builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1453211176.74 results: success (0) buildid: 20160119030232 builduid: eec43e3591ec44058424218e1eb07a6e revision: b67316254602a63bf4e568198a5c7d3288a9db27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.743087) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.743602) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.743959) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.768464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.768823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.792635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.792946) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029685 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.840475) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.840791) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.841177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:16.841496) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 05:46:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.0M=0s 2016-01-19 05:46:17 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.020702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.021025) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.110600 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.143306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.143677) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b67316254602a63bf4e568198a5c7d3288a9db27 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b67316254602a63bf4e568198a5c7d3288a9db27 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 05:46:17,334 truncating revision to first 12 chars 2016-01-19 05:46:17,334 Setting DEBUG logging. 2016-01-19 05:46:17,334 attempt 1/10 2016-01-19 05:46:17,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b67316254602?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 05:46:17,583 unpacking tar archive at: mozilla-central-b67316254602/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.698107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.698432) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003834 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.747306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.747618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.757864) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.758151) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 05:46:17.758565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-19 05:46:17.758902) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:18 INFO - MultiFileLogger online at 20160119 05:46:18 in /builds/slave/test-pgo 05:46:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:46:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:46:18 INFO - {'append_to_log': False, 05:46:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:46:18 INFO - 'blob_upload_branch': 'Firefox', 05:46:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:46:18 INFO - 'branch': 'Firefox', 05:46:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:18 INFO - 'config_files': ('talos/linux_config.py',), 05:46:18 INFO - 'default_actions': ('clobber', 05:46:18 INFO - 'read-buildbot-config', 05:46:18 INFO - 'download-and-extract', 05:46:18 INFO - 'populate-webroot', 05:46:18 INFO - 'create-virtualenv', 05:46:18 INFO - 'install', 05:46:18 INFO - 'run-tests'), 05:46:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:18 INFO - 'download_minidump_stackwalk': True, 05:46:18 INFO - 'download_symbols': 'ondemand', 05:46:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:18 INFO - 'installer_path': 'installer.exe', 05:46:18 INFO - 'log_level': 'info', 05:46:18 INFO - 'log_name': 'talos', 05:46:18 INFO - 'log_to_console': True, 05:46:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:18 INFO - 'opt_config_files': (), 05:46:18 INFO - 'pip_index': False, 05:46:18 INFO - 'sps_profile': False, 05:46:18 INFO - 'sps_profile_interval': 0, 05:46:18 INFO - 'suite': 'dromaeojs', 05:46:18 INFO - 'system_bits': '32', 05:46:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:18 INFO - 'title': 'talos-linux64-ix-027', 05:46:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:18 INFO - 'use_talos_json': True, 05:46:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:46:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:18 INFO - 'work_dir': 'build'} 05:46:18 INFO - ##### 05:46:18 INFO - ##### Running clobber step. 05:46:18 INFO - ##### 05:46:18 INFO - Running pre-action listener: _resource_record_pre_action 05:46:18 INFO - Running main action method: clobber 05:46:18 INFO - rmtree: /builds/slave/test-pgo/build 05:46:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:46:19 INFO - Running post-action listener: _resource_record_post_action 05:46:19 INFO - ##### 05:46:19 INFO - ##### Running read-buildbot-config step. 05:46:19 INFO - ##### 05:46:19 INFO - Running pre-action listener: _resource_record_pre_action 05:46:19 INFO - Running main action method: read_buildbot_config 05:46:19 INFO - Using buildbot properties: 05:46:19 INFO - { 05:46:19 INFO - "project": "", 05:46:19 INFO - "product": "firefox", 05:46:19 INFO - "script_repo_revision": "production", 05:46:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:46:19 INFO - "repository": "", 05:46:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:46:19 INFO - "buildid": "20160119030232", 05:46:19 INFO - "stage_platform": "linux64-pgo", 05:46:19 INFO - "basedir": "/builds/slave/test-pgo", 05:46:19 INFO - "nightly_build": "True", 05:46:19 INFO - "buildnumber": 162, 05:46:19 INFO - "slavename": "talos-linux64-ix-027", 05:46:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:46:19 INFO - "platform": "ubuntu64_hw", 05:46:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:46:19 INFO - "branch": "mozilla-central", 05:46:19 INFO - "repo_path": "mozilla-central", 05:46:19 INFO - "revision": "b67316254602a63bf4e568198a5c7d3288a9db27", 05:46:19 INFO - "pgo_build": "True", 05:46:19 INFO - "builduid": "eec43e3591ec44058424218e1eb07a6e", 05:46:19 INFO - "slavebuilddir": "test" 05:46:19 INFO - } 05:46:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:46:19 INFO - Running post-action listener: _resource_record_post_action 05:46:19 INFO - ##### 05:46:19 INFO - ##### Running download-and-extract step. 05:46:19 INFO - ##### 05:46:19 INFO - Running pre-action listener: _resource_record_pre_action 05:46:19 INFO - Running main action method: download_and_extract 05:46:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:19 INFO - https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:46:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/test_packages.json 05:46:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/test_packages.json 05:46:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:46:28 INFO - Downloaded 1448 bytes. 05:46:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:46:28 INFO - Using the following test package requirements: 05:46:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:46:28 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:46:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'jsshell-linux-x86_64.zip'], 05:46:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:46:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:46:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:46:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:46:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:46:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:28 INFO - https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:46:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:46:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:46:33 INFO - Downloaded 22484120 bytes. 05:46:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:46:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:46:35 INFO - Return code: 0 05:46:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:35 INFO - https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:46:37 INFO - Downloaded 22484120 bytes. 05:46:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:46:38 INFO - Return code: 0 05:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:38 INFO - https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:46:39 INFO - Downloaded 11132144 bytes. 05:46:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:46:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:46:39 INFO - Return code: 0 05:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:39 INFO - https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:46:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:46:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:46:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:46:41 INFO - Downloaded 55944020 bytes. 05:46:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:46:41 INFO - mkdir: /builds/slave/test-pgo/properties 05:46:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:46:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:46:41 INFO - Contents: 05:46:41 INFO - build_url:https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:46:41 INFO - Running post-action listener: _resource_record_post_action 05:46:41 INFO - Running post-action listener: set_extra_try_arguments 05:46:41 INFO - ##### 05:46:41 INFO - ##### Running populate-webroot step. 05:46:41 INFO - ##### 05:46:41 INFO - Running pre-action listener: _resource_record_pre_action 05:46:41 INFO - Running main action method: populate_webroot 05:46:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:41 INFO - '--tppagecycles', 05:46:41 INFO - '7'], 05:46:41 INFO - 'tests': ['tsvgm']}}, 05:46:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:46:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:46:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:46:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'tests': ['damp', 'tps']}, 05:46:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['damp', 'tps']}, 05:46:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:46:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:41 INFO - 'other': {'tests': ['a11yr', 05:46:41 INFO - 'ts_paint', 05:46:41 INFO - 'tpaint', 05:46:41 INFO - 'sessionrestore', 05:46:41 INFO - 'sessionrestore_no_auto_restore']}, 05:46:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['a11yr', 05:46:41 INFO - 'ts_paint', 05:46:41 INFO - 'tpaint', 05:46:41 INFO - 'sessionrestore', 05:46:41 INFO - 'sessionrestore_no_auto_restore']}, 05:46:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['a11yr', 05:46:41 INFO - 'ts_paint', 05:46:41 INFO - 'tpaint', 05:46:41 INFO - 'sessionrestore', 05:46:41 INFO - 'sessionrestore_no_auto_restore']}, 05:46:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['a11yr', 05:46:41 INFO - 'ts_paint', 05:46:41 INFO - 'tpaint', 05:46:41 INFO - 'sessionrestore', 05:46:41 INFO - 'sessionrestore_no_auto_restore']}, 05:46:41 INFO - 'other_l64': {'tests': ['a11yr', 05:46:41 INFO - 'ts_paint', 05:46:41 INFO - 'tpaint', 05:46:41 INFO - 'sessionrestore', 05:46:41 INFO - 'sessionrestore_no_auto_restore']}, 05:46:41 INFO - 'other_nol64': {'tests': ['a11yr', 05:46:41 INFO - 'ts_paint', 05:46:41 INFO - 'tpaint', 05:46:41 INFO - 'sessionrestore', 05:46:41 INFO - 'sessionrestore_no_auto_restore']}, 05:46:41 INFO - 'svgr': {'tests': ['tsvgx', 05:46:41 INFO - 'tsvgr_opacity', 05:46:41 INFO - 'tart', 05:46:41 INFO - 'tscrollx', 05:46:41 INFO - 'cart']}, 05:46:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['tsvgx', 05:46:41 INFO - 'tsvgr_opacity', 05:46:41 INFO - 'tart', 05:46:41 INFO - 'tscrollx', 05:46:41 INFO - 'cart']}, 05:46:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'tests': ['tp5o']}, 05:46:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'talos_options': ['--e10s'], 05:46:41 INFO - 'tests': ['tp5o']}, 05:46:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'talos_options': ['--xperf_path', 05:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:41 INFO - 'tests': ['tp5n']}, 05:46:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:41 INFO - 'talos_options': ['--e10s', 05:46:41 INFO - '--xperf_path', 05:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:41 INFO - 'tests': ['tp5n']}}, 05:46:41 INFO - 'talos.zip': {'path': '', 05:46:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:41 INFO - Running post-action listener: _resource_record_post_action 05:46:41 INFO - ##### 05:46:41 INFO - ##### Running create-virtualenv step. 05:46:41 INFO - ##### 05:46:41 INFO - Running pre-action listener: _resource_record_pre_action 05:46:41 INFO - Running main action method: create_virtualenv 05:46:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:46:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:46:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:46:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:41 INFO - Using real prefix '/usr' 05:46:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:46:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:43 INFO - Installing pip.................done. 05:46:44 INFO - Return code: 0 05:46:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:46:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:46:44 INFO - Using env: {'DISPLAY': ':0', 05:46:44 INFO - 'HOME': '/home/cltbld', 05:46:44 INFO - 'LANG': 'en_US.UTF-8', 05:46:44 INFO - 'LANGUAGE': 'en_US:en', 05:46:44 INFO - 'LOGNAME': 'cltbld', 05:46:44 INFO - 'MAIL': '/var/mail/cltbld', 05:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:44 INFO - 'MOZ_NO_REMOTE': '1', 05:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:44 INFO - 'NO_EM_RESTART': '1', 05:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:44 INFO - 'SHELL': '/bin/bash', 05:46:44 INFO - 'SHLVL': '1', 05:46:44 INFO - 'TERM': 'linux', 05:46:44 INFO - 'TMOUT': '86400', 05:46:44 INFO - 'USER': 'cltbld', 05:46:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:44 INFO - '_': '/tools/buildbot/bin/python'} 05:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:46:44 INFO - Cleaning up... 05:46:44 INFO - Return code: 0 05:46:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:46:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:46:44 INFO - Using env: {'DISPLAY': ':0', 05:46:44 INFO - 'HOME': '/home/cltbld', 05:46:44 INFO - 'LANG': 'en_US.UTF-8', 05:46:44 INFO - 'LANGUAGE': 'en_US:en', 05:46:44 INFO - 'LOGNAME': 'cltbld', 05:46:44 INFO - 'MAIL': '/var/mail/cltbld', 05:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:44 INFO - 'MOZ_NO_REMOTE': '1', 05:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:44 INFO - 'NO_EM_RESTART': '1', 05:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:44 INFO - 'SHELL': '/bin/bash', 05:46:44 INFO - 'SHLVL': '1', 05:46:44 INFO - 'TERM': 'linux', 05:46:44 INFO - 'TMOUT': '86400', 05:46:44 INFO - 'USER': 'cltbld', 05:46:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:44 INFO - '_': '/tools/buildbot/bin/python'} 05:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:44 INFO - Downloading/unpacking psutil>=0.7.1 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:46:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:46:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:46 INFO - Installing collected packages: psutil 05:46:46 INFO - Running setup.py install for psutil 05:46:46 INFO - building 'psutil._psutil_linux' extension 05:46:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:46:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:46:46 INFO - building 'psutil._psutil_posix' extension 05:46:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:46:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:46:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:46 INFO - Successfully installed psutil 05:46:46 INFO - Cleaning up... 05:46:46 INFO - Return code: 0 05:46:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:46:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:46:46 INFO - Using env: {'DISPLAY': ':0', 05:46:46 INFO - 'HOME': '/home/cltbld', 05:46:46 INFO - 'LANG': 'en_US.UTF-8', 05:46:46 INFO - 'LANGUAGE': 'en_US:en', 05:46:46 INFO - 'LOGNAME': 'cltbld', 05:46:46 INFO - 'MAIL': '/var/mail/cltbld', 05:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:46 INFO - 'MOZ_NO_REMOTE': '1', 05:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:46 INFO - 'NO_EM_RESTART': '1', 05:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:46 INFO - 'SHELL': '/bin/bash', 05:46:46 INFO - 'SHLVL': '1', 05:46:46 INFO - 'TERM': 'linux', 05:46:46 INFO - 'TMOUT': '86400', 05:46:46 INFO - 'USER': 'cltbld', 05:46:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:46 INFO - '_': '/tools/buildbot/bin/python'} 05:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:46:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:46:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:46:48 INFO - Installing collected packages: mozsystemmonitor 05:46:48 INFO - Running setup.py install for mozsystemmonitor 05:46:48 INFO - Successfully installed mozsystemmonitor 05:46:48 INFO - Cleaning up... 05:46:48 INFO - Return code: 0 05:46:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:46:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:46:48 INFO - Using env: {'DISPLAY': ':0', 05:46:48 INFO - 'HOME': '/home/cltbld', 05:46:48 INFO - 'LANG': 'en_US.UTF-8', 05:46:48 INFO - 'LANGUAGE': 'en_US:en', 05:46:48 INFO - 'LOGNAME': 'cltbld', 05:46:48 INFO - 'MAIL': '/var/mail/cltbld', 05:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:48 INFO - 'MOZ_NO_REMOTE': '1', 05:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:48 INFO - 'NO_EM_RESTART': '1', 05:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:48 INFO - 'SHELL': '/bin/bash', 05:46:48 INFO - 'SHLVL': '1', 05:46:48 INFO - 'TERM': 'linux', 05:46:48 INFO - 'TMOUT': '86400', 05:46:48 INFO - 'USER': 'cltbld', 05:46:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:48 INFO - '_': '/tools/buildbot/bin/python'} 05:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:46:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:51 INFO - Downloading docopt-0.6.1.tar.gz 05:46:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:51 INFO - Running setup.py install for blobuploader 05:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:46:51 INFO - Running setup.py install for requests 05:46:51 INFO - Running setup.py install for docopt 05:46:52 INFO - Successfully installed blobuploader requests docopt 05:46:52 INFO - Cleaning up... 05:46:52 INFO - Return code: 0 05:46:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:52 INFO - Using env: {'DISPLAY': ':0', 05:46:52 INFO - 'HOME': '/home/cltbld', 05:46:52 INFO - 'LANG': 'en_US.UTF-8', 05:46:52 INFO - 'LANGUAGE': 'en_US:en', 05:46:52 INFO - 'LOGNAME': 'cltbld', 05:46:52 INFO - 'MAIL': '/var/mail/cltbld', 05:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:52 INFO - 'MOZ_NO_REMOTE': '1', 05:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:52 INFO - 'NO_EM_RESTART': '1', 05:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:52 INFO - 'SHELL': '/bin/bash', 05:46:52 INFO - 'SHLVL': '1', 05:46:52 INFO - 'TERM': 'linux', 05:46:52 INFO - 'TMOUT': '86400', 05:46:52 INFO - 'USER': 'cltbld', 05:46:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:52 INFO - '_': '/tools/buildbot/bin/python'} 05:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:46:52 INFO - Running setup.py (path:/tmp/pip-SiRX7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:46:52 INFO - Running setup.py (path:/tmp/pip-bLXYfa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:46:52 INFO - Running setup.py (path:/tmp/pip-aJoSLZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:46:52 INFO - Running setup.py (path:/tmp/pip-_GGo_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:46:52 INFO - Running setup.py (path:/tmp/pip-Ii6sgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:46:52 INFO - Running setup.py (path:/tmp/pip-Bcu3m8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:46:52 INFO - Running setup.py (path:/tmp/pip-ISPfEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:46:52 INFO - Running setup.py (path:/tmp/pip-X9IEvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:46:52 INFO - Running setup.py (path:/tmp/pip-oO0N3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:46:52 INFO - Running setup.py (path:/tmp/pip-GevQAG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:46:53 INFO - Running setup.py (path:/tmp/pip-p2vKA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:46:53 INFO - Running setup.py (path:/tmp/pip-yOnHai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:46:53 INFO - Running setup.py (path:/tmp/pip-bZAICF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:46:53 INFO - Running setup.py (path:/tmp/pip-Xpzq3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:46:53 INFO - Running setup.py (path:/tmp/pip-a4zoVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:46:53 INFO - Running setup.py (path:/tmp/pip-c5gDk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:46:53 INFO - Running setup.py (path:/tmp/pip-R7f3fJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:46:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:53 INFO - Running setup.py install for manifestparser 05:46:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:46:53 INFO - Running setup.py install for mozcrash 05:46:53 INFO - Running setup.py install for mozdebug 05:46:53 INFO - Running setup.py install for mozdevice 05:46:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:46:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:46:53 INFO - Running setup.py install for mozfile 05:46:54 INFO - Running setup.py install for mozhttpd 05:46:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Running setup.py install for mozinfo 05:46:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Running setup.py install for mozInstall 05:46:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Running setup.py install for mozleak 05:46:54 INFO - Running setup.py install for mozlog 05:46:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Running setup.py install for moznetwork 05:46:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Running setup.py install for mozprocess 05:46:54 INFO - Running setup.py install for mozprofile 05:46:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:46:54 INFO - Running setup.py install for mozrunner 05:46:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:46:55 INFO - Running setup.py install for mozscreenshot 05:46:55 INFO - Running setup.py install for moztest 05:46:55 INFO - Running setup.py install for mozversion 05:46:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:46:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:55 INFO - Cleaning up... 05:46:55 INFO - Return code: 0 05:46:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:55 INFO - Using env: {'DISPLAY': ':0', 05:46:55 INFO - 'HOME': '/home/cltbld', 05:46:55 INFO - 'LANG': 'en_US.UTF-8', 05:46:55 INFO - 'LANGUAGE': 'en_US:en', 05:46:55 INFO - 'LOGNAME': 'cltbld', 05:46:55 INFO - 'MAIL': '/var/mail/cltbld', 05:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:55 INFO - 'MOZ_NO_REMOTE': '1', 05:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:55 INFO - 'NO_EM_RESTART': '1', 05:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:55 INFO - 'SHELL': '/bin/bash', 05:46:55 INFO - 'SHLVL': '1', 05:46:55 INFO - 'TERM': 'linux', 05:46:55 INFO - 'TMOUT': '86400', 05:46:55 INFO - 'USER': 'cltbld', 05:46:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:55 INFO - '_': '/tools/buildbot/bin/python'} 05:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:46:55 INFO - Running setup.py (path:/tmp/pip-dDa2Ru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:46:55 INFO - Running setup.py (path:/tmp/pip-SKoQ7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:46:55 INFO - Running setup.py (path:/tmp/pip-UrgCzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:46:55 INFO - Running setup.py (path:/tmp/pip-6cSikU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:46:55 INFO - Running setup.py (path:/tmp/pip-bx5eM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:46:55 INFO - Running setup.py (path:/tmp/pip-mo8ULe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:46:55 INFO - Running setup.py (path:/tmp/pip-A8O_w7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:46:56 INFO - Running setup.py (path:/tmp/pip-tcCFNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:46:56 INFO - Running setup.py (path:/tmp/pip-bmWChZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:46:56 INFO - Running setup.py (path:/tmp/pip-ka0WpO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:46:56 INFO - Running setup.py (path:/tmp/pip-1L7GqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:46:56 INFO - Running setup.py (path:/tmp/pip-NHE0Q2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:46:56 INFO - Running setup.py (path:/tmp/pip-zDmJYo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:46:56 INFO - Running setup.py (path:/tmp/pip-GuSAwH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:46:56 INFO - Running setup.py (path:/tmp/pip-LZptiC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:46:56 INFO - Running setup.py (path:/tmp/pip-cTIkQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:46:56 INFO - Running setup.py (path:/tmp/pip-PGqQYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:58 INFO - Downloading blessings-1.5.1.tar.gz 05:46:58 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:46:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:58 INFO - Installing collected packages: blessings 05:46:58 INFO - Running setup.py install for blessings 05:46:58 INFO - Successfully installed blessings 05:46:58 INFO - Cleaning up... 05:46:58 INFO - Return code: 0 05:46:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:46:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:46:58 INFO - Reading from file tmpfile_stdout 05:46:58 INFO - Current package versions: 05:46:58 INFO - argparse == 1.2.1 05:46:58 INFO - blessings == 1.5.1 05:46:58 INFO - blobuploader == 1.2.4 05:46:58 INFO - docopt == 0.6.1 05:46:58 INFO - manifestparser == 1.1 05:46:58 INFO - mozInstall == 1.12 05:46:58 INFO - mozcrash == 0.16 05:46:58 INFO - mozdebug == 0.1 05:46:58 INFO - mozdevice == 0.48 05:46:58 INFO - mozfile == 1.2 05:46:58 INFO - mozhttpd == 0.7 05:46:58 INFO - mozinfo == 0.9 05:46:58 INFO - mozleak == 0.1 05:46:58 INFO - mozlog == 3.1 05:46:58 INFO - moznetwork == 0.27 05:46:58 INFO - mozprocess == 0.22 05:46:58 INFO - mozprofile == 0.28 05:46:58 INFO - mozrunner == 6.11 05:46:58 INFO - mozscreenshot == 0.1 05:46:58 INFO - mozsystemmonitor == 0.0 05:46:58 INFO - moztest == 0.7 05:46:58 INFO - mozversion == 1.4 05:46:58 INFO - psutil == 3.1.1 05:46:58 INFO - requests == 1.2.3 05:46:58 INFO - wsgiref == 0.1.2 05:46:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:58 INFO - Using env: {'DISPLAY': ':0', 05:46:58 INFO - 'HOME': '/home/cltbld', 05:46:58 INFO - 'LANG': 'en_US.UTF-8', 05:46:58 INFO - 'LANGUAGE': 'en_US:en', 05:46:58 INFO - 'LOGNAME': 'cltbld', 05:46:58 INFO - 'MAIL': '/var/mail/cltbld', 05:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:58 INFO - 'MOZ_NO_REMOTE': '1', 05:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:58 INFO - 'NO_EM_RESTART': '1', 05:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:58 INFO - 'SHELL': '/bin/bash', 05:46:58 INFO - 'SHLVL': '1', 05:46:58 INFO - 'TERM': 'linux', 05:46:58 INFO - 'TMOUT': '86400', 05:46:58 INFO - 'USER': 'cltbld', 05:46:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:58 INFO - '_': '/tools/buildbot/bin/python'} 05:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:46:59 INFO - Cleaning up... 05:46:59 INFO - Return code: 0 05:46:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:46:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:59 INFO - Using env: {'DISPLAY': ':0', 05:46:59 INFO - 'HOME': '/home/cltbld', 05:46:59 INFO - 'LANG': 'en_US.UTF-8', 05:46:59 INFO - 'LANGUAGE': 'en_US:en', 05:46:59 INFO - 'LOGNAME': 'cltbld', 05:46:59 INFO - 'MAIL': '/var/mail/cltbld', 05:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:59 INFO - 'MOZ_NO_REMOTE': '1', 05:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:59 INFO - 'NO_EM_RESTART': '1', 05:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:59 INFO - 'SHELL': '/bin/bash', 05:46:59 INFO - 'SHLVL': '1', 05:46:59 INFO - 'TERM': 'linux', 05:46:59 INFO - 'TMOUT': '86400', 05:46:59 INFO - 'USER': 'cltbld', 05:46:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:59 INFO - '_': '/tools/buildbot/bin/python'} 05:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:59 INFO - Downloading/unpacking jsonschema 05:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:47:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:01 INFO - warning: no files found matching '*.txt' 05:47:01 INFO - no previously-included directories found matching 'build' 05:47:01 INFO - no previously-included directories found matching 'dist' 05:47:01 INFO - no previously-included directories found matching '.git*' 05:47:01 INFO - Installing collected packages: jsonschema, functools32 05:47:01 INFO - Running setup.py install for functools32 05:47:01 INFO - warning: no files found matching '*.txt' 05:47:01 INFO - no previously-included directories found matching 'build' 05:47:01 INFO - no previously-included directories found matching 'dist' 05:47:01 INFO - no previously-included directories found matching '.git*' 05:47:01 INFO - Successfully installed jsonschema functools32 05:47:01 INFO - Cleaning up... 05:47:01 INFO - Return code: 0 05:47:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef3cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:47:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:47:01 INFO - Using env: {'DISPLAY': ':0', 05:47:01 INFO - 'HOME': '/home/cltbld', 05:47:01 INFO - 'LANG': 'en_US.UTF-8', 05:47:01 INFO - 'LANGUAGE': 'en_US:en', 05:47:01 INFO - 'LOGNAME': 'cltbld', 05:47:01 INFO - 'MAIL': '/var/mail/cltbld', 05:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:01 INFO - 'MOZ_NO_REMOTE': '1', 05:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:01 INFO - 'NO_EM_RESTART': '1', 05:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:01 INFO - 'SHELL': '/bin/bash', 05:47:01 INFO - 'SHLVL': '1', 05:47:01 INFO - 'TERM': 'linux', 05:47:01 INFO - 'TMOUT': '86400', 05:47:01 INFO - 'USER': 'cltbld', 05:47:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:01 INFO - '_': '/tools/buildbot/bin/python'} 05:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:01 INFO - Downloading/unpacking flake8 05:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:47:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:47:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:47:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:47:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:47:04 INFO - no previously-included directories found matching 'docs/_build' 05:47:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:47:04 INFO - Running setup.py install for pep8 05:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:47:04 INFO - no previously-included directories found matching 'docs/_build' 05:47:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:47:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:47:04 INFO - Cleaning up... 05:47:04 INFO - Return code: 0 05:47:04 INFO - Running post-action listener: _resource_record_post_action 05:47:04 INFO - Running post-action listener: _start_resource_monitoring 05:47:04 INFO - Starting resource monitoring. 05:47:04 INFO - ##### 05:47:04 INFO - ##### Running install step. 05:47:04 INFO - ##### 05:47:04 INFO - Running pre-action listener: _resource_record_pre_action 05:47:04 INFO - Running main action method: install 05:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:47:04 INFO - Reading from file tmpfile_stdout 05:47:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:47:04 INFO - Reading from file tmpfile_stdout 05:47:04 INFO - Output received: 05:47:04 INFO - Usage: mozinstall [options] installer 05:47:04 INFO - Options: 05:47:04 INFO - -h, --help show this help message and exit 05:47:04 INFO - -d DEST, --destination=DEST 05:47:04 INFO - Directory to install application into. [default: 05:47:04 INFO - "/builds/slave/test-pgo"] 05:47:04 INFO - --app=APP Application being installed. [default: firefox] 05:47:04 INFO - mkdir: /builds/slave/test-pgo/build/application 05:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:47:20 INFO - Reading from file tmpfile_stdout 05:47:20 INFO - Output received: 05:47:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:47:20 INFO - Running post-action listener: _resource_record_post_action 05:47:20 INFO - ##### 05:47:20 INFO - ##### Running run-tests step. 05:47:20 INFO - ##### 05:47:20 INFO - Running pre-action listener: _resource_record_pre_action 05:47:20 INFO - Running main action method: run_tests 05:47:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:47:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:47:20 INFO - Python 2.7.3 05:47:20 INFO - Return code: 0 05:47:20 INFO - grabbing minidump binary from tooltool 05:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2372840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:47:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:47:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:47:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:20 INFO - Return code: 0 05:47:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:47:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:47:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:47:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:47:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:47:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:47:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:47:21 INFO - Return code: 0 05:47:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:47:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:47:21 INFO - Using env: {'DISPLAY': ':0', 05:47:21 INFO - 'HOME': '/home/cltbld', 05:47:21 INFO - 'LANG': 'en_US.UTF-8', 05:47:21 INFO - 'LANGUAGE': 'en_US:en', 05:47:21 INFO - 'LOGNAME': 'cltbld', 05:47:21 INFO - 'MAIL': '/var/mail/cltbld', 05:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:21 INFO - 'MOZ_NO_REMOTE': '1', 05:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:21 INFO - 'NO_EM_RESTART': '1', 05:47:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:47:21 INFO - 'SHELL': '/bin/bash', 05:47:21 INFO - 'SHLVL': '1', 05:47:21 INFO - 'TERM': 'linux', 05:47:21 INFO - 'TMOUT': '86400', 05:47:21 INFO - 'USER': 'cltbld', 05:47:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620', 05:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:21 INFO - '_': '/tools/buildbot/bin/python'} 05:47:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:47:21 INFO - mozversion application_buildid: 20160119030232 05:47:21 INFO - mozversion application_changeset: b67316254602a63bf4e568198a5c7d3288a9db27 05:47:21 INFO - mozversion application_display_name: Nightly 05:47:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:21 INFO - mozversion application_name: Firefox 05:47:21 INFO - mozversion application_remotingname: firefox 05:47:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:21 INFO - mozversion application_vendor: Mozilla 05:47:21 INFO - mozversion application_version: 46.0a1 05:47:21 INFO - mozversion platform_buildid: 20160119030232 05:47:21 INFO - mozversion platform_changeset: b67316254602a63bf4e568198a5c7d3288a9db27 05:47:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:21 INFO - mozversion platform_version: 46.0a1 05:47:21 INFO - using testdate: 1453211241 05:47:21 INFO - actual date: 1453211241 05:47:21 INFO - starting webserver on 'localhost:44970' 05:47:21 INFO - SUITE-START | Running 3 tests 05:47:21 INFO - TEST-START | dromaeo_css 05:47:21 INFO - operating with platform_type : linux_ 05:47:21 INFO - Initialising browser for dromaeo_css test... 05:47:21 INFO - TEST-INFO | started process 14849 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNh1AV_/profile http://localhost:44970/getInfo.html) 05:47:26 INFO - PROCESS | 14849 | __metrics Screen width/height:1600/1200 05:47:26 INFO - PROCESS | 14849 | colorDepth:24 05:47:26 INFO - PROCESS | 14849 | Browser inner width/height: 1024/697 05:47:26 INFO - PROCESS | 14849 | __metrics 05:47:26 INFO - PROCESS | 14849 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:47:26 INFO - PROCESS | 14849 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:27 INFO - TEST-INFO | 14849: exit 0 05:47:27 INFO - Browser initialized. 05:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:27 INFO - TEST-INFO | started process 14943 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNh1AV_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:38 INFO - PROCESS | 14943 | RSS: Main: 149393408 05:47:38 INFO - PROCESS | 14943 | 05:48:30 INFO - PROCESS | 14943 | 1453211310337 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:50:38 INFO - PROCESS | 14943 | Cycle 1(1): loaded http://localhost:44970/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44970/tests/dromaeo/cssquery-ext.html) 05:50:39 INFO - PROCESS | 14943 | RSS: Main: 228241408 05:50:39 INFO - PROCESS | 14943 | 05:53:41 INFO - PROCESS | 14943 | Cycle 1(1): loaded http://localhost:44970/tests/dromaeo/cssquery-ext.html (next: http://localhost:44970/tests/dromaeo/cssquery-jquery.html) 05:53:42 INFO - PROCESS | 14943 | RSS: Main: 234676224 05:53:42 INFO - PROCESS | 14943 | 05:56:44 INFO - PROCESS | 14943 | Cycle 1(1): loaded http://localhost:44970/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44970/tests/dromaeo/cssquery-mootools.html) 05:56:44 INFO - PROCESS | 14943 | RSS: Main: 248774656 05:56:44 INFO - PROCESS | 14943 | 05:59:46 INFO - PROCESS | 14943 | Cycle 1(1): loaded http://localhost:44970/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44970/tests/dromaeo/cssquery-prototype.html) 05:59:47 INFO - PROCESS | 14943 | RSS: Main: 212365312 05:59:47 INFO - PROCESS | 14943 | 06:02:49 INFO - PROCESS | 14943 | Cycle 1(1): loaded http://localhost:44970/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44970/tests/dromaeo/cssquery-yui.html) 06:02:50 INFO - PROCESS | 14943 | RSS: Main: 215027712 06:02:50 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | Cycle 1(1): loaded http://localhost:44970/tests/dromaeo/cssquery-yui.html (next: http://localhost:44970/tests/dromaeo/cssquery-dojo.html) 06:05:53 INFO - PROCESS | 14943 | RSS: Main: 261226496 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | __start_tp_report 06:05:53 INFO - PROCESS | 14943 | _x_x_mozilla_page_load 06:05:53 INFO - PROCESS | 14943 | _x_x_mozilla_page_load_details 06:05:53 INFO - PROCESS | 14943 | |i|pagename|runs| 06:05:53 INFO - PROCESS | 14943 | |0;dojo.html;3146.88985885494;3177.872885084597;3236.870525178993;3237.9514307285394;3256.0231930420873;5079;5176.352955880515;5197.324347834781;5206.45332240115;5260.158374660055;5156.948430515703;5167.431582525928;5230.790768369261;5261.736913154336;5269.209618557218;4729.952700473003;4746.572808447248;4759.190937540609;4779.283107533863;4882.682625629341;4457.834276336725;4830.106430310386;4923.950760492385;4927.876803079916;4966.65233433658;4645.76771161444;4713.670043096985;4722.197226471508;4853.490383509734;4867.014665672384;4739;4774.594159496447;4788.11419887322;4794.832180873653;4808.422989241313;4738.455077666078;4762.690425122356;4763.404574428197;4767.356406885061;4796.088743138793;4888.193448081062;4986.301917731521;5039.672421292605;5125.128728116192;5162.380514338266;5554.361248456398;5610.49505544503;5614.29821272341;5614.326280846284;5667.3482549506925;5597.496225339698;5614.63504872182;5615.550755939515;5622.156676498517;5623.634463759883;5115.462876397999;5142.305788718512;5220.321358223407;5258.447862974371;5264.842054738364;5688.146777983336;5689.630174038674;5706.885862282814;5708.058170401837;5729.28383952006;5472.097103977799;5474.534664553557;5477.28795256622;5486.890262194734;5488.204210389471;5461.208124821958;5501.862453438616;5537.861553461115;5543;5584.720763961785;5497.230387745719;5518.19986102013;5537.058700020925;5537.5569954404355;5537.723113844291;5487.149491828773;5527.640703354269;5530.794771319991;5532.114861622202;5580.883823235369;4271.871843844628;4308.159908817813;4329.545397733255;4361.302191649321;4396.538363471854;3896.6298201670797;3903.512060992376;3913.6673382762783;3941.7832019238645;3950.2692001979726;5129.025485157808;5222.843314700565;5234.895302094013;5236.266922630834;5239.869003274948;5468.835934921959;5531.1426728857095;5561.805336813192;5574.275344205227;5624.437556244343;5210.921836172461;5253.973730131325;5254.448282930237;5259.868503287372;5260.7718787830545;4707.2468405055715;4791.664583479123;4830.178869592178;4835.709857408567;4867.318575399447;5816.098504731774;5830.7084645767545;5846.503047240947;5849.473547380756;5922.644641321534;5548.833534993957;5573.3869274380595;5578.414266501959;5579.944200557942;5583;5696.231008813757;5770.13447982806;5801.477866991991;5836.416358364129;5839.065749480063;5518.696471694096;5527.198556209408;5527.613067085426;5532.529734972572;5562.332520097614;5596.776128954796;5606.85982850432;5614.803481878114;5617.213590097308;5620.4660557247;5402.135658294654;5456.536194423518;5474.863128421821;5483.643563168382;5562.72186390687;5379.488948549882;5394.595405344693;5421.1055175895535;5436.184572314184;5443.755031023535;5274.76263568148;5337.653052551727;5339.4126646068125;5340.252364668871;5393.514583687487;5352;5390.4879036491475;5447.237386765777;5458.536024437967;5468.152436372368;5256.474352564713;5292.259083728204;5293.285406470077;5293.576513878804;5340.145576707708 06:05:53 INFO - PROCESS | 14943 | |1;ext.html;534.95185433311;547.1983544107883;568.7128000359818;569.6809786519548;572.0047118014655;28634.427311453783;29545.11364659061;36064.278714425694;36672.81663591678;36821.44767828485;42579;43622.781886090605;43648.127037459235;43718.781406093;43735.343969840476;8589.613467393967;8797.07630698777;8800.47197168172;8802.207801297882;8802.207801297882;8511.361647876434;8616.578264586336;8646.783830404227;8653.95673021634;8663.566821658924;8648.135186481364;8710.738677839676;8719.782005449882;8728.301735861116;8730.956345218297;8610.913890861106;8673.262772664268;8695.652173913037;8697.652093916236;8699.608517616722;8517.36119791018;8652.091530389345;8652.178043085896;8653.394262401634;8656.697015604424;39854.402183967264;40653.30853680487;40657.186856263004;40692.79653601743;40699.59300406987;3290.654481279479;3355.4966754986704;3408.113890388492;3436.1237884339334;3930.803459827026;30379.848100759576;31017;31049.068527944197;31152;31302;3842.0010797192654;3966.603339666039;4028.194361127786;4075.7962101894786;4106.609872062179;265845;268002;268723;269436;270223;54589.727051365284;56349.43650563442;62473.37526624766;62608;62701;66553.33446665568;67457.66271168613;67643.66178169078;67679.66160169266;67788.32211677919;16113.355465781471;16279.51161465158;16311.265993030342;16317.265723042492;16325.346986120423;11495.942520287344;11718.179727419169;11745.823812642817;12051.156419050758;12333.69165770845;20173.697394539093;20294.56465224153;20428.18287268522;20484;20564;8011;8261.504309741435;8261.504309741435;8269.95865020671;8290.253877151084;903.1284810158229;969.2972594868804;983.8671779309844;999.5855863952426;1036.891126431729;28980.855437501465;29216.269593259913;29410.411791764473;29517.409651806844;29663.55504667432;1033.1992705653029;1056.8837427882927;1096.336716286635;1134.886511348875;1163.790517706804;13944.930275348559;13999.720005599831;14187.219702916438;14236.715265694627;14389.64025899361;292639;297556;297935;299094;299240;53432;54296;54444.72777636166;54473.455265446835;54476.72761636166;1366.064245991499;1372.053283234565;1382.3502953611787;1386.8613138686253;1387.5213051497217;26468;27378.86310568514;27722.584161238003;27892.58161127625;27938.441231174857;43863.56136438723;44432.77783611061;44453.333200001376;44477;44509.33236001527;300483;300891;302322;302380;303068;28325.858370708014;28940.27649308784;32487.837560812044;32604.510932336507;32980.50529242015;40109.59890401176;40353.39469908013;40377;40547.797261013504;41096.79451602723;33553.49669754907;33909.49135763015;34014;34804.65195348014;34936.65063349334;28498.715012849607;32861.34277314488;34486.82756586201;34761.82619086889;35854.10364740902;31711.841440792647;32253.677463225067;32559.511607325436;32607.836960815992;32610.184745381554;27372.178834634196;30057.54913676253;32335.35329293448;32392.352152956337;32658.34683306273;24206.394840129138;24339.14812981537;24399.878000609882;24707.62938555887;24778.752212477644 06:05:53 INFO - PROCESS | 14943 | |2;jquery.html;359.83447614097514;366.1103518450167;367.84734335250874;367.9742418030738;371.11674215367424;13161.341932903364;13445.865541344583;15590.376384944602;15854.969426987238;16489.835101648965;14483.2758362082;15452.381904723825;15792.763108553381;15809.130497822614;16295.103769292684;5173.534381905628;5338.386085600147;5341.545968592674;5349.598780091509;5352.946470535284;4013.458183145282;4116.115035267417;5241.8427447176455;5325.3077099976945;5659.179418984245;5740.512056475204;5760.107183386561;5765.913511297334;5794.362620111784;5804.229709938467;5020.723860187688;5175.715335656538;5178.766955487012;5197.220416937452;5205.141151709982;4803.207470767319;4971.726555039471;4975.029869175512;4980.2778597103215;4987.127252730794;12975.286359250238;13344.866551334459;19419.80580194194;20182;20219.090140943692;2178.498945242587;2204.9669254961186;2214.9114035438565;2215.8559693620023;2308.8499247549025;9360.859587106199;9524.999875013093;9717.416954982724;9782.853257201148;11628.476718547601;1837.7794664640328;1846.8891866488054;1853.9165737541844;1857.3963461874944;1878.6336664350458;56898.7155064222;56953.71523142358;58766;59253.703731481495;59299.70350148222;9935.900640993643;10093.69718908434;10246.743831404125;10275.897241027644;10280.331778434378;13490.527831526046;13563.321833908265;13564.186148831102;13569.660758481117;13588.93205533966;7513.812154696067;7522.097348318237;7559.659815308324;7620.237976202336;7648.73229436967;7300.087489063867;7383.2616738326815;7385.556866588022;7421.740239091606;7449.925500745032;4457.64338852891;4478.798454069574;4497.730136191839;4501.729896206238;4511.210538155809;1692.9068901210305;1735.6094878652202;1785.1609743420572;1796.1558067708156;1796.6137280484759;877.1053525404052;886.8049029213563;893.5934149961752;918.8621706743908;938.4275591888942;15757.212139392985;16473.34106635745;16509.83490165107;16511.09188994593;17008.149592520323;897.5018864530249;910.899801021887;939.9812003759887;948.0756262644005;997.8652881861001;9355.345125841262;9375.953120234355;9835.360701554519;9923.255755818342;9958.900410995942;386906;396850;460294;526781;532060;58553.70723146357;65970;66724.33275667278;67225;69038.65480672565;1099.1536516881956;1118.6140781430393;1132.1565433751744;1132.603588743933;1136.534021051365;11243.55025798959;13669.863301366859;14381.155589312706;14413.207273600052;15511.612209694847;23048;23329.88335058314;29372.94389392722;31277.218069548442;32727.509087364186;38556.2165675151;39007.609923900396;39645.405318919664;40003.39994900021;42159.36760948527;7211.2428195038765;7220.205777364381;7236.167840698176;7296.562206267641;7377.741779037708;8734;10283.691489255334;10649.840252396376;10821.783564328513;11002.284851484628;8978.730638080868;9241.630334786532;9243.306751993492;9383.859242111237;9395.24838012971;9005;9379.953100234456;9793.314467987173;10168.491575421347;10292.022257885788;9386.530673466163;9607.759806004906;9615.711528654152;9617.182539483942;9854.950725246328;7502.174760776419;7511.624418779148;7531.698732050876;7571.205023472456;7627.237276272328;8377.49735015901;10070.496475176065;10095.646652367132;10116.84824727615;10409.219308551737 06:05:53 INFO - PROCESS | 14943 | |3;mootools.html;1319.4656164253481;1493.8804895608348;1497.558220325004;1685.6881476926762;1828.4880233534616;7091.255418181087;7585.696572137114;7723.227677232274;7734.729284475045;7737.806554836132;7674.923250767504;7860.489068210562;7868.881966770503;7872.448928575002;7877.842443151134;2069.0999415254337;2120.3532922458644;2303.2974942642486;2351.8000969917575;2375.964360534593;2338.3452633262714;2343.6953196084487;2345.542619189259;2345.9882700586472;2347.859128452298;2298.954020919589;2383.5828729972186;2384.3085505203558;2387.259949415678;2387.319613910036;2322.1640209524558;2343.273585188597;2372.478054827935;2374.263978166774;2375.6555299481565;2348.859068455898;2353.682252895854;2373.8694371809543;2377.3343463830156;2386.642003699442;7930.1276859545405;7991.400644951652;8004.239597238253;8014.078380986203;8020.35837133028;4903.607711383081;5000.949990500121;5009.0983622948215;5011.448740638527;5018.347614810088;3241.5137729340554;3259.168911927467;3312.933741325184;3364.0916952422954;3371.814550199738;1035.6841163445147;1038.937663740178;1049.108257980718;1092.4100985467837;1104.9226554141214;11024.228304018721;11040.116790656728;11042.889571104266;11076.667699969013;11078.889211107948;4389.890252743707;4462.509123996358;4465.799039043186;4516.593506584358;4523.344115103291;9362.578683959238;9373.859392109123;9374.484403357881;9376.343655944154;9376.718698439057;4992.575631071327;4993.825216117491;5008.273800298936;5009;5014.373203349582;4553.066621342617;4554.977225113919;4559.749213793207;4562.270036794163;4562.954370456319;3533.081398836321;3619.8371073301764;3736.4768932349493;3758.6053464385845;3797.240551889633;1242.105683907585;1248.0514808745238;1249.6001279590444;1254.1785130739381;1263.5451237554473;1044.9111825494917;1063.7021633942509;1064.0636240108654;1176.2236923630362;1311.1084462565357;7136.821579460555;7157.749478768218;7184.712611495482;7242.094738157731;7250.891236631454;1115.983260251097;1130.8756036835941;1135.9204855660025;1143.8512993310817;1153.210051114989;5839.270091238595;5921.555883308769;5930.703464826742;5933.851653708692;5935.584509084409;9196.540172991323;9243;9273.30450216223;9358.4384936904;9610.471424071744;9200.217981471516;9329.90670093304;9338;9340.4862732549;9341.719748407559;7224.927750722425;7348.96325518369;7374.705011799575;7445.85108297831;7453.962730186315;7348.375388091858;7437.181909990005;7437.888431673638;7441.144268408986;7443.888341674988;8017.198280171936;8154.75535733929;8296.170382961896;8445.831083378422;8459.915400845914;8335.49987000782;8358.791030224049;8370.204830541088;8501.489910605384;8504.659813607634;6324.557280990471;6928.792136235921;7133.144022717307;7133.821654458472;7143.285671432815;6884.759033433806;7446.292602202782;7628;7633.465657403928;7645;6958.199807022257;6984.965075174591;7057.117860267466;7085.468589855678;7248.746293879689;7008.299170082951;7014.333638304353;7096.680649370687;7138.928610713826;7166.605836678824;6795;6936.0636314096955;7166;7213.747518836815;7214.855702886018;6234.781782637586;6301.0863424804065;6316.336784637547;6316.778912738032;6324.810255692337;6367.363263673781;6393.104965304768;6406.327335629878;6407.263164736115;6413.743450261937 06:05:53 INFO - PROCESS | 14943 | |4;prototype.html;348.66876467356013;355.82742369950586;357.1072319201996;361.73954752578135;362.82765686298995;5695.686737229461;5740.167675687023;5802.462347477922;5842.88314233715;5851.941480585198;5618.15727640853;5732.5127364173995;5734.770609175638;5739.167820666001;5754.079347304432;4558.384618076567;4559.247724125516;4559.475660299075;4561.407017087774;4561.885952851172;4373.497047839492;4483.910321793563;4497.7526236057;4503.57216064475;4574.79413426395;4400.471943366801;4450.910981780363;4480.484744254403;4485.910281794362;4489.371487991683;4479.686421950465;4486.596206341429;4502.594766471033;4513.616342610882;4528.524504926968;4013.618706222904;4016.297147999118;4016.6585840203325;4018.5177778666457;4018.9799051004557;5487.6981766002855;5604.607677462538;5609.298837645294;5643.830685079454;5665.348484924245;5208.817691380821;5212.218167274901;5215.191645294985;5216.843494695166;5218.712970786605;5880.794172203952;6199.597026193283;6208.2239720034995;6216.787726393355;6217.098520714516;4249.490061192677;4271.231178387889;4343.6959412841115;4344.761038142932;4377.649788016951;6325.620462772203;6439.678016099177;6446;6447.774327898501;6461.676916154221;4442.378067070613;4443.666724995638;4444.599986001275;4446.6220371268155;4449.710768800018;4385.583369579885;4497.123061003138;4499.190145773792;4502;4541.931871021871;5199.4020687621405;5200.167973124282;5207.192885102815;5213.113770658997;5216.191490319006;6235.875282494416;6247.312795592572;6248.4376406123665;6249.375062493805;6252.437280644764;1577.8895477316478;1597.161490217645;1597.8561929426176;1599.1844159478517;1600.5198440467814;1075.978480430387;1080.708208783624;1081.643057790927;1081.7025318037602;1108.152263518409;5911.556633252523;5924.496417804448;5966.164736936746;5969.2240008799445;5979.342272350038;6330.113784070234;6340.4927605792345;6356.396142366468;6376.776812811529;6382.776602818879;5904.616199947076;5914.93531164386;5918.082697181943;5924.4667979882015;5927.9703601481715;3359.8152101634155;3471.288385880888;3477;3481.425564781833;3483.494893240517;6772.187337519431;6775;6779.084823548857;6782.38958493728;6783.287754785775;6577.6053436793945;6584.8024559263295;6589.341065893373;6591.736330546821;6592.110065141144;6512.185976752906;6754.662266886636;6763.5941843489545;6767.695453704595;6780.050792888901;6169.383061693795;6311.558190926591;6380.266269379081;6390.87218255623;6398.360163983564;6188.81433556994;6272.310045895039;6285.2457705075685;6294.276158241678;6307.180066591313;6778.898316525355;6842.110525631636;6849.589024658537;6853.211880633791;6855.417289530246;4311.159323931804;4468.21806183923;4502.797374118107;4503.662225333179;4505.166544189336;6359.17330747;6376.808695739135;6380.170577824853;6386.16979792624;6392.977123660192;6235.594686345373;6242.719077641608;6245.250569931637;6248.937510624835;6250.156228909221;6068.757249709962;6216.347283535345;6219.937800622117;6220.409061139185;6230.43926046658;6123.08153776937;6126.479249263863;6136.956717358149;6195.16365290698;6198.907016394848;6300.117983482224;6320.209973753281;6321.620702757849;6352.460040896575;6390.712417941111;6086.817395478142;6140.846478838065;6160.507159427325;6190.288116866618;6191.659458729813 06:05:53 INFO - PROCESS | 14943 | |5;yui.html;767.1024900865988;786.5713186313459;789.5499565247808;806.3146325623221;808.9676412943483;13406.396712147953;13573.253471059088;13590.388432520536;13591.592252232436;13596.524121655744;12355.135140540144;12908.612741617766;13034.478620855178;13089.934550327234;13101.213927164377;688.748606758532;694.9513534052618;820.2248874813304;823.4277177361736;823.6211342782327;693.4175292754086;828.8715249136394;832.1595188859235;836.1095433363448;836.8912041434605;866.3112825303898;868.7133246028795;869.1525762381659;869.7216890595012;870.5995242188601;700.0339531446571;702.9086218791575;844.6579135450153;854.0605334132435;860.2343913916619;639.6098379988204;640.6572483721187;641.5957946493679;641.8523739539932;642.4410762636489;12375.257484550955;12380.81428778569;12388.442520086617;12404.069694772928;12485.875141248562;12597.118201725883;12768.553100641526;12810;13279.73440531184;13280.136791108547;10472.895271047344;10606.416647084407;10628.840567391495;10965.61620343284;11170.888291117148;3609.530761001079;3647.708183345326;3684.392075307571;3782.092297848524;3784.924301513982;49450.50549494531;49730.50269497295;49768;49848;51128.58635497869;9195.218406435393;9494.810103797885;9543.952280238693;9721.805563888682;9728.756781080388;17795.644087118184;17871.463856084338;17888.91055544714;17908.641827163643;17948.910255448638;7561.697532098765;7730.2656247657505;7770.766876993699;7777.455578109591;7820.217978202248;4280.272353699878;4303.289957157097;4336.9132617348105;4376.102898905717;4423.756693381895;3194.8722051117693;3214.51782232667;3218.5815843940136;3229.9031029069165;3230.2570408806105;585.4321308330913;602.4698265526309;603.1766638538363;604.145134634496;613.487737738984;504.3356922156868;545;596.5815875035981;669.8760729265101;702.3924305475726;8832.470051796912;8841.69054083104;8981.595828187747;9079.273658107335;9198.356115071882;554.0138652662155;617.7992152550349;648.6562122075213;652.3443938841434;657.0899304463353;3936.291467535871;4049.8380064797666;4098.672106231554;4111.8972025699595;4128.318827393507;57224;57354.71322643443;57660.423395766345;57747;60929;47410.762946185045;48293.517064829604;52575;53958.730206348715;54015.72992135014;45044;45366;47096.29355559669;49274.75362623164;49296.75351623219;8633.6978205765;8877.511736854276;8989.595468203815;9093.181613654802;9181.54092295396;33044.1738956528;33423.33153336968;33441.83279083589;33682.3263534723;33688.66311336855;39702.404463932486;42813.14373712446;42964.35553466638;43397.132057359304;43984;11215.551377945118;11494;11569.768604627692;11630.6510804676;11763.416978322875;11971.221870578385;12012.63962081139;12075.456604452645;12810.615681529569;12825.743485130432;11758.588449404571;11789.882101179222;11792;12240.816387754012;12287.815682764944;11203.15976301797;11259.549618015515;11320.943395282971;11747.177697561088;11981.64055078349;10767.246292759432;10989.884536656084;11004.889951100387;11028.117750580095;11581.942090289831;9187.631001159998;9216.329524168466;9283.86074208901;9297.20466105697;9442.669506567237;9222.262219022596;9574.138327550554;9659.227261818896;9692.951535242279;9718.465484398426 06:05:53 INFO - PROCESS | 14943 | __end_tp_report 06:05:53 INFO - PROCESS | 14943 | __start_cc_report 06:05:53 INFO - PROCESS | 14943 | _x_x_mozilla_cycle_collect,890 06:05:53 INFO - PROCESS | 14943 | __end_cc_report 06:05:53 INFO - PROCESS | 14943 | __startTimestamp1453212353407__endTimestamp 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | ------- Summary: start ------- 06:05:53 INFO - PROCESS | 14943 | Number of tests: 6 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | [#0] dojo.html Cycles:165 Average:5185.89 Median:5340.15 stddev:552.25 (10.3%) stddev-sans-first:530.27 06:05:53 INFO - PROCESS | 14943 | Values: 3146.9 3177.9 3236.9 3238.0 3256.0 5079.0 5176.4 5197.3 5206.5 5260.2 5156.9 5167.4 5230.8 5261.7 5269.2 4730.0 4746.6 4759.2 4779.3 4882.7 4457.8 4830.1 4924.0 4927.9 4966.7 4645.8 4713.7 4722.2 4853.5 4867.0 4739.0 4774.6 4788.1 4794.8 4808.4 4738.5 4762.7 4763.4 4767.4 4796.1 4888.2 4986.3 5039.7 5125.1 5162.4 5554.4 5610.5 5614.3 5614.3 5667.3 5597.5 5614.6 5615.6 5622.2 5623.6 5115.5 5142.3 5220.3 5258.4 5264.8 5688.1 5689.6 5706.9 5708.1 5729.3 5472.1 5474.5 5477.3 5486.9 5488.2 5461.2 5501.9 5537.9 5543.0 5584.7 5497.2 5518.2 5537.1 5537.6 5537.7 5487.1 5527.6 5530.8 5532.1 5580.9 4271.9 4308.2 4329.5 4361.3 4396.5 3896.6 3903.5 3913.7 3941.8 3950.3 5129.0 5222.8 5234.9 5236.3 5239.9 5468.8 5531.1 5561.8 5574.3 5624.4 5210.9 5254.0 5254.4 5259.9 5260.8 4707.2 4791.7 4830.2 4835.7 4867.3 5816.1 5830.7 5846.5 5849.5 5922.6 5548.8 5573.4 5578.4 5579.9 5583.0 5696.2 5770.1 5801.5 5836.4 5839.1 5518.7 5527.2 5527.6 5532.5 5562.3 5596.8 5606.9 5614.8 5617.2 5620.5 5402.1 5456.5 5474.9 5483.6 5562.7 5379.5 5394.6 5421.1 5436.2 5443.8 5274.8 5337.7 5339.4 5340.3 5393.5 5352.0 5390.5 5447.2 5458.5 5468.2 5256.5 5292.3 5293.3 5293.6 5340.1 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | [#1] ext.html Cycles:180 Average:45870.27 Median:3422.12 stddev:75689.62 (2211.8%) stddev-sans-first:75825.41 06:05:53 INFO - PROCESS | 14943 | Values: 535.0 547.2 568.7 569.7 572.0 28634.4 29545.1 36064.3 36672.8 36821.4 42579.0 43622.8 43648.1 43718.8 43735.3 8589.6 8797.1 8800.5 8802.2 8802.2 8511.4 8616.6 8646.8 8654.0 8663.6 8648.1 8710.7 8719.8 8728.3 8731.0 8610.9 8673.3 8695.7 8697.7 8699.6 8517.4 8652.1 8652.2 8653.4 8656.7 39854.4 40653.3 40657.2 40692.8 40699.6 3290.7 3355.5 3408.1 3436.1 3930.8 30379.8 31017.0 31049.1 31152.0 31302.0 3842.0 3966.6 4028.2 4075.8 4106.6 265845.0 268002.0 268723.0 269436.0 270223.0 54589.7 56349.4 62473.4 62608.0 62701.0 66553.3 67457.7 67643.7 67679.7 67788.3 16113.4 16279.5 16311.3 16317.3 16325.3 11495.9 11718.2 11745.8 12051.2 12333.7 20173.7 20294.6 20428.2 20484.0 20564.0 8011.0 8261.5 8261.5 8270.0 8290.3 903.1 969.3 983.9 999.6 1036.9 28980.9 29216.3 29410.4 29517.4 29663.6 1033.2 1056.9 1096.3 1134.9 1163.8 13944.9 13999.7 14187.2 14236.7 14389.6 292639.0 297556.0 297935.0 299094.0 299240.0 53432.0 54296.0 54444.7 54473.5 54476.7 1366.1 1372.1 1382.4 1386.9 1387.5 26468.0 27378.9 27722.6 27892.6 27938.4 43863.6 44432.8 44453.3 44477.0 44509.3 300483.0 300891.0 302322.0 302380.0 303068.0 28325.9 28940.3 32487.8 32604.5 32980.5 40109.6 40353.4 40377.0 40547.8 41096.8 33553.5 33909.5 34014.0 34804.7 34936.7 28498.7 32861.3 34486.8 34761.8 35854.1 31711.8 32253.7 32559.5 32607.8 32610.2 27372.2 30057.5 32335.4 32392.4 32658.3 24206.4 24339.1 24399.9 24707.6 24778.8 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | [#2] jquery.html Cycles:180 Average:24770.94 Median:4887.47 stddev:75951.11 (1554.0%) stddev-sans-first:76142.06 06:05:53 INFO - PROCESS | 14943 | Values: 359.8 366.1 367.8 368.0 371.1 13161.3 13445.9 15590.4 15855.0 16489.8 14483.3 15452.4 15792.8 15809.1 16295.1 5173.5 5338.4 5341.5 5349.6 5352.9 4013.5 4116.1 5241.8 5325.3 5659.2 5740.5 5760.1 5765.9 5794.4 5804.2 5020.7 5175.7 5178.8 5197.2 5205.1 4803.2 4971.7 4975.0 4980.3 4987.1 12975.3 13344.9 19419.8 20182.0 20219.1 2178.5 2205.0 2214.9 2215.9 2308.8 9360.9 9525.0 9717.4 9782.9 11628.5 1837.8 1846.9 1853.9 1857.4 1878.6 56898.7 56953.7 58766.0 59253.7 59299.7 9935.9 10093.7 10246.7 10275.9 10280.3 13490.5 13563.3 13564.2 13569.7 13588.9 7513.8 7522.1 7559.7 7620.2 7648.7 7300.1 7383.3 7385.6 7421.7 7449.9 4457.6 4478.8 4497.7 4501.7 4511.2 1692.9 1735.6 1785.2 1796.2 1796.6 877.1 886.8 893.6 918.9 938.4 15757.2 16473.3 16509.8 16511.1 17008.1 897.5 910.9 940.0 948.1 997.9 9355.3 9376.0 9835.4 9923.3 9958.9 386906.0 396850.0 460294.0 526781.0 532060.0 58553.7 65970.0 66724.3 67225.0 69038.7 1099.2 1118.6 1132.2 1132.6 1136.5 11243.6 13669.9 14381.2 14413.2 15511.6 23048.0 23329.9 29372.9 31277.2 32727.5 38556.2 39007.6 39645.4 40003.4 42159.4 7211.2 7220.2 7236.2 7296.6 7377.7 8734.0 10283.7 10649.8 10821.8 11002.3 8978.7 9241.6 9243.3 9383.9 9395.2 9005.0 9380.0 9793.3 10168.5 10292.0 9386.5 9607.8 9615.7 9617.2 9855.0 7502.2 7511.6 7531.7 7571.2 7627.2 8377.5 10070.5 10095.6 10116.8 10409.2 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | [#3] mootools.html Cycles:180 Average:5533.40 Median:6267.93 stddev:2818.81 (45.0%) stddev-sans-first:2808.91 06:05:53 INFO - PROCESS | 14943 | Values: 1319.5 1493.9 1497.6 1685.7 1828.5 7091.3 7585.7 7723.2 7734.7 7737.8 7674.9 7860.5 7868.9 7872.4 7877.8 2069.1 2120.4 2303.3 2351.8 2376.0 2338.3 2343.7 2345.5 2346.0 2347.9 2299.0 2383.6 2384.3 2387.3 2387.3 2322.2 2343.3 2372.5 2374.3 2375.7 2348.9 2353.7 2373.9 2377.3 2386.6 7930.1 7991.4 8004.2 8014.1 8020.4 4903.6 5000.9 5009.1 5011.4 5018.3 3241.5 3259.2 3312.9 3364.1 3371.8 1035.7 1038.9 1049.1 1092.4 1104.9 11024.2 11040.1 11042.9 11076.7 11078.9 4389.9 4462.5 4465.8 4516.6 4523.3 9362.6 9373.9 9374.5 9376.3 9376.7 4992.6 4993.8 5008.3 5009.0 5014.4 4553.1 4555.0 4559.7 4562.3 4563.0 3533.1 3619.8 3736.5 3758.6 3797.2 1242.1 1248.1 1249.6 1254.2 1263.5 1044.9 1063.7 1064.1 1176.2 1311.1 7136.8 7157.7 7184.7 7242.1 7250.9 1116.0 1130.9 1135.9 1143.9 1153.2 5839.3 5921.6 5930.7 5933.9 5935.6 9196.5 9243.0 9273.3 9358.4 9610.5 9200.2 9329.9 9338.0 9340.5 9341.7 7224.9 7349.0 7374.7 7445.9 7454.0 7348.4 7437.2 7437.9 7441.1 7443.9 8017.2 8154.8 8296.2 8445.8 8459.9 8335.5 8358.8 8370.2 8501.5 8504.7 6324.6 6928.8 7133.1 7133.8 7143.3 6884.8 7446.3 7628.0 7633.5 7645.0 6958.2 6985.0 7057.1 7085.5 7248.7 7008.3 7014.3 7096.7 7138.9 7166.6 6795.0 6936.1 7166.0 7213.7 7214.9 6234.8 6301.1 6316.3 6316.8 6324.8 6367.4 6393.1 6406.3 6407.3 6413.7 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | [#4] prototype.html Cycles:180 Average:5215.86 Median:5892.71 stddev:1561.78 (26.5%) stddev-sans-first:1522.84 06:05:53 INFO - PROCESS | 14943 | Values: 348.7 355.8 357.1 361.7 362.8 5695.7 5740.2 5802.5 5842.9 5851.9 5618.2 5732.5 5734.8 5739.2 5754.1 4558.4 4559.2 4559.5 4561.4 4561.9 4373.5 4483.9 4497.8 4503.6 4574.8 4400.5 4450.9 4480.5 4485.9 4489.4 4479.7 4486.6 4502.6 4513.6 4528.5 4013.6 4016.3 4016.7 4018.5 4019.0 5487.7 5604.6 5609.3 5643.8 5665.3 5208.8 5212.2 5215.2 5216.8 5218.7 5880.8 6199.6 6208.2 6216.8 6217.1 4249.5 4271.2 4343.7 4344.8 4377.6 6325.6 6439.7 6446.0 6447.8 6461.7 4442.4 4443.7 4444.6 4446.6 4449.7 4385.6 4497.1 4499.2 4502.0 4541.9 5199.4 5200.2 5207.2 5213.1 5216.2 6235.9 6247.3 6248.4 6249.4 6252.4 1577.9 1597.2 1597.9 1599.2 1600.5 1076.0 1080.7 1081.6 1081.7 1108.2 5911.6 5924.5 5966.2 5969.2 5979.3 6330.1 6340.5 6356.4 6376.8 6382.8 5904.6 5914.9 5918.1 5924.5 5928.0 3359.8 3471.3 3477.0 3481.4 3483.5 6772.2 6775.0 6779.1 6782.4 6783.3 6577.6 6584.8 6589.3 6591.7 6592.1 6512.2 6754.7 6763.6 6767.7 6780.1 6169.4 6311.6 6380.3 6390.9 6398.4 6188.8 6272.3 6285.2 6294.3 6307.2 6778.9 6842.1 6849.6 6853.2 6855.4 4311.2 4468.2 4502.8 4503.7 4505.2 6359.2 6376.8 6380.2 6386.2 6393.0 6235.6 6242.7 6245.3 6248.9 6250.2 6068.8 6216.3 6219.9 6220.4 6230.4 6123.1 6126.5 6137.0 6195.2 6198.9 6300.1 6320.2 6321.6 6352.5 6390.7 6086.8 6140.8 6160.5 6190.3 6191.7 06:05:53 INFO - PROCESS | 14943 | 06:05:53 INFO - PROCESS | 14943 | [#5] yui.html Cycles:180 Average:13817.83 Median:49285.75 stddev:15995.25 (32.5%) stddev-sans-first:16010.10 06:05:53 INFO - PROCESS | 14943 | Values: 767.1 786.6 789.5 806.3 809.0 13406.4 13573.3 13590.4 13591.6 13596.5 12355.1 12908.6 13034.5 13089.9 13101.2 688.7 695.0 820.2 823.4 823.6 693.4 828.9 832.2 836.1 836.9 866.3 868.7 869.2 869.7 870.6 700.0 702.9 844.7 854.1 860.2 639.6 640.7 641.6 641.9 642.4 12375.3 12380.8 12388.4 12404.1 12485.9 12597.1 12768.6 12810.0 13279.7 13280.1 10472.9 10606.4 10628.8 10965.6 11170.9 3609.5 3647.7 3684.4 3782.1 3784.9 49450.5 49730.5 49768.0 49848.0 51128.6 9195.2 9494.8 9544.0 9721.8 9728.8 17795.6 17871.5 17888.9 17908.6 17948.9 7561.7 7730.3 7770.8 7777.5 7820.2 4280.3 4303.3 4336.9 4376.1 4423.8 3194.9 3214.5 3218.6 3229.9 3230.3 585.4 602.5 603.2 604.1 613.5 504.3 545.0 596.6 669.9 702.4 8832.5 8841.7 8981.6 9079.3 9198.4 554.0 617.8 648.7 652.3 657.1 3936.3 4049.8 4098.7 4111.9 4128.3 57224.0 57354.7 57660.4 57747.0 60929.0 47410.8 48293.5 52575.0 53958.7 54015.7 45044.0 45366.0 47096.3 49274.8 49296.8 8633.7 8877.5 8989.6 9093.2 9181.5 33044.2 33423.3 33441.8 33682.3 33688.7 39702.4 42813.1 42964.4 43397.1 43984.0 11215.6 11494.0 11569.8 11630.7 11763.4 11971.2 12012.6 12075.5 12810.6 12825.7 11758.6 11789.9 11792.0 12240.8 12287.8 11203.2 11259.5 11320.9 11747.2 11981.6 10767.2 10989.9 11004.9 11028.1 11581.9 9187.6 9216.3 9283.9 9297.2 9442.7 9222.3 9574.1 9659.2 9693.0 9718.5 06:05:53 INFO - PROCESS | 14943 | -------- Summary: end -------- 06:05:53 INFO - PROCESS | 14943 | 06:05:54 INFO - TEST-INFO | 14943: exit 0 06:05:54 INFO - TEST-OK | dromaeo_css | took 1112114ms 06:05:54 INFO - TEST-START | kraken 06:05:54 INFO - operating with platform_type : linux_ 06:05:54 INFO - Initialising browser for kraken test... 06:05:54 INFO - TEST-INFO | started process 15139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW7ZcDZ/profile http://localhost:44970/getInfo.html) 06:05:57 INFO - PROCESS | 15139 | __metrics Screen width/height:1600/1200 06:05:57 INFO - PROCESS | 15139 | colorDepth:24 06:05:57 INFO - PROCESS | 15139 | Browser inner width/height: 1024/697 06:05:57 INFO - PROCESS | 15139 | __metrics 06:05:57 INFO - PROCESS | 15139 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:05:57 INFO - PROCESS | 15139 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:58 INFO - TEST-INFO | 15139: exit 0 06:05:58 INFO - Browser initialized. 06:05:58 INFO - Running cycle 1/1 for kraken test... 06:05:58 INFO - TEST-INFO | started process 15223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW7ZcDZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:10 INFO - PROCESS | 15223 | RSS: Main: 150106112 06:06:10 INFO - PROCESS | 15223 | 06:06:12 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44970/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:13 INFO - PROCESS | 15223 | RSS: Main: 187019264 06:06:13 INFO - PROCESS | 15223 | 06:06:16 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44970/tests/kraken/driver.html?testName=audio-dft) 06:06:16 INFO - PROCESS | 15223 | RSS: Main: 178769920 06:06:16 INFO - PROCESS | 15223 | 06:06:19 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44970/tests/kraken/driver.html?testName=audio-fft) 06:06:20 INFO - PROCESS | 15223 | RSS: Main: 165855232 06:06:20 INFO - PROCESS | 15223 | 06:06:22 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44970/tests/kraken/driver.html?testName=audio-oscillator) 06:06:22 INFO - PROCESS | 15223 | RSS: Main: 165294080 06:06:22 INFO - PROCESS | 15223 | 06:06:24 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44970/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:25 INFO - PROCESS | 15223 | RSS: Main: 165789696 06:06:25 INFO - PROCESS | 15223 | 06:06:28 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44970/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:29 INFO - PROCESS | 15223 | RSS: Main: 166547456 06:06:29 INFO - PROCESS | 15223 | 06:06:32 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44970/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:32 INFO - PROCESS | 15223 | RSS: Main: 166236160 06:06:32 INFO - PROCESS | 15223 | 06:06:35 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44970/tests/kraken/driver.html?testName=json-parse-financial) 06:06:36 INFO - PROCESS | 15223 | RSS: Main: 165376000 06:06:36 INFO - PROCESS | 15223 | 06:06:37 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44970/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:38 INFO - PROCESS | 15223 | RSS: Main: 178524160 06:06:38 INFO - PROCESS | 15223 | 06:06:40 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:40 INFO - PROCESS | 15223 | RSS: Main: 177414144 06:06:40 INFO - PROCESS | 15223 | 06:06:42 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:43 INFO - PROCESS | 15223 | RSS: Main: 188207104 06:06:43 INFO - PROCESS | 15223 | 06:06:45 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:46 INFO - PROCESS | 15223 | RSS: Main: 192077824 06:06:46 INFO - PROCESS | 15223 | 06:06:48 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:49 INFO - PROCESS | 15223 | RSS: Main: 191397888 06:06:49 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:44970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44970/tests/kraken/driver.html?testName=ai-astar) 06:06:51 INFO - PROCESS | 15223 | RSS: Main: 247517184 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | __start_tp_report 06:06:51 INFO - PROCESS | 15223 | _x_x_mozilla_page_load 06:06:51 INFO - PROCESS | 15223 | _x_x_mozilla_page_load_details 06:06:51 INFO - PROCESS | 15223 | |i|pagename|runs| 06:06:51 INFO - PROCESS | 15223 | |0;ai-astar;110;109;105;109;108;109;111;110;103;110 06:06:51 INFO - PROCESS | 15223 | |1;audio-beat-detection;162;126;161;165;127;156;153;128;164;128 06:06:51 INFO - PROCESS | 15223 | |2;audio-dft;162;159;160;160;161;161;159;161;162;162 06:06:51 INFO - PROCESS | 15223 | |3;audio-fft;73;73;72;157;73;72;76;73;148;74 06:06:51 INFO - PROCESS | 15223 | |4;audio-oscillator;95;95;139;95;96;96;146;96;96;141 06:06:51 INFO - PROCESS | 15223 | |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;109;109 06:06:51 INFO - PROCESS | 15223 | |6;imaging-darkroom;145;145;146;145;145;146;145;145;145;146 06:06:51 INFO - PROCESS | 15223 | |7;imaging-desaturate;96;96;96;96;97;96;104;96;96;96 06:06:51 INFO - PROCESS | 15223 | |8;json-parse-financial;57;56;55;55;55;55;55;57;55;54 06:06:51 INFO - PROCESS | 15223 | |9;json-stringify-tinderbox;68;69;68;68;69;68;68;69;70;68 06:06:51 INFO - PROCESS | 15223 | |10;stanford-crypto-aes;81;81;82;82;82;83;83;82;82;82 06:06:51 INFO - PROCESS | 15223 | |11;stanford-crypto-ccm;117;116;120;112;118;111;120;121;118;116 06:06:51 INFO - PROCESS | 15223 | |12;stanford-crypto-pbkdf2;142;143;147;141;142;132;141;142;140;143 06:06:51 INFO - PROCESS | 15223 | |13;stanford-crypto-sha256-iterative;66;65;65;64;66;67;66;66;67;66 06:06:51 INFO - PROCESS | 15223 | __end_tp_report 06:06:51 INFO - PROCESS | 15223 | __start_cc_report 06:06:51 INFO - PROCESS | 15223 | _x_x_mozilla_cycle_collect,932 06:06:51 INFO - PROCESS | 15223 | __end_cc_report 06:06:51 INFO - PROCESS | 15223 | __startTimestamp1453212411319__endTimestamp 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | ------- Summary: start ------- 06:06:51 INFO - PROCESS | 15223 | Number of tests: 14 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:2.50 (2.3%) stddev-sans-first:2.59 06:06:51 INFO - PROCESS | 15223 | Values: 110.0 109.0 105.0 109.0 108.0 109.0 111.0 110.0 103.0 110.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:158.50 stddev:17.37 (11.0%) stddev-sans-first:17.55 06:06:51 INFO - PROCESS | 15223 | Values: 162.0 126.0 161.0 165.0 127.0 156.0 153.0 128.0 164.0 128.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 06:06:51 INFO - PROCESS | 15223 | Values: 162.0 159.0 160.0 160.0 161.0 161.0 159.0 161.0 162.0 162.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:33.50 (45.9%) stddev-sans-first:35.02 06:06:51 INFO - PROCESS | 15223 | Values: 73.0 73.0 72.0 157.0 73.0 72.0 76.0 73.0 148.0 74.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.50 stddev:22.50 (23.6%) stddev-sans-first:23.24 06:06:51 INFO - PROCESS | 15223 | Values: 95.0 95.0 139.0 95.0 96.0 96.0 146.0 96.0 96.0 141.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:06:51 INFO - PROCESS | 15223 | Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:06:51 INFO - PROCESS | 15223 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:2.51 (2.6%) stddev-sans-first:2.65 06:06:51 INFO - PROCESS | 15223 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 104.0 96.0 96.0 96.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 06:06:51 INFO - PROCESS | 15223 | Values: 57.0 56.0 55.0 55.0 55.0 55.0 55.0 57.0 55.0 54.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 06:06:51 INFO - PROCESS | 15223 | Values: 68.0 69.0 68.0 68.0 69.0 68.0 68.0 69.0 70.0 68.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 06:06:51 INFO - PROCESS | 15223 | Values: 81.0 81.0 82.0 82.0 82.0 83.0 83.0 82.0 82.0 82.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:118.00 stddev:3.31 (2.8%) stddev-sans-first:3.52 06:06:51 INFO - PROCESS | 15223 | Values: 117.0 116.0 120.0 112.0 118.0 111.0 120.0 121.0 118.0 116.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:142.00 stddev:3.77 (2.7%) stddev-sans-first:3.99 06:06:51 INFO - PROCESS | 15223 | Values: 142.0 143.0 147.0 141.0 142.0 132.0 141.0 142.0 140.0 143.0 06:06:51 INFO - PROCESS | 15223 | 06:06:51 INFO - PROCESS | 15223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 06:06:51 INFO - PROCESS | 15223 | Values: 66.0 65.0 65.0 64.0 66.0 67.0 66.0 66.0 67.0 66.0 06:06:51 INFO - PROCESS | 15223 | -------- Summary: end -------- 06:06:51 INFO - PROCESS | 15223 | 06:06:52 INFO - TEST-INFO | 15223: exit 0 06:06:52 INFO - TEST-OK | kraken | took 58162ms 06:06:52 INFO - TEST-START | v8_7 06:06:52 INFO - operating with platform_type : linux_ 06:06:52 INFO - Initialising browser for v8_7 test... 06:06:52 INFO - TEST-INFO | started process 15469 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTwunTK/profile http://localhost:44970/getInfo.html) 06:06:56 INFO - PROCESS | 15469 | __metrics Screen width/height:1600/1200 06:06:56 INFO - PROCESS | 15469 | colorDepth:24 06:06:56 INFO - PROCESS | 15469 | Browser inner width/height: 1024/697 06:06:56 INFO - PROCESS | 15469 | __metrics 06:06:56 INFO - PROCESS | 15469 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:06:56 INFO - PROCESS | 15469 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:57 INFO - TEST-INFO | 15469: exit 0 06:06:57 INFO - Browser initialized. 06:06:57 INFO - Running cycle 1/1 for v8_7 test... 06:06:57 INFO - TEST-INFO | started process 15554 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTwunTK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:08 INFO - PROCESS | 15554 | RSS: Main: 149991424 06:07:08 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:44970/tests/v8_7/run.html (next: http://localhost:44970/tests/v8_7/run.html) 06:07:31 INFO - PROCESS | 15554 | RSS: Main: 580263936 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | __start_tp_report 06:07:31 INFO - PROCESS | 15554 | _x_x_mozilla_page_load 06:07:31 INFO - PROCESS | 15554 | _x_x_mozilla_page_load_details 06:07:31 INFO - PROCESS | 15554 | |i|pagename|runs| 06:07:31 INFO - PROCESS | 15554 | |0;Richards;166.88918558077435 06:07:31 INFO - PROCESS | 15554 | |1;DeltaBlue;189.25056775170324 06:07:31 INFO - PROCESS | 15554 | |2;Encrypt;281.7695125387433 06:07:31 INFO - PROCESS | 15554 | |3;Decrypt;5273.684210526316 06:07:31 INFO - PROCESS | 15554 | |4;RayTrace;1142.6940639269405 06:07:31 INFO - PROCESS | 15554 | |5;Earley;786.1635220125786 06:07:31 INFO - PROCESS | 15554 | |6;Boyer;12192.77108433735 06:07:31 INFO - PROCESS | 15554 | |7;RegExp;42583.333333333336 06:07:31 INFO - PROCESS | 15554 | |8;Splay;635.3240152477764 06:07:31 INFO - PROCESS | 15554 | |9;NavierStokes;4817.307692307692 06:07:31 INFO - PROCESS | 15554 | __end_tp_report 06:07:31 INFO - PROCESS | 15554 | __startTimestamp1453212451425__endTimestamp 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | ------- Summary: start ------- 06:07:31 INFO - PROCESS | 15554 | Number of tests: 10 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 166.9 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#1] DeltaBlue Cycles:1 Average:189.25 Median:189.25 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 189.3 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 281.8 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 5273.7 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#4] RayTrace Cycles:1 Average:1142.69 Median:1142.69 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 1142.7 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 786.2 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 12192.8 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#7] RegExp Cycles:1 Average:42583.33 Median:42583.33 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 42583.3 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#8] Splay Cycles:1 Average:635.32 Median:635.32 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 635.3 06:07:31 INFO - PROCESS | 15554 | 06:07:31 INFO - PROCESS | 15554 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 06:07:31 INFO - PROCESS | 15554 | Values: 4817.3 06:07:31 INFO - PROCESS | 15554 | -------- Summary: end -------- 06:07:31 INFO - PROCESS | 15554 | 06:07:32 INFO - TEST-INFO | 15554: exit 0 06:07:32 INFO - TEST-OK | v8_7 | took 40054ms 06:07:32 INFO - SUITE-END | took 1210s 06:07:32 INFO - Completed test suite (00:20:10) 06:07:32 INFO - Working with test: dromaeo_css 06:07:32 INFO - Generating results file: dromaeo_css 06:07:32 INFO - Working with test: kraken 06:07:32 INFO - Generating results file: kraken 06:07:32 INFO - javascript benchmark 06:07:32 INFO - Working with test: v8_7 06:07:32 INFO - Generating results file: v8_7 06:07:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:07:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:07:32 INFO - process_Request line: dromaeo_css 6843.60 graph.html#tests=[[72,1,35]] 06:07:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:07:32 INFO - process_Request line: kraken 1496.00 graph.html#tests=[[232,1,35]] 06:07:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:07:32 INFO - process_Request line: v8_7 19839.73 graph.html#tests=[[230,1,35]] 06:07:32 INFO - RETURN: dromaeo_css: 6843.60 06:07:32 INFO - RETURN: kraken: 1496.00 06:07:32 INFO - RETURN: v8_7: 19839.73 06:07:32 INFO - javascript benchmark 06:07:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3146.88985885494, 3177.872885084597, 3236.870525178993, 3237.9514307285394, 3256.0231930420873, 5079.0, 5176.352955880515, 5197.324347834781, 5206.45332240115, 5260.158374660055, 5156.948430515703, 5167.431582525928, 5230.790768369261, 5261.736913154336, 5269.209618557218, 4729.952700473003, 4746.572808447248, 4759.190937540609, 4779.283107533863, 4882.682625629341, 4457.834276336725, 4830.106430310386, 4923.950760492385, 4927.876803079916, 4966.65233433658, 4645.76771161444, 4713.670043096985, 4722.197226471508, 4853.490383509734, 4867.014665672384, 4739.0, 4774.594159496447, 4788.11419887322, 4794.832180873653, 4808.422989241313, 4738.455077666078, 4762.690425122356, 4763.404574428197, 4767.356406885061, 4796.088743138793, 4888.193448081062, 4986.301917731521, 5039.672421292605, 5125.128728116192, 5162.380514338266, 5554.361248456398, 5610.49505544503, 5614.29821272341, 5614.326280846284, 5667.3482549506925, 5597.496225339698, 5614.63504872182, 5615.550755939515, 5622.156676498517, 5623.634463759883, 5115.462876397999, 5142.305788718512, 5220.321358223407, 5258.447862974371, 5264.842054738364, 5688.146777983336, 5689.630174038674, 5706.885862282814, 5708.058170401837, 5729.28383952006, 5472.097103977799, 5474.534664553557, 5477.28795256622, 5486.890262194734, 5488.204210389471, 5461.208124821958, 5501.862453438616, 5537.861553461115, 5543.0, 5584.720763961785, 5497.230387745719, 5518.19986102013, 5537.058700020925, 5537.5569954404355, 5537.723113844291, 5487.149491828773, 5527.640703354269, 5530.794771319991, 5532.114861622202, 5580.883823235369, 4271.871843844628, 4308.159908817813, 4329.545397733255, 4361.302191649321, 4396.538363471854, 3896.6298201670797, 3903.512060992376, 3913.6673382762783, 3941.7832019238645, 3950.2692001979726, 5129.025485157808, 5222.843314700565, 5234.895302094013, 5236.266922630834, 5239.869003274948, 5468.835934921959, 5531.1426728857095, 5561.805336813192, 5574.275344205227, 5624.437556244343, 5210.921836172461, 5253.973730131325, 5254.448282930237, 5259.868503287372, 5260.7718787830545, 4707.2468405055715, 4791.664583479123, 4830.178869592178, 4835.709857408567, 4867.318575399447, 5816.098504731774, 5830.7084645767545, 5846.503047240947, 5849.473547380756, 5922.644641321534, 5548.833534993957, 5573.3869274380595, 5578.414266501959, 5579.944200557942, 5583.0, 5696.231008813757, 5770.13447982806, 5801.477866991991, 5836.416358364129, 5839.065749480063, 5518.696471694096, 5527.198556209408, 5527.613067085426, 5532.529734972572, 5562.332520097614, 5596.776128954796, 5606.85982850432, 5614.803481878114, 5617.213590097308, 5620.4660557247, 5402.135658294654, 5456.536194423518, 5474.863128421821, 5483.643563168382, 5562.72186390687, 5379.488948549882, 5394.595405344693, 5421.1055175895535, 5436.184572314184, 5443.755031023535, 5274.76263568148, 5337.653052551727, 5339.4126646068125, 5340.252364668871, 5393.514583687487, 5352.0, 5390.4879036491475, 5447.237386765777, 5458.536024437967, 5468.152436372368, 5256.474352564713, 5292.259083728204, 5293.285406470077, 5293.576513878804, 5340.145576707708], "unit": "score", "name": "dojo.html", "value": 5152.046923082212}, {"lowerIsBetter": false, "replicates": [534.95185433311, 547.1983544107883, 568.7128000359818, 569.6809786519548, 572.0047118014655, 28634.427311453783, 29545.11364659061, 36064.278714425694, 36672.81663591678, 36821.44767828485, 42579.0, 43622.781886090605, 43648.127037459235, 43718.781406093, 43735.343969840476, 8589.613467393967, 8797.07630698777, 8800.47197168172, 8802.207801297882, 8802.207801297882, 8511.361647876434, 8616.578264586336, 8646.783830404227, 8653.95673021634, 8663.566821658924, 8648.135186481364, 8710.738677839676, 8719.782005449882, 8728.301735861116, 8730.956345218297, 8610.913890861106, 8673.262772664268, 8695.652173913037, 8697.652093916236, 8699.608517616722, 8517.36119791018, 8652.091530389345, 8652.178043085896, 8653.394262401634, 8656.697015604424, 39854.402183967264, 40653.30853680487, 40657.186856263004, 40692.79653601743, 40699.59300406987, 3290.654481279479, 3355.4966754986704, 3408.113890388492, 3436.1237884339334, 3930.803459827026, 30379.848100759576, 31017.0, 31049.068527944197, 31152.0, 31302.0, 3842.0010797192654, 3966.603339666039, 4028.194361127786, 4075.7962101894786, 4106.609872062179, 265845.0, 268002.0, 268723.0, 269436.0, 270223.0, 54589.727051365284, 56349.43650563442, 62473.37526624766, 62608.0, 62701.0, 66553.33446665568, 67457.66271168613, 67643.66178169078, 67679.66160169266, 67788.32211677919, 16113.355465781471, 16279.51161465158, 16311.265993030342, 16317.265723042492, 16325.346986120423, 11495.942520287344, 11718.179727419169, 11745.823812642817, 12051.156419050758, 12333.69165770845, 20173.697394539093, 20294.56465224153, 20428.18287268522, 20484.0, 20564.0, 8011.0, 8261.504309741435, 8261.504309741435, 8269.95865020671, 8290.253877151084, 903.1284810158229, 969.2972594868804, 983.8671779309844, 999.5855863952426, 1036.891126431729, 28980.855437501465, 29216.269593259913, 29410.411791764473, 29517.409651806844, 29663.55504667432, 1033.1992705653029, 1056.8837427882927, 1096.336716286635, 1134.886511348875, 1163.790517706804, 13944.930275348559, 13999.720005599831, 14187.219702916438, 14236.715265694627, 14389.64025899361, 292639.0, 297556.0, 297935.0, 299094.0, 299240.0, 53432.0, 54296.0, 54444.72777636166, 54473.455265446835, 54476.72761636166, 1366.064245991499, 1372.053283234565, 1382.3502953611787, 1386.8613138686253, 1387.5213051497217, 26468.0, 27378.86310568514, 27722.584161238003, 27892.58161127625, 27938.441231174857, 43863.56136438723, 44432.77783611061, 44453.333200001376, 44477.0, 44509.33236001527, 300483.0, 300891.0, 302322.0, 302380.0, 303068.0, 28325.858370708014, 28940.27649308784, 32487.837560812044, 32604.510932336507, 32980.50529242015, 40109.59890401176, 40353.39469908013, 40377.0, 40547.797261013504, 41096.79451602723, 33553.49669754907, 33909.49135763015, 34014.0, 34804.65195348014, 34936.65063349334, 28498.715012849607, 32861.34277314488, 34486.82756586201, 34761.82619086889, 35854.10364740902, 31711.841440792647, 32253.677463225067, 32559.511607325436, 32607.836960815992, 32610.184745381554, 27372.178834634196, 30057.54913676253, 32335.35329293448, 32392.352152956337, 32658.34683306273, 24206.394840129138, 24339.14812981537, 24399.878000609882, 24707.62938555887, 24778.752212477644], "unit": "score", "name": "ext.html", "value": 18360.67482044015}, {"lowerIsBetter": false, "replicates": [359.83447614097514, 366.1103518450167, 367.84734335250874, 367.9742418030738, 371.11674215367424, 13161.341932903364, 13445.865541344583, 15590.376384944602, 15854.969426987238, 16489.835101648965, 14483.2758362082, 15452.381904723825, 15792.763108553381, 15809.130497822614, 16295.103769292684, 5173.534381905628, 5338.386085600147, 5341.545968592674, 5349.598780091509, 5352.946470535284, 4013.458183145282, 4116.115035267417, 5241.8427447176455, 5325.3077099976945, 5659.179418984245, 5740.512056475204, 5760.107183386561, 5765.913511297334, 5794.362620111784, 5804.229709938467, 5020.723860187688, 5175.715335656538, 5178.766955487012, 5197.220416937452, 5205.141151709982, 4803.207470767319, 4971.726555039471, 4975.029869175512, 4980.2778597103215, 4987.127252730794, 12975.286359250238, 13344.866551334459, 19419.80580194194, 20182.0, 20219.090140943692, 2178.498945242587, 2204.9669254961186, 2214.9114035438565, 2215.8559693620023, 2308.8499247549025, 9360.859587106199, 9524.999875013093, 9717.416954982724, 9782.853257201148, 11628.476718547601, 1837.7794664640328, 1846.8891866488054, 1853.9165737541844, 1857.3963461874944, 1878.6336664350458, 56898.7155064222, 56953.71523142358, 58766.0, 59253.703731481495, 59299.70350148222, 9935.900640993643, 10093.69718908434, 10246.743831404125, 10275.897241027644, 10280.331778434378, 13490.527831526046, 13563.321833908265, 13564.186148831102, 13569.660758481117, 13588.93205533966, 7513.812154696067, 7522.097348318237, 7559.659815308324, 7620.237976202336, 7648.73229436967, 7300.087489063867, 7383.2616738326815, 7385.556866588022, 7421.740239091606, 7449.925500745032, 4457.64338852891, 4478.798454069574, 4497.730136191839, 4501.729896206238, 4511.210538155809, 1692.9068901210305, 1735.6094878652202, 1785.1609743420572, 1796.1558067708156, 1796.6137280484759, 877.1053525404052, 886.8049029213563, 893.5934149961752, 918.8621706743908, 938.4275591888942, 15757.212139392985, 16473.34106635745, 16509.83490165107, 16511.09188994593, 17008.149592520323, 897.5018864530249, 910.899801021887, 939.9812003759887, 948.0756262644005, 997.8652881861001, 9355.345125841262, 9375.953120234355, 9835.360701554519, 9923.255755818342, 9958.900410995942, 386906.0, 396850.0, 460294.0, 526781.0, 532060.0, 58553.70723146357, 65970.0, 66724.33275667278, 67225.0, 69038.65480672565, 1099.1536516881956, 1118.6140781430393, 1132.1565433751744, 1132.603588743933, 1136.534021051365, 11243.55025798959, 13669.863301366859, 14381.155589312706, 14413.207273600052, 15511.612209694847, 23048.0, 23329.88335058314, 29372.94389392722, 31277.218069548442, 32727.509087364186, 38556.2165675151, 39007.609923900396, 39645.405318919664, 40003.39994900021, 42159.36760948527, 7211.2428195038765, 7220.205777364381, 7236.167840698176, 7296.562206267641, 7377.741779037708, 8734.0, 10283.691489255334, 10649.840252396376, 10821.783564328513, 11002.284851484628, 8978.730638080868, 9241.630334786532, 9243.306751993492, 9383.859242111237, 9395.24838012971, 9005.0, 9379.953100234456, 9793.314467987173, 10168.491575421347, 10292.022257885788, 9386.530673466163, 9607.759806004906, 9615.711528654152, 9617.182539483942, 9854.950725246328, 7502.174760776419, 7511.624418779148, 7531.698732050876, 7571.205023472456, 7627.237276272328, 8377.49735015901, 10070.496475176065, 10095.646652367132, 10116.84824727615, 10409.219308551737], "unit": "score", "name": "jquery.html", "value": 7966.445039505744}, {"lowerIsBetter": false, "replicates": [1319.4656164253481, 1493.8804895608348, 1497.558220325004, 1685.6881476926762, 1828.4880233534616, 7091.255418181087, 7585.696572137114, 7723.227677232274, 7734.729284475045, 7737.806554836132, 7674.923250767504, 7860.489068210562, 7868.881966770503, 7872.448928575002, 7877.842443151134, 2069.0999415254337, 2120.3532922458644, 2303.2974942642486, 2351.8000969917575, 2375.964360534593, 2338.3452633262714, 2343.6953196084487, 2345.542619189259, 2345.9882700586472, 2347.859128452298, 2298.954020919589, 2383.5828729972186, 2384.3085505203558, 2387.259949415678, 2387.319613910036, 2322.1640209524558, 2343.273585188597, 2372.478054827935, 2374.263978166774, 2375.6555299481565, 2348.859068455898, 2353.682252895854, 2373.8694371809543, 2377.3343463830156, 2386.642003699442, 7930.1276859545405, 7991.400644951652, 8004.239597238253, 8014.078380986203, 8020.35837133028, 4903.607711383081, 5000.949990500121, 5009.0983622948215, 5011.448740638527, 5018.347614810088, 3241.5137729340554, 3259.168911927467, 3312.933741325184, 3364.0916952422954, 3371.814550199738, 1035.6841163445147, 1038.937663740178, 1049.108257980718, 1092.4100985467837, 1104.9226554141214, 11024.228304018721, 11040.116790656728, 11042.889571104266, 11076.667699969013, 11078.889211107948, 4389.890252743707, 4462.509123996358, 4465.799039043186, 4516.593506584358, 4523.344115103291, 9362.578683959238, 9373.859392109123, 9374.484403357881, 9376.343655944154, 9376.718698439057, 4992.575631071327, 4993.825216117491, 5008.273800298936, 5009.0, 5014.373203349582, 4553.066621342617, 4554.977225113919, 4559.749213793207, 4562.270036794163, 4562.954370456319, 3533.081398836321, 3619.8371073301764, 3736.4768932349493, 3758.6053464385845, 3797.240551889633, 1242.105683907585, 1248.0514808745238, 1249.6001279590444, 1254.1785130739381, 1263.5451237554473, 1044.9111825494917, 1063.7021633942509, 1064.0636240108654, 1176.2236923630362, 1311.1084462565357, 7136.821579460555, 7157.749478768218, 7184.712611495482, 7242.094738157731, 7250.891236631454, 1115.983260251097, 1130.8756036835941, 1135.9204855660025, 1143.8512993310817, 1153.210051114989, 5839.270091238595, 5921.555883308769, 5930.703464826742, 5933.851653708692, 5935.584509084409, 9196.540172991323, 9243.0, 9273.30450216223, 9358.4384936904, 9610.471424071744, 9200.217981471516, 9329.90670093304, 9338.0, 9340.4862732549, 9341.719748407559, 7224.927750722425, 7348.96325518369, 7374.705011799575, 7445.85108297831, 7453.962730186315, 7348.375388091858, 7437.181909990005, 7437.888431673638, 7441.144268408986, 7443.888341674988, 8017.198280171936, 8154.75535733929, 8296.170382961896, 8445.831083378422, 8459.915400845914, 8335.49987000782, 8358.791030224049, 8370.204830541088, 8501.489910605384, 8504.659813607634, 6324.557280990471, 6928.792136235921, 7133.144022717307, 7133.821654458472, 7143.285671432815, 6884.759033433806, 7446.292602202782, 7628.0, 7633.465657403928, 7645.0, 6958.199807022257, 6984.965075174591, 7057.117860267466, 7085.468589855678, 7248.746293879689, 7008.299170082951, 7014.333638304353, 7096.680649370687, 7138.928610713826, 7166.605836678824, 6795.0, 6936.0636314096955, 7166.0, 7213.747518836815, 7214.855702886018, 6234.781782637586, 6301.0863424804065, 6316.336784637547, 6316.778912738032, 6324.810255692337, 6367.363263673781, 6393.104965304768, 6406.327335629878, 6407.263164736115, 6413.743450261937], "unit": "score", "name": "mootools.html", "value": 4574.252861900921}, {"lowerIsBetter": false, "replicates": [348.66876467356013, 355.82742369950586, 357.1072319201996, 361.73954752578135, 362.82765686298995, 5695.686737229461, 5740.167675687023, 5802.462347477922, 5842.88314233715, 5851.941480585198, 5618.15727640853, 5732.5127364173995, 5734.770609175638, 5739.167820666001, 5754.079347304432, 4558.384618076567, 4559.247724125516, 4559.475660299075, 4561.407017087774, 4561.885952851172, 4373.497047839492, 4483.910321793563, 4497.7526236057, 4503.57216064475, 4574.79413426395, 4400.471943366801, 4450.910981780363, 4480.484744254403, 4485.910281794362, 4489.371487991683, 4479.686421950465, 4486.596206341429, 4502.594766471033, 4513.616342610882, 4528.524504926968, 4013.618706222904, 4016.297147999118, 4016.6585840203325, 4018.5177778666457, 4018.9799051004557, 5487.6981766002855, 5604.607677462538, 5609.298837645294, 5643.830685079454, 5665.348484924245, 5208.817691380821, 5212.218167274901, 5215.191645294985, 5216.843494695166, 5218.712970786605, 5880.794172203952, 6199.597026193283, 6208.2239720034995, 6216.787726393355, 6217.098520714516, 4249.490061192677, 4271.231178387889, 4343.6959412841115, 4344.761038142932, 4377.649788016951, 6325.620462772203, 6439.678016099177, 6446.0, 6447.774327898501, 6461.676916154221, 4442.378067070613, 4443.666724995638, 4444.599986001275, 4446.6220371268155, 4449.710768800018, 4385.583369579885, 4497.123061003138, 4499.190145773792, 4502.0, 4541.931871021871, 5199.4020687621405, 5200.167973124282, 5207.192885102815, 5213.113770658997, 5216.191490319006, 6235.875282494416, 6247.312795592572, 6248.4376406123665, 6249.375062493805, 6252.437280644764, 1577.8895477316478, 1597.161490217645, 1597.8561929426176, 1599.1844159478517, 1600.5198440467814, 1075.978480430387, 1080.708208783624, 1081.643057790927, 1081.7025318037602, 1108.152263518409, 5911.556633252523, 5924.496417804448, 5966.164736936746, 5969.2240008799445, 5979.342272350038, 6330.113784070234, 6340.4927605792345, 6356.396142366468, 6376.776812811529, 6382.776602818879, 5904.616199947076, 5914.93531164386, 5918.082697181943, 5924.4667979882015, 5927.9703601481715, 3359.8152101634155, 3471.288385880888, 3477.0, 3481.425564781833, 3483.494893240517, 6772.187337519431, 6775.0, 6779.084823548857, 6782.38958493728, 6783.287754785775, 6577.6053436793945, 6584.8024559263295, 6589.341065893373, 6591.736330546821, 6592.110065141144, 6512.185976752906, 6754.662266886636, 6763.5941843489545, 6767.695453704595, 6780.050792888901, 6169.383061693795, 6311.558190926591, 6380.266269379081, 6390.87218255623, 6398.360163983564, 6188.81433556994, 6272.310045895039, 6285.2457705075685, 6294.276158241678, 6307.180066591313, 6778.898316525355, 6842.110525631636, 6849.589024658537, 6853.211880633791, 6855.417289530246, 4311.159323931804, 4468.21806183923, 4502.797374118107, 4503.662225333179, 4505.166544189336, 6359.17330747, 6376.808695739135, 6380.170577824853, 6386.16979792624, 6392.977123660192, 6235.594686345373, 6242.719077641608, 6245.250569931637, 6248.937510624835, 6250.156228909221, 6068.757249709962, 6216.347283535345, 6219.937800622117, 6220.409061139185, 6230.43926046658, 6123.08153776937, 6126.479249263863, 6136.956717358149, 6195.16365290698, 6198.907016394848, 6300.117983482224, 6320.209973753281, 6321.620702757849, 6352.460040896575, 6390.712417941111, 6086.817395478142, 6140.846478838065, 6160.507159427325, 6190.288116866618, 6191.659458729813], "unit": "score", "name": "prototype.html", "value": 4719.106101689232}, {"lowerIsBetter": false, "replicates": [767.1024900865988, 786.5713186313459, 789.5499565247808, 806.3146325623221, 808.9676412943483, 13406.396712147953, 13573.253471059088, 13590.388432520536, 13591.592252232436, 13596.524121655744, 12355.135140540144, 12908.612741617766, 13034.478620855178, 13089.934550327234, 13101.213927164377, 688.748606758532, 694.9513534052618, 820.2248874813304, 823.4277177361736, 823.6211342782327, 693.4175292754086, 828.8715249136394, 832.1595188859235, 836.1095433363448, 836.8912041434605, 866.3112825303898, 868.7133246028795, 869.1525762381659, 869.7216890595012, 870.5995242188601, 700.0339531446571, 702.9086218791575, 844.6579135450153, 854.0605334132435, 860.2343913916619, 639.6098379988204, 640.6572483721187, 641.5957946493679, 641.8523739539932, 642.4410762636489, 12375.257484550955, 12380.81428778569, 12388.442520086617, 12404.069694772928, 12485.875141248562, 12597.118201725883, 12768.553100641526, 12810.0, 13279.73440531184, 13280.136791108547, 10472.895271047344, 10606.416647084407, 10628.840567391495, 10965.61620343284, 11170.888291117148, 3609.530761001079, 3647.708183345326, 3684.392075307571, 3782.092297848524, 3784.924301513982, 49450.50549494531, 49730.50269497295, 49768.0, 49848.0, 51128.58635497869, 9195.218406435393, 9494.810103797885, 9543.952280238693, 9721.805563888682, 9728.756781080388, 17795.644087118184, 17871.463856084338, 17888.91055544714, 17908.641827163643, 17948.910255448638, 7561.697532098765, 7730.2656247657505, 7770.766876993699, 7777.455578109591, 7820.217978202248, 4280.272353699878, 4303.289957157097, 4336.9132617348105, 4376.102898905717, 4423.756693381895, 3194.8722051117693, 3214.51782232667, 3218.5815843940136, 3229.9031029069165, 3230.2570408806105, 585.4321308330913, 602.4698265526309, 603.1766638538363, 604.145134634496, 613.487737738984, 504.3356922156868, 545.0, 596.5815875035981, 669.8760729265101, 702.3924305475726, 8832.470051796912, 8841.69054083104, 8981.595828187747, 9079.273658107335, 9198.356115071882, 554.0138652662155, 617.7992152550349, 648.6562122075213, 652.3443938841434, 657.0899304463353, 3936.291467535871, 4049.8380064797666, 4098.672106231554, 4111.8972025699595, 4128.318827393507, 57224.0, 57354.71322643443, 57660.423395766345, 57747.0, 60929.0, 47410.762946185045, 48293.517064829604, 52575.0, 53958.730206348715, 54015.72992135014, 45044.0, 45366.0, 47096.29355559669, 49274.75362623164, 49296.75351623219, 8633.6978205765, 8877.511736854276, 8989.595468203815, 9093.181613654802, 9181.54092295396, 33044.1738956528, 33423.33153336968, 33441.83279083589, 33682.3263534723, 33688.66311336855, 39702.404463932486, 42813.14373712446, 42964.35553466638, 43397.132057359304, 43984.0, 11215.551377945118, 11494.0, 11569.768604627692, 11630.6510804676, 11763.416978322875, 11971.221870578385, 12012.63962081139, 12075.456604452645, 12810.615681529569, 12825.743485130432, 11758.588449404571, 11789.882101179222, 11792.0, 12240.816387754012, 12287.815682764944, 11203.15976301797, 11259.549618015515, 11320.943395282971, 11747.177697561088, 11981.64055078349, 10767.246292759432, 10989.884536656084, 11004.889951100387, 11028.117750580095, 11581.942090289831, 9187.631001159998, 9216.329524168466, 9283.86074208901, 9297.20466105697, 9442.669506567237, 9222.262219022596, 9574.138327550554, 9659.227261818896, 9692.951535242279, 9718.465484398426], "unit": "score", "name": "yui.html", "value": 6314.768100264426}], "name": "dromaeo_css", "value": 6843.600172168397}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 105.0, 109.0, 108.0, 109.0, 111.0, 110.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [162.0, 126.0, 161.0, 165.0, 127.0, 156.0, 153.0, 128.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 160.0, 160.0, 161.0, 161.0, 159.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 157.0, 73.0, 72.0, 76.0, 73.0, 148.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 139.0, 95.0, 96.0, 96.0, 146.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 104.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 57.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 82.0, 83.0, 83.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 120.0, 112.0, 118.0, 111.0, 120.0, 121.0, 118.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 147.0, 141.0, 142.0, 132.0, 141.0, 142.0, 140.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 64.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1496.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [189.25056775170324], "unit": "score", "name": "DeltaBlue", "value": 349.36751200000015}, {"lowerIsBetter": false, "replicates": [281.7695125387433], "unit": "score", "name": "Encrypt", "value": 944.6763689999997}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1142.6940639269405], "unit": "score", "name": "RayTrace", "value": 647.5827812187812}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [42583.333333333336], "unit": "score", "name": "RegExp", "value": 21.392994129158513}, {"lowerIsBetter": false, "replicates": [635.3240152477764], "unit": "score", "name": "Splay", "value": 128.26683399999996}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 19839.73108280313}]} 06:07:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19839.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1496.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6843.60"}}} 06:07:32 INFO - Return code: 0 06:07:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:07:32 INFO - # TBPL SUCCESS # 06:07:32 INFO - Running post-action listener: _resource_record_post_action 06:07:32 INFO - Running post-run listener: _resource_record_post_run 06:07:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 541585408; Read time: 48; Write time: 528188 06:07:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237338624; Read time: 0; Write time: 305036 06:07:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 16384; Write bytes: 304246784; Read time: 48; Write time: 223152 06:07:33 INFO - Running post-run listener: _upload_blobber_files 06:07:33 INFO - Blob upload gear active. 06:07:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:07:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:07:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:07:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:07:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:35 INFO - (blobuploader) - INFO - Done attempting. 06:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:35 INFO - (blobuploader) - INFO - Done attempting. 06:07:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:35 INFO - Return code: 0 06:07:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:07:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9339e2554ffc6ec98c0c965af60e2171e8780922974267332c16cd9f199627221eeca5f99dd6e2581372cd93314627c9aa8f1860ff7238228afa72d013efb1b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56d38897204e68186ed1716b158138ec96970a10b1c1d6f6c8d6af5baff7005b71b3e2ee454ce59f01db06afc2d56c2ceafde06b2a6a4cb08f2e86682b62d1bd"} 06:07:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:07:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:07:35 INFO - Contents: 06:07:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9339e2554ffc6ec98c0c965af60e2171e8780922974267332c16cd9f199627221eeca5f99dd6e2581372cd93314627c9aa8f1860ff7238228afa72d013efb1b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56d38897204e68186ed1716b158138ec96970a10b1c1d6f6c8d6af5baff7005b71b3e2ee454ce59f01db06afc2d56c2ceafde06b2a6a4cb08f2e86682b62d1bd"} 06:07:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:35 INFO - Copying logs to upload dir... 06:07:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:07:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.093676 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-19 06:07:35.919524) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 06:07:35.923046) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9339e2554ffc6ec98c0c965af60e2171e8780922974267332c16cd9f199627221eeca5f99dd6e2581372cd93314627c9aa8f1860ff7238228afa72d013efb1b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56d38897204e68186ed1716b158138ec96970a10b1c1d6f6c8d6af5baff7005b71b3e2ee454ce59f01db06afc2d56c2ceafde06b2a6a4cb08f2e86682b62d1bd"} build_url:https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/cctg1QTUS8KRZRNaEiIqRg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9339e2554ffc6ec98c0c965af60e2171e8780922974267332c16cd9f199627221eeca5f99dd6e2581372cd93314627c9aa8f1860ff7238228afa72d013efb1b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56d38897204e68186ed1716b158138ec96970a10b1c1d6f6c8d6af5baff7005b71b3e2ee454ce59f01db06afc2d56c2ceafde06b2a6a4cb08f2e86682b62d1bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 06:07:35.950390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 06:07:35.950729) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453208678.718280-449061620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 06:07:36.031303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 06:07:36.031607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 06:07:36.034924) ========= ========= Total master_lag: 0.28 =========