builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1451912125.51 results: success (0) buildid: 20160104023003 builduid: cdeb86d5db1b42cf845179e2a068e9b7 revision: 8060449a6dd05e89690e957c1e88230c6ff6e1d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.510200) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.510654) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.510940) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006054 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.579930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.580240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.630498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.630757) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004333 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.682634) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.682910) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.683259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.683554) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 04:55:25-- 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.8M=0s 2016-01-04 04:55:25 (84.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.847292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.847584) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004341 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.898860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.899162) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8060449a6dd05e89690e957c1e88230c6ff6e1d4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8060449a6dd05e89690e957c1e88230c6ff6e1d4 --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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 04:55:25,978 truncating revision to first 12 chars 2016-01-04 04:55:25,978 Setting DEBUG logging. 2016-01-04 04:55:25,978 attempt 1/10 2016-01-04 04:55:25,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8060449a6dd0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 04:55:26,598 unpacking tar archive at: fx-team-8060449a6dd0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.828670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.828975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.835872) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.836147) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.836568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-04 04:55:26.836845) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:55:27 INFO - MultiFileLogger online at 20160104 04:55:27 in /builds/slave/test-pgo 04:55:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:55:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:55:27 INFO - {'append_to_log': False, 04:55:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:55:27 INFO - 'blob_upload_branch': 'Fx-Team', 04:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:55:27 INFO - 'branch': 'Fx-Team', 04:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:27 INFO - 'config_files': ('talos/linux_config.py',), 04:55:27 INFO - 'default_actions': ('clobber', 04:55:27 INFO - 'read-buildbot-config', 04:55:27 INFO - 'download-and-extract', 04:55:27 INFO - 'populate-webroot', 04:55:27 INFO - 'create-virtualenv', 04:55:27 INFO - 'install', 04:55:27 INFO - 'run-tests'), 04:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:27 INFO - 'download_minidump_stackwalk': True, 04:55:27 INFO - 'download_symbols': 'ondemand', 04:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:27 INFO - 'installer_path': 'installer.exe', 04:55:27 INFO - 'log_level': 'info', 04:55:27 INFO - 'log_name': 'talos', 04:55:27 INFO - 'log_to_console': True, 04:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:55:27 INFO - 'opt_config_files': (), 04:55:27 INFO - 'pip_index': False, 04:55:27 INFO - 'sps_profile': False, 04:55:27 INFO - 'sps_profile_interval': 0, 04:55:27 INFO - 'suite': 'dromaeojs-e10s', 04:55:27 INFO - 'system_bits': '32', 04:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:27 INFO - 'title': 'talos-linux64-ix-051', 04:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:27 INFO - 'use_talos_json': True, 04:55:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:27 INFO - 'work_dir': 'build'} 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running clobber step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: clobber 04:55:27 INFO - rmtree: /builds/slave/test-pgo/build 04:55:27 INFO - Running post-action listener: _resource_record_post_action 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running read-buildbot-config step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: read_buildbot_config 04:55:27 INFO - Using buildbot properties: 04:55:27 INFO - { 04:55:27 INFO - "project": "", 04:55:27 INFO - "product": "firefox", 04:55:27 INFO - "script_repo_revision": "production", 04:55:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:55:27 INFO - "repository": "", 04:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:55:27 INFO - "buildid": "20160104023003", 04:55:27 INFO - "pgo_build": "True", 04:55:27 INFO - "basedir": "/builds/slave/test-pgo", 04:55:27 INFO - "buildnumber": 119, 04:55:27 INFO - "slavename": "talos-linux64-ix-051", 04:55:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:55:27 INFO - "platform": "ubuntu64_hw", 04:55:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:55:27 INFO - "branch": "fx-team", 04:55:27 INFO - "repo_path": "integration/fx-team", 04:55:27 INFO - "revision": "8060449a6dd05e89690e957c1e88230c6ff6e1d4", 04:55:27 INFO - "stage_platform": "linux64-pgo", 04:55:27 INFO - "builduid": "cdeb86d5db1b42cf845179e2a068e9b7", 04:55:27 INFO - "slavebuilddir": "test" 04:55:27 INFO - } 04:55:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:55:27 INFO - Running post-action listener: _resource_record_post_action 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running download-and-extract step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: download_and_extract 04:55:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:55:27 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')]} 04:55:27 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json 04:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json 04:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:55:31 INFO - Downloaded 1302 bytes. 04:55:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:55:31 INFO - Using the following test package requirements: 04:55:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:55:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'jsshell-linux-x86_64.zip'], 04:55:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:55:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:55:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:55:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:55:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:55:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:55:31 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')]} 04:55:31 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:43 INFO - Downloaded 23199260 bytes. 04:55:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:55:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:55:45 INFO - Return code: 0 04:55:45 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 04:55:45 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')]} 04:55:45 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:48 INFO - Downloaded 23199260 bytes. 04:55:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:55:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:55:49 INFO - Return code: 0 04:55:49 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')]} 04:55:49 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:50 INFO - Downloaded 11132285 bytes. 04:55:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:55:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:55:50 INFO - Return code: 0 04:55:50 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')]} 04:55:50 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:55:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:51 INFO - Downloaded 54978014 bytes. 04:55:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:51 INFO - mkdir: /builds/slave/test-pgo/properties 04:55:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:55:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:55:51 INFO - Contents: 04:55:51 INFO - build_url:https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:51 INFO - Running post-action listener: _resource_record_post_action 04:55:51 INFO - Running post-action listener: set_extra_try_arguments 04:55:51 INFO - ##### 04:55:51 INFO - ##### Running populate-webroot step. 04:55:51 INFO - ##### 04:55:51 INFO - Running pre-action listener: _resource_record_pre_action 04:55:51 INFO - Running main action method: populate_webroot 04:55:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:51 INFO - '--tppagecycles', 04:55:51 INFO - '7'], 04:55:51 INFO - 'tests': ['tsvgm']}}, 04:55:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:55:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:55:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:55:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'tests': ['damp', 'tps']}, 04:55:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['damp', 'tps']}, 04:55:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:55:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:51 INFO - 'other': {'tests': ['a11yr', 04:55:51 INFO - 'ts_paint', 04:55:51 INFO - 'tpaint', 04:55:51 INFO - 'sessionrestore', 04:55:51 INFO - 'sessionrestore_no_auto_restore']}, 04:55:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['a11yr', 04:55:51 INFO - 'ts_paint', 04:55:51 INFO - 'tpaint', 04:55:51 INFO - 'sessionrestore', 04:55:51 INFO - 'sessionrestore_no_auto_restore']}, 04:55:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['a11yr', 04:55:51 INFO - 'ts_paint', 04:55:51 INFO - 'tpaint', 04:55:51 INFO - 'sessionrestore', 04:55:51 INFO - 'sessionrestore_no_auto_restore']}, 04:55:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['a11yr', 04:55:51 INFO - 'ts_paint', 04:55:51 INFO - 'tpaint', 04:55:51 INFO - 'sessionrestore', 04:55:51 INFO - 'sessionrestore_no_auto_restore']}, 04:55:51 INFO - 'other_l64': {'tests': ['a11yr', 04:55:51 INFO - 'ts_paint', 04:55:51 INFO - 'tpaint', 04:55:51 INFO - 'sessionrestore', 04:55:51 INFO - 'sessionrestore_no_auto_restore']}, 04:55:51 INFO - 'other_nol64': {'tests': ['a11yr', 04:55:51 INFO - 'ts_paint', 04:55:51 INFO - 'tpaint', 04:55:51 INFO - 'sessionrestore', 04:55:51 INFO - 'sessionrestore_no_auto_restore']}, 04:55:51 INFO - 'svgr': {'tests': ['tsvgx', 04:55:51 INFO - 'tsvgr_opacity', 04:55:51 INFO - 'tart', 04:55:51 INFO - 'tscrollx', 04:55:51 INFO - 'cart']}, 04:55:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['tsvgx', 04:55:51 INFO - 'tsvgr_opacity', 04:55:51 INFO - 'tart', 04:55:51 INFO - 'tscrollx', 04:55:51 INFO - 'cart']}, 04:55:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'tests': ['tp5o']}, 04:55:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'talos_options': ['--e10s'], 04:55:51 INFO - 'tests': ['tp5o']}, 04:55:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'talos_options': ['--xperf_path', 04:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:51 INFO - 'tests': ['tp5n']}, 04:55:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:51 INFO - 'talos_options': ['--e10s', 04:55:51 INFO - '--xperf_path', 04:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:51 INFO - 'tests': ['tp5n']}}, 04:55:51 INFO - 'talos.zip': {'path': '', 04:55:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:51 INFO - Running post-action listener: _resource_record_post_action 04:55:51 INFO - ##### 04:55:51 INFO - ##### Running create-virtualenv step. 04:55:51 INFO - ##### 04:55:51 INFO - Running pre-action listener: _resource_record_pre_action 04:55:51 INFO - Running main action method: create_virtualenv 04:55:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:55:51 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 04:55:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:55:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:51 INFO - Using real prefix '/usr' 04:55:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:55:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:54 INFO - Installing pip.................done. 04:55:54 INFO - Return code: 0 04:55:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:55:54 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')]} 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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')]} 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:55:54 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 04:55:54 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 04:55:54 INFO - Using env: {'DISPLAY': ':0', 04:55:54 INFO - 'HOME': '/home/cltbld', 04:55:54 INFO - 'LANG': 'en_US.UTF-8', 04:55:54 INFO - 'LANGUAGE': 'en_US:en', 04:55:54 INFO - 'LOGNAME': 'cltbld', 04:55:54 INFO - 'MAIL': '/var/mail/cltbld', 04:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:54 INFO - 'MOZ_NO_REMOTE': '1', 04:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:54 INFO - 'NO_EM_RESTART': '1', 04:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:54 INFO - 'SHELL': '/bin/bash', 04:55:54 INFO - 'SHLVL': '1', 04:55:54 INFO - 'TERM': 'linux', 04:55:54 INFO - 'TMOUT': '86400', 04:55:54 INFO - 'USER': 'cltbld', 04:55:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:54 INFO - '_': '/tools/buildbot/bin/python'} 04:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:54 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 04:55:54 INFO - Cleaning up... 04:55:54 INFO - Return code: 0 04:55:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:55:54 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')]} 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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')]} 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:55:54 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 04:55:54 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 04:55:54 INFO - Using env: {'DISPLAY': ':0', 04:55:54 INFO - 'HOME': '/home/cltbld', 04:55:54 INFO - 'LANG': 'en_US.UTF-8', 04:55:54 INFO - 'LANGUAGE': 'en_US:en', 04:55:54 INFO - 'LOGNAME': 'cltbld', 04:55:54 INFO - 'MAIL': '/var/mail/cltbld', 04:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:54 INFO - 'MOZ_NO_REMOTE': '1', 04:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:54 INFO - 'NO_EM_RESTART': '1', 04:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:54 INFO - 'SHELL': '/bin/bash', 04:55:54 INFO - 'SHLVL': '1', 04:55:54 INFO - 'TERM': 'linux', 04:55:54 INFO - 'TMOUT': '86400', 04:55:54 INFO - 'USER': 'cltbld', 04:55:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:54 INFO - '_': '/tools/buildbot/bin/python'} 04:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:55 INFO - Downloading/unpacking psutil>=0.7.1 04:55:55 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 04:55:55 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 04:55:55 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 04:55:55 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 04:55:55 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 04:55:55 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 04:55:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:55:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:57 INFO - Installing collected packages: psutil 04:55:57 INFO - Running setup.py install for psutil 04:55:57 INFO - building 'psutil._psutil_linux' extension 04:55:57 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 04:55:58 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 04:55:58 INFO - building 'psutil._psutil_posix' extension 04:55:58 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 04:55:58 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 04:55:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:58 INFO - Successfully installed psutil 04:55:58 INFO - Cleaning up... 04:55:58 INFO - Return code: 0 04:55:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:55: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')]} 04:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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', '--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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:55:58 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 04:55:58 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 04:55:58 INFO - Using env: {'DISPLAY': ':0', 04:55:58 INFO - 'HOME': '/home/cltbld', 04:55:58 INFO - 'LANG': 'en_US.UTF-8', 04:55:58 INFO - 'LANGUAGE': 'en_US:en', 04:55:58 INFO - 'LOGNAME': 'cltbld', 04:55:58 INFO - 'MAIL': '/var/mail/cltbld', 04:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:58 INFO - 'MOZ_NO_REMOTE': '1', 04:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:58 INFO - 'NO_EM_RESTART': '1', 04:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:58 INFO - 'SHELL': '/bin/bash', 04:55:58 INFO - 'SHLVL': '1', 04:55:58 INFO - 'TERM': 'linux', 04:55:58 INFO - 'TMOUT': '86400', 04:55:58 INFO - 'USER': 'cltbld', 04:55:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:58 INFO - '_': '/tools/buildbot/bin/python'} 04:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:56:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:56:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:56:00 INFO - Installing collected packages: mozsystemmonitor 04:56:00 INFO - Running setup.py install for mozsystemmonitor 04:56:00 INFO - Successfully installed mozsystemmonitor 04:56:00 INFO - Cleaning up... 04:56:01 INFO - Return code: 0 04:56:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:56: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')]} 04:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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', '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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:56: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:56: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 blobuploader==1.2.4 04:56:01 INFO - Using env: {'DISPLAY': ':0', 04:56:01 INFO - 'HOME': '/home/cltbld', 04:56:01 INFO - 'LANG': 'en_US.UTF-8', 04:56:01 INFO - 'LANGUAGE': 'en_US:en', 04:56:01 INFO - 'LOGNAME': 'cltbld', 04:56:01 INFO - 'MAIL': '/var/mail/cltbld', 04:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:01 INFO - 'MOZ_NO_REMOTE': '1', 04:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:01 INFO - 'NO_EM_RESTART': '1', 04:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:01 INFO - 'SHELL': '/bin/bash', 04:56:01 INFO - 'SHLVL': '1', 04:56:01 INFO - 'TERM': 'linux', 04:56:01 INFO - 'TMOUT': '86400', 04:56:01 INFO - 'USER': 'cltbld', 04:56:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:01 INFO - '_': '/tools/buildbot/bin/python'} 04:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:56:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:56:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:56:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56:03 INFO - Downloading docopt-0.6.1.tar.gz 04:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:56:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:03 INFO - Running setup.py install for blobuploader 04:56:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:56:03 INFO - Running setup.py install for requests 04:56:04 INFO - Running setup.py install for docopt 04:56:04 INFO - Successfully installed blobuploader requests docopt 04:56:04 INFO - Cleaning up... 04:56:04 INFO - Return code: 0 04:56:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:56:04 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')]} 04:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:04 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')]} 04:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:04 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:56:04 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 04:56:04 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 04:56:04 INFO - Using env: {'DISPLAY': ':0', 04:56:04 INFO - 'HOME': '/home/cltbld', 04:56:04 INFO - 'LANG': 'en_US.UTF-8', 04:56:04 INFO - 'LANGUAGE': 'en_US:en', 04:56:04 INFO - 'LOGNAME': 'cltbld', 04:56:04 INFO - 'MAIL': '/var/mail/cltbld', 04:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:04 INFO - 'MOZ_NO_REMOTE': '1', 04:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:04 INFO - 'NO_EM_RESTART': '1', 04:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:04 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:04 INFO - 'SHELL': '/bin/bash', 04:56:04 INFO - 'SHLVL': '1', 04:56:04 INFO - 'TERM': 'linux', 04:56:04 INFO - 'TMOUT': '86400', 04:56:04 INFO - 'USER': 'cltbld', 04:56:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:04 INFO - '_': '/tools/buildbot/bin/python'} 04:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:56:04 INFO - Running setup.py (path:/tmp/pip-NgsafX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:56:04 INFO - Running setup.py (path:/tmp/pip-GY5SKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:56:04 INFO - Running setup.py (path:/tmp/pip-x8_h2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:56:04 INFO - Running setup.py (path:/tmp/pip-2j6sRJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:56:04 INFO - Running setup.py (path:/tmp/pip-ZD2mAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:56:04 INFO - Running setup.py (path:/tmp/pip-rBYZ8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:56:05 INFO - Running setup.py (path:/tmp/pip-EctE5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:56:05 INFO - Running setup.py (path:/tmp/pip-sacEEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:56:05 INFO - Running setup.py (path:/tmp/pip-xwijl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:56:05 INFO - Running setup.py (path:/tmp/pip-ofuES9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:56:05 INFO - Running setup.py (path:/tmp/pip-g4r7BB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:56:05 INFO - Running setup.py (path:/tmp/pip-uQ9yFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:56:05 INFO - Running setup.py (path:/tmp/pip-9x0yPT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:56:05 INFO - Running setup.py (path:/tmp/pip-sMpPVW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:56:05 INFO - Running setup.py (path:/tmp/pip-9L8J4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:56:05 INFO - Running setup.py (path:/tmp/pip-M8sRlt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:56:05 INFO - Running setup.py (path:/tmp/pip-dEwP6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:56:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:05 INFO - Running setup.py install for manifestparser 04:56:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:56:05 INFO - Running setup.py install for mozcrash 04:56:05 INFO - Running setup.py install for mozdebug 04:56:06 INFO - Running setup.py install for mozdevice 04:56:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Running setup.py install for mozfile 04:56:06 INFO - Running setup.py install for mozhttpd 04:56:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Running setup.py install for mozinfo 04:56:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Running setup.py install for mozInstall 04:56:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Running setup.py install for mozleak 04:56:06 INFO - Running setup.py install for mozlog 04:56:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Running setup.py install for moznetwork 04:56:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:56:06 INFO - Running setup.py install for mozprocess 04:56:07 INFO - Running setup.py install for mozprofile 04:56:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:56:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:56:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:56:07 INFO - Running setup.py install for mozrunner 04:56:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:56:07 INFO - Running setup.py install for mozscreenshot 04:56:07 INFO - Running setup.py install for moztest 04:56:07 INFO - Running setup.py install for mozversion 04:56:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:56:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:07 INFO - Cleaning up... 04:56:07 INFO - Return code: 0 04:56:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:56:07 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')]} 04:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:07 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')]} 04:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:07 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:56:07 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 04:56:07 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 04:56:07 INFO - Using env: {'DISPLAY': ':0', 04:56:07 INFO - 'HOME': '/home/cltbld', 04:56:07 INFO - 'LANG': 'en_US.UTF-8', 04:56:07 INFO - 'LANGUAGE': 'en_US:en', 04:56:07 INFO - 'LOGNAME': 'cltbld', 04:56:07 INFO - 'MAIL': '/var/mail/cltbld', 04:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:07 INFO - 'MOZ_NO_REMOTE': '1', 04:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:07 INFO - 'NO_EM_RESTART': '1', 04:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:07 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:07 INFO - 'SHELL': '/bin/bash', 04:56:07 INFO - 'SHLVL': '1', 04:56:07 INFO - 'TERM': 'linux', 04:56:07 INFO - 'TMOUT': '86400', 04:56:07 INFO - 'USER': 'cltbld', 04:56:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:07 INFO - '_': '/tools/buildbot/bin/python'} 04:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:56:07 INFO - Running setup.py (path:/tmp/pip-2EWCyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:56:07 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)) 04:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:56:07 INFO - Running setup.py (path:/tmp/pip-KUC4eO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:56:07 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)) 04:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:56:07 INFO - Running setup.py (path:/tmp/pip-2hBW3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:56:07 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)) 04:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:56:07 INFO - Running setup.py (path:/tmp/pip-rduizu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:56:08 INFO - Running setup.py (path:/tmp/pip-gObqvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:56:08 INFO - Running setup.py (path:/tmp/pip-zcZ4o0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:56:08 INFO - Running setup.py (path:/tmp/pip-G00OUT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:56:08 INFO - Running setup.py (path:/tmp/pip-uJqJEY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:56:08 INFO - Running setup.py (path:/tmp/pip-V4KmYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:56:08 INFO - Running setup.py (path:/tmp/pip-4wBO87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:56:08 INFO - Running setup.py (path:/tmp/pip-TUXZpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:56:08 INFO - Running setup.py (path:/tmp/pip-J4UARG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:56:08 INFO - Running setup.py (path:/tmp/pip-VwTg6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:56:08 INFO - Running setup.py (path:/tmp/pip-yQryGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:56:08 INFO - Running setup.py (path:/tmp/pip-bmfgxy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:56:08 INFO - Running setup.py (path:/tmp/pip-lERdAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:56:08 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)) 04:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:56:08 INFO - Running setup.py (path:/tmp/pip-LtUM8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:56:08 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)) 04:56:08 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)) 04:56:08 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)) 04:56:08 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)) 04:56:08 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:08 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:08 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:11 INFO - Downloading blessings-1.5.1.tar.gz 04:56:11 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 04:56:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:11 INFO - Installing collected packages: blessings 04:56:11 INFO - Running setup.py install for blessings 04:56:11 INFO - Successfully installed blessings 04:56:11 INFO - Cleaning up... 04:56:11 INFO - Return code: 0 04:56:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:56:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:56:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:56:12 INFO - Reading from file tmpfile_stdout 04:56:12 INFO - Current package versions: 04:56:12 INFO - argparse == 1.2.1 04:56:12 INFO - blessings == 1.5.1 04:56:12 INFO - blobuploader == 1.2.4 04:56:12 INFO - docopt == 0.6.1 04:56:12 INFO - manifestparser == 1.1 04:56:12 INFO - mozInstall == 1.12 04:56:12 INFO - mozcrash == 0.16 04:56:12 INFO - mozdebug == 0.1 04:56:12 INFO - mozdevice == 0.47 04:56:12 INFO - mozfile == 1.2 04:56:12 INFO - mozhttpd == 0.7 04:56:12 INFO - mozinfo == 0.9 04:56:12 INFO - mozleak == 0.1 04:56:12 INFO - mozlog == 3.1 04:56:12 INFO - moznetwork == 0.27 04:56:12 INFO - mozprocess == 0.22 04:56:12 INFO - mozprofile == 0.28 04:56:12 INFO - mozrunner == 6.11 04:56:12 INFO - mozscreenshot == 0.1 04:56:12 INFO - mozsystemmonitor == 0.0 04:56:12 INFO - moztest == 0.7 04:56:12 INFO - mozversion == 1.4 04:56:12 INFO - psutil == 3.1.1 04:56:12 INFO - requests == 1.2.3 04:56:12 INFO - wsgiref == 0.1.2 04:56:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:56:12 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')]} 04:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:12 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')]} 04:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:12 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:56:12 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 04:56:12 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 04:56:12 INFO - Using env: {'DISPLAY': ':0', 04:56:12 INFO - 'HOME': '/home/cltbld', 04:56:12 INFO - 'LANG': 'en_US.UTF-8', 04:56:12 INFO - 'LANGUAGE': 'en_US:en', 04:56:12 INFO - 'LOGNAME': 'cltbld', 04:56:12 INFO - 'MAIL': '/var/mail/cltbld', 04:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:12 INFO - 'MOZ_NO_REMOTE': '1', 04:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:12 INFO - 'NO_EM_RESTART': '1', 04:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:12 INFO - 'SHELL': '/bin/bash', 04:56:12 INFO - 'SHLVL': '1', 04:56:12 INFO - 'TERM': 'linux', 04:56:12 INFO - 'TMOUT': '86400', 04:56:12 INFO - 'USER': 'cltbld', 04:56:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:12 INFO - '_': '/tools/buildbot/bin/python'} 04:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 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)) 04:56:12 INFO - Cleaning up... 04:56:12 INFO - Return code: 0 04:56:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:56:12 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')]} 04:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:12 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')]} 04:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:12 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:56:12 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 04:56:12 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 04:56:12 INFO - Using env: {'DISPLAY': ':0', 04:56:12 INFO - 'HOME': '/home/cltbld', 04:56:12 INFO - 'LANG': 'en_US.UTF-8', 04:56:12 INFO - 'LANGUAGE': 'en_US:en', 04:56:12 INFO - 'LOGNAME': 'cltbld', 04:56:12 INFO - 'MAIL': '/var/mail/cltbld', 04:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:12 INFO - 'MOZ_NO_REMOTE': '1', 04:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:12 INFO - 'NO_EM_RESTART': '1', 04:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:12 INFO - 'SHELL': '/bin/bash', 04:56:12 INFO - 'SHLVL': '1', 04:56:12 INFO - 'TERM': 'linux', 04:56:12 INFO - 'TMOUT': '86400', 04:56:12 INFO - 'USER': 'cltbld', 04:56:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:12 INFO - '_': '/tools/buildbot/bin/python'} 04:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:12 INFO - Downloading/unpacking jsonschema 04:56:12 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 04:56:12 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 04:56:12 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 04:56:12 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 04:56:12 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 04:56:12 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 04:56:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:14 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 04:56:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:56:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:14 INFO - warning: no files found matching '*.txt' 04:56:14 INFO - no previously-included directories found matching 'build' 04:56:14 INFO - no previously-included directories found matching 'dist' 04:56:14 INFO - no previously-included directories found matching '.git*' 04:56:14 INFO - Installing collected packages: jsonschema, functools32 04:56:14 INFO - Running setup.py install for functools32 04:56:14 INFO - warning: no files found matching '*.txt' 04:56:14 INFO - no previously-included directories found matching 'build' 04:56:14 INFO - no previously-included directories found matching 'dist' 04:56:14 INFO - no previously-included directories found matching '.git*' 04:56:14 INFO - Successfully installed jsonschema functools32 04:56:14 INFO - Cleaning up... 04:56:14 INFO - Return code: 0 04:56:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:56:14 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')]} 04:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:14 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')]} 04:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:14 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 0x7f4a35ad8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', '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 04:56:14 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 04:56:14 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 04:56:14 INFO - Using env: {'DISPLAY': ':0', 04:56:14 INFO - 'HOME': '/home/cltbld', 04:56:14 INFO - 'LANG': 'en_US.UTF-8', 04:56:14 INFO - 'LANGUAGE': 'en_US:en', 04:56:14 INFO - 'LOGNAME': 'cltbld', 04:56:14 INFO - 'MAIL': '/var/mail/cltbld', 04:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:14 INFO - 'MOZ_NO_REMOTE': '1', 04:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:14 INFO - 'NO_EM_RESTART': '1', 04:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:14 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:14 INFO - 'SHELL': '/bin/bash', 04:56:14 INFO - 'SHLVL': '1', 04:56:14 INFO - 'TERM': 'linux', 04:56:14 INFO - 'TMOUT': '86400', 04:56:14 INFO - 'USER': 'cltbld', 04:56:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:14 INFO - '_': '/tools/buildbot/bin/python'} 04:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:14 INFO - Downloading/unpacking flake8 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:56:16 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 04:56:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:56:16 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 04:56:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:17 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 04:56:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:56:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:56:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:17 INFO - no previously-included directories found matching 'docs/_build' 04:56:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:56:17 INFO - Running setup.py install for pep8 04:56:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:17 INFO - no previously-included directories found matching 'docs/_build' 04:56:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:56:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:56:17 INFO - Cleaning up... 04:56:17 INFO - Return code: 0 04:56:17 INFO - Running post-action listener: _resource_record_post_action 04:56:17 INFO - Running post-action listener: _start_resource_monitoring 04:56:17 INFO - Starting resource monitoring. 04:56:17 INFO - ##### 04:56:17 INFO - ##### Running install step. 04:56:17 INFO - ##### 04:56:17 INFO - Running pre-action listener: _resource_record_pre_action 04:56:17 INFO - Running main action method: install 04:56:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:56:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:56:17 INFO - Reading from file tmpfile_stdout 04:56:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:56:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:56:17 INFO - Reading from file tmpfile_stdout 04:56:17 INFO - Output received: 04:56:17 INFO - Usage: mozinstall [options] installer 04:56:17 INFO - Options: 04:56:17 INFO - -h, --help show this help message and exit 04:56:17 INFO - -d DEST, --destination=DEST 04:56:17 INFO - Directory to install application into. [default: 04:56:17 INFO - "/builds/slave/test-pgo"] 04:56:17 INFO - --app=APP Application being installed. [default: firefox] 04:56:17 INFO - mkdir: /builds/slave/test-pgo/build/application 04:56:17 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'] 04:56:17 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 04:56:33 INFO - Reading from file tmpfile_stdout 04:56:33 INFO - Output received: 04:56:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:56:33 INFO - Running post-action listener: _resource_record_post_action 04:56:33 INFO - ##### 04:56:33 INFO - ##### Running run-tests step. 04:56:33 INFO - ##### 04:56:33 INFO - Running pre-action listener: _resource_record_pre_action 04:56:33 INFO - Running main action method: run_tests 04:56:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:56:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:56:33 INFO - Python 2.7.3 04:56:33 INFO - Return code: 0 04:56:33 INFO - grabbing minidump binary from tooltool 04:56:33 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')]} 04:56:33 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 0x1dcc660>, '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 0x1dcd560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcda10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:56:33 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 04:56:33 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 04:56:33 INFO - INFO - File linux64-minidump_stackwalk not present in local cache folder /builds/tooltool_cache 04:56:33 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 04:56:34 INFO - INFO - File linux64-minidump_stackwalk fetched from https://api.pub.build.mozilla.org/tooltool/ as /builds/slave/test-pgo/build/tmpiP0z2w 04:56:34 INFO - INFO - File integrity verified, renaming tmpiP0z2w to linux64-minidump_stackwalk 04:56:34 INFO - INFO - Updating local cache /builds/tooltool_cache... 04:56:34 INFO - INFO - Local cache /builds/tooltool_cache updated with linux64-minidump_stackwalk 04:56:34 INFO - Return code: 0 04:56:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:56:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:56:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:56:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:56:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:56:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:56:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:56:35 INFO - Return code: 0 04:56:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 04:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:56:35 INFO - Using env: {'DISPLAY': ':0', 04:56:35 INFO - 'HOME': '/home/cltbld', 04:56:35 INFO - 'LANG': 'en_US.UTF-8', 04:56:35 INFO - 'LANGUAGE': 'en_US:en', 04:56:35 INFO - 'LOGNAME': 'cltbld', 04:56:35 INFO - 'MAIL': '/var/mail/cltbld', 04:56:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:56:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:35 INFO - 'MOZ_NO_REMOTE': '1', 04:56:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:35 INFO - 'NO_EM_RESTART': '1', 04:56:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:56:35 INFO - 'SHELL': '/bin/bash', 04:56:35 INFO - 'SHLVL': '1', 04:56:35 INFO - 'TERM': 'linux', 04:56:35 INFO - 'TMOUT': '86400', 04:56:35 INFO - 'USER': 'cltbld', 04:56:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918', 04:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:35 INFO - '_': '/tools/buildbot/bin/python'} 04:56:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:56:36 INFO - mozversion application_buildid: 20160104023003 04:56:36 INFO - mozversion application_changeset: 8060449a6dd05e89690e957c1e88230c6ff6e1d4 04:56:36 INFO - mozversion application_display_name: Nightly 04:56:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:36 INFO - mozversion application_name: Firefox 04:56:36 INFO - mozversion application_remotingname: firefox 04:56:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:56:36 INFO - mozversion application_vendor: Mozilla 04:56:36 INFO - mozversion application_version: 46.0a1 04:56:36 INFO - mozversion platform_buildid: 20160104023003 04:56:36 INFO - mozversion platform_changeset: 8060449a6dd05e89690e957c1e88230c6ff6e1d4 04:56:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:56:36 INFO - mozversion platform_version: 46.0a1 04:56:36 INFO - using testdate: 1451912196 04:56:36 INFO - actual date: 1451912196 04:56:36 INFO - starting webserver on 'localhost:51971' 04:56:36 INFO - SUITE-START | Running 3 tests 04:56:36 INFO - TEST-START | dromaeo_css 04:56:36 INFO - operating with platform_type : linux_ 04:56:36 INFO - Initialising browser for dromaeo_css test... 04:56:36 INFO - TEST-INFO | started process 4340 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXJYCOl/profile http://localhost:51971/getInfo.html) 04:56:42 INFO - PROCESS | 4340 | __metrics Screen width/height:1600/1200 04:56:42 INFO - PROCESS | 4340 | colorDepth:24 04:56:42 INFO - PROCESS | 4340 | Browser inner width/height: 1024/697 04:56:42 INFO - PROCESS | 4340 | __metrics 04:56:43 INFO - PROCESS | 4340 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:56:43 INFO - TEST-INFO | 4340: exit 0 04:56:43 INFO - Browser initialized. 04:56:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:43 INFO - TEST-INFO | started process 4474 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXJYCOl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:55 INFO - PROCESS | 4474 | RSS: Main: 150294528 04:56:55 INFO - PROCESS | 4474 | 04:57:45 INFO - PROCESS | 4474 | 1451912265390 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] 04:59:54 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:51971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51971/tests/dromaeo/cssquery-ext.html) 04:59:55 INFO - PROCESS | 4474 | RSS: Main: 156827648 04:59:55 INFO - PROCESS | 4474 | 05:02:57 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:51971/tests/dromaeo/cssquery-ext.html (next: http://localhost:51971/tests/dromaeo/cssquery-jquery.html) 05:02:57 INFO - PROCESS | 4474 | RSS: Main: 153657344 05:02:57 INFO - PROCESS | 4474 | 05:05:59 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:51971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51971/tests/dromaeo/cssquery-mootools.html) 05:06:00 INFO - PROCESS | 4474 | RSS: Main: 153391104 05:06:00 INFO - PROCESS | 4474 | 05:09:01 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:51971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51971/tests/dromaeo/cssquery-prototype.html) 05:09:02 INFO - PROCESS | 4474 | RSS: Main: 152887296 05:09:02 INFO - PROCESS | 4474 | 05:12:04 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:51971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51971/tests/dromaeo/cssquery-yui.html) 05:12:05 INFO - PROCESS | 4474 | RSS: Main: 153726976 05:12:05 INFO - PROCESS | 4474 | 05:15:07 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:51971/tests/dromaeo/cssquery-yui.html (next: http://localhost:51971/tests/dromaeo/cssquery-dojo.html) 05:15:08 INFO - PROCESS | 4474 | RSS: Main: 155717632 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | __start_tp_report 05:15:08 INFO - PROCESS | 4474 | _x_x_mozilla_page_load 05:15:08 INFO - PROCESS | 4474 | _x_x_mozilla_page_load_details 05:15:08 INFO - PROCESS | 4474 | |i|pagename|runs| 05:15:08 INFO - PROCESS | 4474 | |0;dojo.html;3159.984200079;3200.5679233303526;3224.2261857154276;3256.3324518473714;3264.885728999484;5211;5365.114756065244;5390.164524498704;5397.811076612319;5401.648892821964;5295.920561191585;5360.356757189143;5442.619016668835;5478.424765399635;5504.834854954348;4846.982133751916;4879.9024019519675;4983.327250821148;4986.002799440108;5059.367579052619;4812.879678008043;4934.481879402647;4953.975230123844;4970.552650261476;5023.346964894558;4864.954034882482;4869.805207791684;4952.33143525623;4968.453470118284;4993.675411098267;4845.563899249085;4847.054824309261;4855.271709243641;4868.391451068616;4896.583790377822;4708.576228139484;4787.880302992453;4814.398200224972;4863.756812159413;4910.950890491085;5145.742712864342;5221.582273418117;5279.60402969775;5286.97356513215;5363.088274993261;5800.216970708942;5832.154337621064;5833.649981001154;5837.532997360201;5842.6202296851;5707.400722924075;5796.2464879565805;5823.184754134425;5851.678157701324;5863.413658634145;5482.91775623366;5489.204065410493;5489.505944465017;5490.862728431781;5493.7802487900435;5972.492338151219;5979.073243647242;6010.579259451796;6013.398660133952;6018.458338749533;5542.972285138549;5637.661740295595;5675.489205971482;5728.112142617901;5815.331236907725;5801.593888427854;5818.389069147678;5825.621334613236;5827.067669172997;5835.9708201458725;5746.655200687972;5799.94200057994;5806;5816.825495235065;5824.388439213906;5634.690092044977;5731.083026715789;5750.108733146285;5825.242718446575;5882.088276317178;4413.646908247332;4414.55854414556;4422.226110430662;4440.045390241114;4476.843310484118;3953.4267531207815;3973.543042550086;3985.4021896715726;3996.9000774980277;4021.3163762160502;5337.919931201035;5341.572674186055;5345.679259244458;5346.8395948121615;5464.480874316933;5778.046622307356;5792.044312688444;5797.449242321973;5818.94181058184;5823.563232757476;5386.057439947994;5388.434214407509;5389.541888939406;5428.511433970962;5435.646682965595;4805.903881922342;4891.5353041461;4895.412550493964;4915.21356582945;4952.430470495867;5972.701364931736;5976.103584462366;5976.342602313742;5982.042873140276;5983.940160598426;5769.048107062287;5823.301203855564;5829.38791426911;5834.824955251349;5871.1486834407915;5835.766569337179;5973.581849270683;6021.608595441282;6033.336333003454;6129.725578588854;5726.885462290647;5736.225609542658;5758.424157584208;5758.683272420057;5771.163181338767;5818.389069147848;5849.3858144894175;5864.120381942743;5915.201447804491;5918.585699001201;5548.916766248591;5652.349979752381;5661.971690141523;5739.598228123991;5768.077107662753;5695.316562012585;5704.686242256716;5713.571482138773;5714.285714285715;5715.685637289989;5401.378841433286;5645.814378980296;5661.886762264649;5687;5691.516221121251;5618.85952851182;5635.211070450058;5778.768849245983;5795.39148389413;5835.649861008353;5590.357108932525;5628.915566266591;5636.689982051026;5642.407547207484;5654.85862853432 05:15:08 INFO - PROCESS | 4474 | |1;ext.html;529.0503546134688;543.8585967648413;559.2115117684065;566.6147020026385;568.3549171690136;34153.487697684526;34758.826205868936;34761.82619086901;34801.47797783032;34883.82558087209;34561;34653.82673086637;35043.82478087612;35068.82465587675;35649.82175089127;8196.3033142183;8237;8287.875681864776;8319.875201871977;8327.708530201444;7982.680692772282;8153.836923261531;8210.137935516774;8214.753557393287;8335.708250211244;8158.061822890355;8167.67329306827;8224.588770561479;8255.628496717662;8262.17378262175;8184.6316915738635;8279.296259817922;8292.17078292172;8308;8329.958350208271;8170.836583268361;8179.100298967109;8254.339652827759;8283.337333013344;8323.875141872877;35533.93398198058;36260.456093158624;36406.63593364059;36427;36444.45333320002;3020.9244768880953;3176.4600017996995;3279.868805247811;3476.7913925164316;3519.6128425873135;28627.284317892012;28679.56980645292;28933.42133157346;28967.42065158706;29719.405611887858;3884.9805750971063;3886.145048089416;3932.233214523169;3998.900027499307;4004;248731;249892;250093;251091.99999999817;251577;40732;40886.38670419946;41368;41547.7922610385;41669.79165104216;38803;38812.80593597014;38897;38923.80538097348;39114.21771564553;13040.087193896527;13070.869291306964;13091.803622945663;13169.604911852659;13173.47306107764;11328.603498877499;11367.09063274936;11381.317120972768;11454.713632159262;11456.54173833054;13875.58373248784;13912.165270083626;13939.930300348433;14014.369353379123;14112.435502579987;5689.175069614883;5701.71491425427;5756.597038207286;5821.825345239565;5905.527557795366;900.9324300677345;922.5663937949154;940.0740270833223;992.9007099290013;996.9850452243222;27240.59139112915;27772.444551109267;28728.71271287302;30029;30672.23319416988;1005.1355833982769;1030.953607087683;1093.8632670916136;1149.5631659969158;1172.8827117288374;14355.64110897215;14519.346629401702;14575.781363279559;14603.561893143222;14642.121472711671;638875;649448;653912;654809;654965;51327;51456.22815657768;51606.74196628993;51695.48304516982;51975;1290.264549206943;1310.5544115000946;1317.6047185844209;1330.946762129504;1351.0812647399862;26918.192454226406;28069.859650701615;28537.14388568263;28683;29670.554941675462;47284.52715472801;48099.75950120227;48143.277850832965;48247.27629085637;48386.5161348382;279059;281156;282272;282350;283137;38467;38794.2241155181;39522.2095558093;40029.79985100056;41009.384859227735;36408;37127;37597.43603845999;37734;38202.61797382102;31571.36857262796;31777.364452711277;32281;32343;32360;32430.513542297358;32554.186145346557;32605;32980.340393192484;33127.66872331342;33272;33387.83306083454;33685.83157084199;34183;34353;29541.409171816875;30681.8465907669;31571.684283156876;31800.204994875312;31949.840250798596;24235;24447.75552244455;25458.236252912444;26905.730942690323;26976.73023269742 05:15:08 INFO - PROCESS | 4474 | |2;jquery.html;352.60684336964283;355.0732587945462;355.4011490638273;355.60350209516383;355.91991801844586;14066.296685165751;14430.567082987502;16420.671586568278;16576;17131.486055418325;15928.203589820521;15931.601709957256;16355.509334719947;16440.177991100427;16444.506664800047;4635.791389387486;4778.784954677048;4803.135435621587;4819.180739274332;4822.180229361;4717.764111794414;5085.669431486942;5216.7391630418515;5291.6031297652635;5310.123829568117;5245.6852588844795;5249.028929648009;5254.448282930294;5265.131253343194;5265.842024739264;5266.34170728659;5280.181571856349;5404.4595540446035;5408.8377348679605;5415.918761218585;5209.895802083937;5213.296205012351;5219.660722053054;5233.790648374061;5310.601704872111;19764.80235197644;20283.391498255078;20650.380488585368;20723.58552828935;20750.48123796902;2087.3842216546154;2141.3254824730316;2230.965283448386;2239.507308392151;2253.3465295064575;9591.328606997513;9652.517374131265;9730.708078757649;9994.750131246705;10081.243906707026;1848.223746026672;1858.6282743451363;1871.8502519798383;1896.3931541906456;1909.0931807391378;59524.70237648784;61600;62519;63118.36881631217;64647.67676161636;9817.950910245403;9824.754381140528;9951.452670103068;9986.700398988041;10046;12456.75086498283;12511.93744031274;12612.873871261354;12687.746245075232;12688;7424.665890034961;7440.516366436164;7444.553326800409;7467.290607392289;7473.663685134182;7090.964545177241;7104.786856394317;7218.242084581148;7223.747168849065;7267.854642907218;4341.39220509129;4350.912981740411;4388.27593447084;4398.956010439919;4405.140997505456;1647.2258038721782;1691.188229649775;1715.2624371520117;1716.5536960390139;1720.028184075993;889.4529864133511;899.9235065019546;919.6367434863191;941.9481928493999;969.1568335547977;15358.385664573516;16411.91794041022;16552.668946621;17116.914415427844;17193.398231061852;867;895.4582477601087;928.3408779766442;936.1434287626881;963.1139351796364;8798.560071996502;9310.72067837966;9373.156415922464;10110.949445252727;10323.587056517805;535929;569515;574316;587519;592839;77283.61358193173;77385;81232.59383703044;81964;82497;1095.8465814785936;1109.0683825586384;1110.4503270880966;1124.2973141786383;1130.2879186112862;15062.246887655792;15189.31648075817;15215;15268.312925918139;15551.300191491184;34973.82513087418;34990.47514287339;35698.643013569534;36139.45790813088;37625.81187094047;45282.77358613186;47103.52896471129;47296.763516182196;48844.511554884;49960.25059624036;9499.952500237454;9643.807123857623;9686.370385924893;9752.804943901225;9769.609215631295;11475.885241147482;15383;17003.829961700223;17341.306347746453;17370.652586947937;14201.502947396792;14412.279386030446;14419.279036048365;14645;14861.182634955181;13545.59363219105;13807.102538334975;13825.446982120602;13852.584422467342;14273.857261427253;13946.721065578835;14109.435622575393;14920.626984325045;15144;15558.533244002698;9156.404833685789;9170.95414522923;9272.165505104573;9301.534923253945;9349.672761453316;14190.29048547589;14575;14589.562313130624;14595.635109122357;15139.772903406678 05:15:08 INFO - PROCESS | 4474 | |3;mootools.html;1371.657085728568;1381.7927310903362;1487.1075757651372;1666.6749983753173;1687.1395588249989;7377.926220737791;7420.925790742091;7482.289182527658;7529.585872776995;7557.659905304261;7581.393488520919;7607.201243869397;7667.194944530827;7675.194104619019;7684.039495063117;2257.0520381439833;2266.002958698176;2267.557826223887;2290.7823756743164;2296.9885150574223;2266.4447210433386;2267.5011497470614;2272.284230467406;2288.199130304397;2317.9884100579475;2185.0822654485155;2203.7575866654656;2234.82121430286;2242.372135801978;2256.4697296135396;2221;2257.0294773247497;2269.9546009079727;2287.3938406322336;2288.6795848581214;2269.217120093565;2299.7700229977036;2301.528186721718;2301.9884900575557;2306.8269879759087;7136.250693677193;7227.241139680363;7241.384482319009;7253.7098516059295;7269.563826170447;4617.076584683077;4698.600618947394;4726;4731.976340118277;4734.455537613184;3093.90718278452;3097.2876238465055;3137.105924811418;3163.4938409854312;3183.0769076967654;1045.9267851250415;1066.306900514664;1074.0601973273385;1083.268793564341;1110.0897264243324;9897.406155630613;10062.647807326708;10151.340162889388;10166.288359814816;10196.133328667147;4067.9796601017397;4072.75563466193;4122.814473348706;4126.938095928564;4127.814248358831;8202.630881610341;8254.504729716236;8322.958385208036;8324.084350721416;8332.416730828905;4561.908761824745;4567.954320456753;4570.040291538748;4586.6789324747615;4589.311603259471;4166.791660416967;4167.4790651168605;4187.916241675211;4198.307279298881;4217.894552636209;3413.8975830725117;3431.4166591679473;3432.5709286339206;3461.8961431157104;3478.3043391321835;1020.7499162705185;1026.4098143567478;1031.3296357367772;1033.1166852341291;1040.599369242832;978.256525040974;1012.594962015185;1026.2867307221409;1120.8991190792867;1283.5186804948144;6866.416354609914;6895.655217239118;6899.137607799025;6913.861722765517;6922.238553759184;1061.2093989977516;1083.8807731149568;1102.9889701103048;1112.8831472695251;1118.4966764955802;5377.0321342158;5510.421405752419;5517.337919449692;5532.197831314437;5567.4432556744005;8569.871451928226;8660.350473714496;8737.912620873836;8744.95627521871;9130.360874738837;8609.053004169537;8629.784255393666;8649.740507784776;8671.176238257356;8705.564721763887;6762.019507171432;6793.490488213404;6812.727490900407;6817.147856517935;6895.069165662571;6909.7581584644295;6928.064711263914;6939.930600693929;6946.2011868635755;6954.130733658293;7983.5209887406945;8346.207110324509;8377.287930525974;8381.287590554628;8430.36772242072;8175.754727358189;8307.08622051586;8309.293710034715;8310.293625041939;8318.584070796314;6685.732570697118;6709.597424154566;6721.193456785217;6733.52865299444;6843.0419741237265;7203.927960720326;7221.447388811431;7249;7302.890456643048;7327.74352897646;6584.176977877765;6618.106555614931;6686.231083425469;6740.561863478858;6760.1549806274215;6350.142730731292;6483.513736469689;6540.149780528501;6678.699458524476;6696.397324240842;6491.48068154537;6516.51126165549;6678.799636010927;6694.4644428444635;6713;5870.970645146747;5882.23530940975;5882.882342353215;5932.288125424977;5961.672108034099;5854.736536855767;5882;5942.257217847769;5949.25634295713;5955.047192449188 05:15:08 INFO - PROCESS | 4474 | |4;prototype.html;337.2327953904866;341.6617548626859;345.4317647469911;349.31011252775755;355.5839667588921;6219.875602487948;6222.502199824009;6250.28121765997;6257.906131408033;6423.164988551482;6234.314225435199;6263.154474145989;6264.404881536247;6282.968585157079;6284.497240220783;4689.835855745049;4709.693869898463;4716.268978308368;4728.40894888139;4733.313669517918;4737.3604563384015;4738.170820106485;4741.8103275868925;4743.051389722053;4748.881277968044;4507.774611269439;4625.051864367797;4646.79089440976;4691.413573303337;4743.976280118594;4615.93076103857;4636.049609829976;4637.65217608679;4654.9069018619775;4679.087577922306;4026.094128820992;4028.536718277406;4031.052702614883;4031.8387264509383;4033.4151548025666;5811.82564523065;5817.185594016841;5833.941660583382;5898.174255604176;5899.174115623816;5277.287566178555;5341.786328546854;5384.757685904144;5427.104527752916;5429.972850135724;6531.640759758211;6588.769393071268;6594.175728033996;6594.406503414716;6613.4709223262025;4502.954970450286;4518.864434066983;4522.502524722311;4529.954700452986;4533.6146427553695;6763.222229443628;6886.827829304308;6947.471556257615;6951.200611929642;6955;4635.304704294315;4639.188142075123;4640.373549570765;4643.837465688753;4651.67438279324;4694.835680751157;4707.811687532529;4710.717356958594;4711.882202944886;4713.505081966413;5472.808451704172;5488.780448782084;5496.31296087989;5496.697681627549;5506.807261745819;6570.244421891448;6635.137432133888;6666.266710661824;6688.398044176048;6688.632125233062;1648.3818568036986;1667.5330907345963;1668.4994501649458;1669.9582510437335;1670.4571014420362;1108.4734750993375;1110.3448965110624;1113.1540029577418;1114.2868564118808;1129.7232178116415;6275.152854364694;6276.309605943343;6280.560360774702;6281.120643109968;6283.7800676976085;6784.525083244224;6787.966060169668;6790.049393084873;6795.490338224653;6845.760398386033;6178.567500275028;6276.623402595859;6280.277768056732;6290.622562646165;6311.905321420182;3717.9070523237137;3738.831752571141;3745.6628903398823;3749.362608356586;3752.924941501209;7090.893636595455;7159.821004474826;7244.818879527948;7269.600171990592;7276.272372762682;6870.828229294308;6973.442124630017;6983.266756990544;7003.859922801617;7038.155421349471;7209.927900721031;7211.206767255598;7217.675204615805;7222.783316500619;7226.530275532074;6787.490938179755;6789.253182149861;6831.98456455337;6836.726530938707;6842.828929276808;6711.959646254838;6785.321467853372;6811.978203269549;6847.281035491202;6867.107276054081;7161.069061022034;7188.964055179691;7226.963865180851;7230.42156627458;7237.710491580277;4583.175028494769;4673.485916549245;4675.99466114787;4681.648876334357;4691.390119284471;6737.393634572912;6901.378875901193;6918;6939.861202776017;6947.131608548932;6614.801555953329;6644.933550664431;6674.566153200027;6684.565503242274;6737.898931515933;6668.199816021915;6684.298148694317;6705.698243579148;6716.966415167893;6732.730690772314;6490.8052758417325;6537.607743535403;6600.07598936159;6601.141851559267;6610.305917878746;6735.259121496533;6743.426808721314;6744;6744.494162937897;6754.290799465985;6410.679466026773;6509.869802603826;6527.445167160845;6533.118029066015;6543.985682219263 05:15:08 INFO - PROCESS | 4474 | |5;yui.html;731.3490993016214;833.2417500074934;833.3749687734199;840.945338552994;877.7410663854164;13234.669133271662;13397.66505837352;13464.326783660814;13477.123986940842;13481.59555213344;12197.451114699837;12327.815082773743;12344.81482777759;12358.567450139248;12518.56185033524;784.8116452051495;796.0487217774762;799.588212070784;802.0215337288498;802.7230605441142;795.5385876191824;805.3355981315409;807.7415227127321;809.4576633655465;812.5815205169342;838.2372041442288;840.5251033166242;842.2293601354753;848.4569875279826;848.4654667559429;825.9752207433787;828.0808302783965;838.9748307550752;839.1943734015322;839.6347588798892;612.2285919741114;613.6992873491956;613.8618810767541;614.124872057321;615.3139249736556;12280.201786883825;12459.93770031144;12502.187357821713;12529.812052819216;12533.623991280276;10608.992145746142;10675.466226688635;10714.785704285949;10716.571337146504;10782.4608769562;9848.409095454295;9874.753131171707;10058.849117263248;10160.085592296655;10258.384496930208;3390.135515443546;3486.511888335635;3491.3715531204375;3572.910677233064;3682.3739964205884;41549.753507394824;41828.58171418277;42402.78798605987;42655.36016959748;43381.3604231451;8720.43317184381;9004.81990360189;9048.683296084606;9098.681546145854;9100.908990910006;17561.38535151289;17694.026828524296;17837.554061148316;18021.459356219333;18029.7295540567;7283;7592.506487078323;7720.3437707795465;7919.960400198077;8007.079185893696;4368.27923392643;4378.737275763465;4398.846040388571;4412.624926881187;4428.889277768081;2969.85150742462;2991.7157870002316;3003.594514740526;3007.804492707967;3008.5938398316384;515.2837555797445;533.2694208933785;534.0627199265265;536.1127334261803;543.8857839853675;527.1986580397773;527.7704198673589;552.2020680117272;631.8294060603612;657.9111570351076;8159.26566609008;8440.66237350499;8547.700830470903;8610.049370918941;8646.610902509403;680.3536640191738;687.2714922182503;689.4139981016197;705.3792662457107;708.7519368221082;3950.9604903951167;4255.97872010638;4266.530681625019;4288.927768057985;4315.84207896052;49620.75189624029;50648.49351506438;50965.49034509682;52164;53134.46865531295;47096.29355559669;47131.764341178074;47383.05233895303;47941.28088078681;48160;43663.78168109203;44073.11853762971;44382.77808610936;44696;44937.999999999345;8726.476411415335;8900.821983560421;9045.728628141167;9082.36423450352;9157.908420915706;33804.66195338015;33965.83017084899;34057.829710851285;34383.312333752685;34528.827355864065;37856.43215351827;40499.190016200104;42600;42761;42932.78533607437;10782.299150555189;10927.508262128382;11083.833742493707;11152.052075573667;11186;11123.610673626385;11418.371989540656;11487.597934072268;11577.247478913843;11656.650300491;10231.28381013322;10486.632967846088;10714.25000249975;11209.383483908463;11242.269252498561;11473.655790326304;11748.706282342668;12056.156069075081;12103.878961210276;12114.818277726017;10786.460676966277;10813.891861081289;10923.289986150874;11349;11726.824097638371;8917.598708058284;9052.54737263121;9088.681896133603;9394.24846012331;9453.149216570542;8950.23922966555;9125.027448944824;9132.49771262587;9310.301727370339;9572.856407153758 05:15:08 INFO - PROCESS | 4474 | __end_tp_report 05:15:08 INFO - PROCESS | 4474 | __start_cc_report 05:15:08 INFO - PROCESS | 4474 | _x_x_mozilla_cycle_collect,323 05:15:08 INFO - PROCESS | 4474 | __end_cc_report 05:15:08 INFO - PROCESS | 4474 | __startTimestamp1451913308016__endTimestamp 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | ------- Summary: start ------- 05:15:08 INFO - PROCESS | 4474 | Number of tests: 6 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | [#0] dojo.html Cycles:165 Average:5382.33 Median:5635.21 stddev:613.52 (10.9%) stddev-sans-first:590.11 05:15:08 INFO - PROCESS | 4474 | Values: 3160.0 3200.6 3224.2 3256.3 3264.9 5211.0 5365.1 5390.2 5397.8 5401.6 5295.9 5360.4 5442.6 5478.4 5504.8 4847.0 4879.9 4983.3 4986.0 5059.4 4812.9 4934.5 4954.0 4970.6 5023.3 4865.0 4869.8 4952.3 4968.5 4993.7 4845.6 4847.1 4855.3 4868.4 4896.6 4708.6 4787.9 4814.4 4863.8 4911.0 5145.7 5221.6 5279.6 5287.0 5363.1 5800.2 5832.2 5833.6 5837.5 5842.6 5707.4 5796.2 5823.2 5851.7 5863.4 5482.9 5489.2 5489.5 5490.9 5493.8 5972.5 5979.1 6010.6 6013.4 6018.5 5543.0 5637.7 5675.5 5728.1 5815.3 5801.6 5818.4 5825.6 5827.1 5836.0 5746.7 5799.9 5806.0 5816.8 5824.4 5634.7 5731.1 5750.1 5825.2 5882.1 4413.6 4414.6 4422.2 4440.0 4476.8 3953.4 3973.5 3985.4 3996.9 4021.3 5337.9 5341.6 5345.7 5346.8 5464.5 5778.0 5792.0 5797.4 5818.9 5823.6 5386.1 5388.4 5389.5 5428.5 5435.6 4805.9 4891.5 4895.4 4915.2 4952.4 5972.7 5976.1 5976.3 5982.0 5983.9 5769.0 5823.3 5829.4 5834.8 5871.1 5835.8 5973.6 6021.6 6033.3 6129.7 5726.9 5736.2 5758.4 5758.7 5771.2 5818.4 5849.4 5864.1 5915.2 5918.6 5548.9 5652.3 5662.0 5739.6 5768.1 5695.3 5704.7 5713.6 5714.3 5715.7 5401.4 5645.8 5661.9 5687.0 5691.5 5618.9 5635.2 5778.8 5795.4 5835.6 5590.4 5628.9 5636.7 5642.4 5654.9 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | [#1] ext.html Cycles:180 Average:52711.26 Median:34963.83 stddev:116791.83 (334.0%) stddev-sans-first:117053.74 05:15:08 INFO - PROCESS | 4474 | Values: 529.1 543.9 559.2 566.6 568.4 34153.5 34758.8 34761.8 34801.5 34883.8 34561.0 34653.8 35043.8 35068.8 35649.8 8196.3 8237.0 8287.9 8319.9 8327.7 7982.7 8153.8 8210.1 8214.8 8335.7 8158.1 8167.7 8224.6 8255.6 8262.2 8184.6 8279.3 8292.2 8308.0 8330.0 8170.8 8179.1 8254.3 8283.3 8323.9 35533.9 36260.5 36406.6 36427.0 36444.5 3020.9 3176.5 3279.9 3476.8 3519.6 28627.3 28679.6 28933.4 28967.4 29719.4 3885.0 3886.1 3932.2 3998.9 4004.0 248731.0 249892.0 250093.0 251092.0 251577.0 40732.0 40886.4 41368.0 41547.8 41669.8 38803.0 38812.8 38897.0 38923.8 39114.2 13040.1 13070.9 13091.8 13169.6 13173.5 11328.6 11367.1 11381.3 11454.7 11456.5 13875.6 13912.2 13939.9 14014.4 14112.4 5689.2 5701.7 5756.6 5821.8 5905.5 900.9 922.6 940.1 992.9 997.0 27240.6 27772.4 28728.7 30029.0 30672.2 1005.1 1031.0 1093.9 1149.6 1172.9 14355.6 14519.3 14575.8 14603.6 14642.1 638875.0 649448.0 653912.0 654809.0 654965.0 51327.0 51456.2 51606.7 51695.5 51975.0 1290.3 1310.6 1317.6 1330.9 1351.1 26918.2 28069.9 28537.1 28683.0 29670.6 47284.5 48099.8 48143.3 48247.3 48386.5 279059.0 281156.0 282272.0 282350.0 283137.0 38467.0 38794.2 39522.2 40029.8 41009.4 36408.0 37127.0 37597.4 37734.0 38202.6 31571.4 31777.4 32281.0 32343.0 32360.0 32430.5 32554.2 32605.0 32980.3 33127.7 33272.0 33387.8 33685.8 34183.0 34353.0 29541.4 30681.8 31571.7 31800.2 31949.8 24235.0 24447.8 25458.2 26905.7 26976.7 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | [#2] jquery.html Cycles:180 Average:29728.41 Median:4369.59 stddev:93515.68 (2140.1%) stddev-sans-first:93752.00 05:15:08 INFO - PROCESS | 4474 | Values: 352.6 355.1 355.4 355.6 355.9 14066.3 14430.6 16420.7 16576.0 17131.5 15928.2 15931.6 16355.5 16440.2 16444.5 4635.8 4778.8 4803.1 4819.2 4822.2 4717.8 5085.7 5216.7 5291.6 5310.1 5245.7 5249.0 5254.4 5265.1 5265.8 5266.3 5280.2 5404.5 5408.8 5415.9 5209.9 5213.3 5219.7 5233.8 5310.6 19764.8 20283.4 20650.4 20723.6 20750.5 2087.4 2141.3 2231.0 2239.5 2253.3 9591.3 9652.5 9730.7 9994.8 10081.2 1848.2 1858.6 1871.9 1896.4 1909.1 59524.7 61600.0 62519.0 63118.4 64647.7 9818.0 9824.8 9951.5 9986.7 10046.0 12456.8 12511.9 12612.9 12687.7 12688.0 7424.7 7440.5 7444.6 7467.3 7473.7 7091.0 7104.8 7218.2 7223.7 7267.9 4341.4 4350.9 4388.3 4399.0 4405.1 1647.2 1691.2 1715.3 1716.6 1720.0 889.5 899.9 919.6 941.9 969.2 15358.4 16411.9 16552.7 17116.9 17193.4 867.0 895.5 928.3 936.1 963.1 8798.6 9310.7 9373.2 10110.9 10323.6 535929.0 569515.0 574316.0 587519.0 592839.0 77283.6 77385.0 81232.6 81964.0 82497.0 1095.8 1109.1 1110.5 1124.3 1130.3 15062.2 15189.3 15215.0 15268.3 15551.3 34973.8 34990.5 35698.6 36139.5 37625.8 45282.8 47103.5 47296.8 48844.5 49960.3 9500.0 9643.8 9686.4 9752.8 9769.6 11475.9 15383.0 17003.8 17341.3 17370.7 14201.5 14412.3 14419.3 14645.0 14861.2 13545.6 13807.1 13825.4 13852.6 14273.9 13946.7 14109.4 14920.6 15144.0 15558.5 9156.4 9171.0 9272.2 9301.5 9349.7 14190.3 14575.0 14589.6 14595.6 15139.8 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | [#3] mootools.html Cycles:180 Average:5218.07 Median:5882.12 stddev:2641.81 (44.9%) stddev-sans-first:2633.40 05:15:08 INFO - PROCESS | 4474 | Values: 1371.7 1381.8 1487.1 1666.7 1687.1 7377.9 7420.9 7482.3 7529.6 7557.7 7581.4 7607.2 7667.2 7675.2 7684.0 2257.1 2266.0 2267.6 2290.8 2297.0 2266.4 2267.5 2272.3 2288.2 2318.0 2185.1 2203.8 2234.8 2242.4 2256.5 2221.0 2257.0 2270.0 2287.4 2288.7 2269.2 2299.8 2301.5 2302.0 2306.8 7136.3 7227.2 7241.4 7253.7 7269.6 4617.1 4698.6 4726.0 4732.0 4734.5 3093.9 3097.3 3137.1 3163.5 3183.1 1045.9 1066.3 1074.1 1083.3 1110.1 9897.4 10062.6 10151.3 10166.3 10196.1 4068.0 4072.8 4122.8 4126.9 4127.8 8202.6 8254.5 8323.0 8324.1 8332.4 4561.9 4568.0 4570.0 4586.7 4589.3 4166.8 4167.5 4187.9 4198.3 4217.9 3413.9 3431.4 3432.6 3461.9 3478.3 1020.7 1026.4 1031.3 1033.1 1040.6 978.3 1012.6 1026.3 1120.9 1283.5 6866.4 6895.7 6899.1 6913.9 6922.2 1061.2 1083.9 1103.0 1112.9 1118.5 5377.0 5510.4 5517.3 5532.2 5567.4 8569.9 8660.4 8737.9 8745.0 9130.4 8609.1 8629.8 8649.7 8671.2 8705.6 6762.0 6793.5 6812.7 6817.1 6895.1 6909.8 6928.1 6939.9 6946.2 6954.1 7983.5 8346.2 8377.3 8381.3 8430.4 8175.8 8307.1 8309.3 8310.3 8318.6 6685.7 6709.6 6721.2 6733.5 6843.0 7203.9 7221.4 7249.0 7302.9 7327.7 6584.2 6618.1 6686.2 6740.6 6760.2 6350.1 6483.5 6540.1 6678.7 6696.4 6491.5 6516.5 6678.8 6694.5 6713.0 5871.0 5882.2 5882.9 5932.3 5961.7 5854.7 5882.0 5942.3 5949.3 5955.0 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | [#4] prototype.html Cycles:180 Average:5534.02 Median:6278.45 stddev:1695.94 (27.0%) stddev-sans-first:1655.24 05:15:08 INFO - PROCESS | 4474 | Values: 337.2 341.7 345.4 349.3 355.6 6219.9 6222.5 6250.3 6257.9 6423.2 6234.3 6263.2 6264.4 6283.0 6284.5 4689.8 4709.7 4716.3 4728.4 4733.3 4737.4 4738.2 4741.8 4743.1 4748.9 4507.8 4625.1 4646.8 4691.4 4744.0 4615.9 4636.0 4637.7 4654.9 4679.1 4026.1 4028.5 4031.1 4031.8 4033.4 5811.8 5817.2 5833.9 5898.2 5899.2 5277.3 5341.8 5384.8 5427.1 5430.0 6531.6 6588.8 6594.2 6594.4 6613.5 4503.0 4518.9 4522.5 4530.0 4533.6 6763.2 6886.8 6947.5 6951.2 6955.0 4635.3 4639.2 4640.4 4643.8 4651.7 4694.8 4707.8 4710.7 4711.9 4713.5 5472.8 5488.8 5496.3 5496.7 5506.8 6570.2 6635.1 6666.3 6688.4 6688.6 1648.4 1667.5 1668.5 1670.0 1670.5 1108.5 1110.3 1113.2 1114.3 1129.7 6275.2 6276.3 6280.6 6281.1 6283.8 6784.5 6788.0 6790.0 6795.5 6845.8 6178.6 6276.6 6280.3 6290.6 6311.9 3717.9 3738.8 3745.7 3749.4 3752.9 7090.9 7159.8 7244.8 7269.6 7276.3 6870.8 6973.4 6983.3 7003.9 7038.2 7209.9 7211.2 7217.7 7222.8 7226.5 6787.5 6789.3 6832.0 6836.7 6842.8 6712.0 6785.3 6812.0 6847.3 6867.1 7161.1 7189.0 7227.0 7230.4 7237.7 4583.2 4673.5 4676.0 4681.6 4691.4 6737.4 6901.4 6918.0 6939.9 6947.1 6614.8 6644.9 6674.6 6684.6 6737.9 6668.2 6684.3 6705.7 6717.0 6732.7 6490.8 6537.6 6600.1 6601.1 6610.3 6735.3 6743.4 6744.0 6744.5 6754.3 6410.7 6509.9 6527.4 6533.1 6544.0 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - PROCESS | 4474 | [#5] yui.html Cycles:180 Average:13009.10 Median:44539.39 stddev:14592.62 (32.8%) stddev-sans-first:14604.43 05:15:08 INFO - PROCESS | 4474 | Values: 731.3 833.2 833.4 840.9 877.7 13234.7 13397.7 13464.3 13477.1 13481.6 12197.5 12327.8 12344.8 12358.6 12518.6 784.8 796.0 799.6 802.0 802.7 795.5 805.3 807.7 809.5 812.6 838.2 840.5 842.2 848.5 848.5 826.0 828.1 839.0 839.2 839.6 612.2 613.7 613.9 614.1 615.3 12280.2 12459.9 12502.2 12529.8 12533.6 10609.0 10675.5 10714.8 10716.6 10782.5 9848.4 9874.8 10058.8 10160.1 10258.4 3390.1 3486.5 3491.4 3572.9 3682.4 41549.8 41828.6 42402.8 42655.4 43381.4 8720.4 9004.8 9048.7 9098.7 9100.9 17561.4 17694.0 17837.6 18021.5 18029.7 7283.0 7592.5 7720.3 7920.0 8007.1 4368.3 4378.7 4398.8 4412.6 4428.9 2969.9 2991.7 3003.6 3007.8 3008.6 515.3 533.3 534.1 536.1 543.9 527.2 527.8 552.2 631.8 657.9 8159.3 8440.7 8547.7 8610.0 8646.6 680.4 687.3 689.4 705.4 708.8 3951.0 4256.0 4266.5 4288.9 4315.8 49620.8 50648.5 50965.5 52164.0 53134.5 47096.3 47131.8 47383.1 47941.3 48160.0 43663.8 44073.1 44382.8 44696.0 44938.0 8726.5 8900.8 9045.7 9082.4 9157.9 33804.7 33965.8 34057.8 34383.3 34528.8 37856.4 40499.2 42600.0 42761.0 42932.8 10782.3 10927.5 11083.8 11152.1 11186.0 11123.6 11418.4 11487.6 11577.2 11656.7 10231.3 10486.6 10714.3 11209.4 11242.3 11473.7 11748.7 12056.2 12103.9 12114.8 10786.5 10813.9 10923.3 11349.0 11726.8 8917.6 9052.5 9088.7 9394.2 9453.1 8950.2 9125.0 9132.5 9310.3 9572.9 05:15:08 INFO - PROCESS | 4474 | -------- Summary: end -------- 05:15:08 INFO - PROCESS | 4474 | 05:15:08 INFO - TEST-INFO | 4474: exit 0 05:15:08 INFO - TEST-OK | dromaeo_css | took 1112704ms 05:15:08 INFO - TEST-START | kraken 05:15:08 INFO - operating with platform_type : linux_ 05:15:08 INFO - Initialising browser for kraken test... 05:15:08 INFO - TEST-INFO | started process 4710 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH_AJwv/profile http://localhost:51971/getInfo.html) 05:15:13 INFO - PROCESS | 4710 | __metrics Screen width/height:1600/1200 05:15:13 INFO - PROCESS | 4710 | colorDepth:24 05:15:13 INFO - PROCESS | 4710 | Browser inner width/height: 1024/697 05:15:13 INFO - PROCESS | 4710 | __metrics 05:15:13 INFO - PROCESS | 4710 | 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:15:14 INFO - TEST-INFO | 4710: exit 0 05:15:14 INFO - Browser initialized. 05:15:14 INFO - Running cycle 1/1 for kraken test... 05:15:14 INFO - TEST-INFO | started process 4831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH_AJwv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:26 INFO - PROCESS | 4831 | RSS: Main: 150630400 05:15:26 INFO - PROCESS | 4831 | 05:15:28 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51971/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:29 INFO - PROCESS | 4831 | RSS: Main: 150999040 05:15:29 INFO - PROCESS | 4831 | 05:15:31 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51971/tests/kraken/driver.html?testName=audio-dft) 05:15:32 INFO - PROCESS | 4831 | RSS: Main: 150265856 05:15:32 INFO - PROCESS | 4831 | 05:15:35 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51971/tests/kraken/driver.html?testName=audio-fft) 05:15:35 INFO - PROCESS | 4831 | RSS: Main: 145682432 05:15:35 INFO - PROCESS | 4831 | 05:15:37 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51971/tests/kraken/driver.html?testName=audio-oscillator) 05:15:38 INFO - PROCESS | 4831 | RSS: Main: 146673664 05:15:38 INFO - PROCESS | 4831 | 05:15:40 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:41 INFO - PROCESS | 4831 | RSS: Main: 146530304 05:15:41 INFO - PROCESS | 4831 | 05:15:44 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51971/tests/kraken/driver.html?testName=imaging-darkroom) 05:15:44 INFO - PROCESS | 4831 | RSS: Main: 147746816 05:15:44 INFO - PROCESS | 4831 | 05:15:48 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51971/tests/kraken/driver.html?testName=imaging-desaturate) 05:15:48 INFO - PROCESS | 4831 | RSS: Main: 149737472 05:15:48 INFO - PROCESS | 4831 | 05:15:51 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51971/tests/kraken/driver.html?testName=json-parse-financial) 05:15:52 INFO - PROCESS | 4831 | RSS: Main: 148377600 05:15:52 INFO - PROCESS | 4831 | 05:15:53 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:54 INFO - PROCESS | 4831 | RSS: Main: 148500480 05:15:54 INFO - PROCESS | 4831 | 05:15:56 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:56 INFO - PROCESS | 4831 | RSS: Main: 148897792 05:15:56 INFO - PROCESS | 4831 | 05:15:59 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:59 INFO - PROCESS | 4831 | RSS: Main: 149299200 05:15:59 INFO - PROCESS | 4831 | 05:16:02 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:03 INFO - PROCESS | 4831 | RSS: Main: 149098496 05:16:03 INFO - PROCESS | 4831 | 05:16:05 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:06 INFO - PROCESS | 4831 | RSS: Main: 149262336 05:16:06 INFO - PROCESS | 4831 | 05:16:07 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:51971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51971/tests/kraken/driver.html?testName=ai-astar) 05:16:08 INFO - PROCESS | 4831 | RSS: Main: 150073344 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | __start_tp_report 05:16:08 INFO - PROCESS | 4831 | _x_x_mozilla_page_load 05:16:08 INFO - PROCESS | 4831 | _x_x_mozilla_page_load_details 05:16:08 INFO - PROCESS | 4831 | |i|pagename|runs| 05:16:08 INFO - PROCESS | 4831 | |0;ai-astar;112;108;111;113;112;123;112;111;112;114 05:16:08 INFO - PROCESS | 4831 | |1;audio-beat-detection;150;122;147;160;129;159;159;127;157;127 05:16:08 INFO - PROCESS | 4831 | |2;audio-dft;166;161;161;161;162;161;161;165;169;161 05:16:08 INFO - PROCESS | 4831 | |3;audio-fft;75;75;72;72;71;77;136;72;71;74 05:16:08 INFO - PROCESS | 4831 | |4;audio-oscillator;96;97;145;96;97;96;139;96;96;141 05:16:08 INFO - PROCESS | 4831 | |5;imaging-gaussian-blur;110;113;110;110;109;111;110;110;110;110 05:16:08 INFO - PROCESS | 4831 | |6;imaging-darkroom;148;148;147;147;147;147;147;147;147;146 05:16:08 INFO - PROCESS | 4831 | |7;imaging-desaturate;97;97;97;96;97;99;96;96;97;97 05:16:08 INFO - PROCESS | 4831 | |8;json-parse-financial;59;59;59;60;60;59;59;70;57;57 05:16:08 INFO - PROCESS | 4831 | |9;json-stringify-tinderbox;67;67;66;67;68;68;66;67;67;67 05:16:08 INFO - PROCESS | 4831 | |10;stanford-crypto-aes;93;85;94;91;93;84;86;88;87;85 05:16:08 INFO - PROCESS | 4831 | |11;stanford-crypto-ccm;119;118;121;127;115;126;141;117;122;132 05:16:08 INFO - PROCESS | 4831 | |12;stanford-crypto-pbkdf2;144;154;154;155;154;143;154;154;152;144 05:16:08 INFO - PROCESS | 4831 | |13;stanford-crypto-sha256-iterative;69;69;71;69;68;68;69;70;68;68 05:16:08 INFO - PROCESS | 4831 | __end_tp_report 05:16:08 INFO - PROCESS | 4831 | __start_cc_report 05:16:08 INFO - PROCESS | 4831 | _x_x_mozilla_cycle_collect,747 05:16:08 INFO - PROCESS | 4831 | __end_cc_report 05:16:08 INFO - PROCESS | 4831 | __startTimestamp1451913368184__endTimestamp 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | ------- Summary: start ------- 05:16:08 INFO - PROCESS | 4831 | Number of tests: 14 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:3.91 (3.5%) stddev-sans-first:4.14 05:16:08 INFO - PROCESS | 4831 | Values: 112.0 108.0 111.0 113.0 112.0 123.0 112.0 111.0 112.0 114.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:153.50 stddev:15.66 (10.2%) stddev-sans-first:16.44 05:16:08 INFO - PROCESS | 4831 | Values: 150.0 122.0 147.0 160.0 129.0 159.0 159.0 127.0 157.0 127.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#2] audio-dft Cycles:10 Average:162.80 Median:161.50 stddev:2.86 (1.8%) stddev-sans-first:2.79 05:16:08 INFO - PROCESS | 4831 | Values: 166.0 161.0 161.0 161.0 162.0 161.0 161.0 165.0 169.0 161.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:19.95 (27.3%) stddev-sans-first:21.10 05:16:08 INFO - PROCESS | 4831 | Values: 75.0 75.0 72.0 72.0 71.0 77.0 136.0 72.0 71.0 74.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:21.97 (22.9%) stddev-sans-first:22.72 05:16:08 INFO - PROCESS | 4831 | Values: 96.0 97.0 145.0 96.0 97.0 96.0 139.0 96.0 96.0 141.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:1.12 05:16:08 INFO - PROCESS | 4831 | Values: 110.0 113.0 110.0 110.0 109.0 111.0 110.0 110.0 110.0 110.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:16:08 INFO - PROCESS | 4831 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 05:16:08 INFO - PROCESS | 4831 | Values: 97.0 97.0 97.0 96.0 97.0 99.0 96.0 96.0 97.0 97.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.00 stddev:3.70 (6.3%) stddev-sans-first:3.91 05:16:08 INFO - PROCESS | 4831 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 59.0 70.0 57.0 57.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:16:08 INFO - PROCESS | 4831 | Values: 67.0 67.0 66.0 67.0 68.0 68.0 66.0 67.0 67.0 67.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.50 stddev:3.81 (4.3%) stddev-sans-first:3.69 05:16:08 INFO - PROCESS | 4831 | Values: 93.0 85.0 94.0 91.0 93.0 84.0 86.0 88.0 87.0 85.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.00 stddev:7.96 (6.4%) stddev-sans-first:8.25 05:16:08 INFO - PROCESS | 4831 | Values: 119.0 118.0 121.0 127.0 115.0 126.0 141.0 117.0 122.0 132.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:154.00 stddev:4.98 (3.2%) stddev-sans-first:4.64 05:16:08 INFO - PROCESS | 4831 | Values: 144.0 154.0 154.0 155.0 154.0 143.0 154.0 154.0 152.0 144.0 05:16:08 INFO - PROCESS | 4831 | 05:16:08 INFO - PROCESS | 4831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 05:16:08 INFO - PROCESS | 4831 | Values: 69.0 69.0 71.0 69.0 68.0 68.0 69.0 70.0 68.0 68.0 05:16:08 INFO - PROCESS | 4831 | -------- Summary: end -------- 05:16:08 INFO - PROCESS | 4831 | 05:16:09 INFO - TEST-INFO | 4831: exit 0 05:16:09 INFO - TEST-OK | kraken | took 60343ms 05:16:09 INFO - TEST-START | v8_7 05:16:09 INFO - operating with platform_type : linux_ 05:16:09 INFO - Initialising browser for v8_7 test... 05:16:09 INFO - TEST-INFO | started process 5123 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4_pegf/profile http://localhost:51971/getInfo.html) 05:16:13 INFO - PROCESS | 5123 | __metrics Screen width/height:1600/1200 05:16:13 INFO - PROCESS | 5123 | colorDepth:24 05:16:13 INFO - PROCESS | 5123 | Browser inner width/height: 1024/697 05:16:13 INFO - PROCESS | 5123 | __metrics 05:16:13 INFO - PROCESS | 5123 | 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:16:14 INFO - TEST-INFO | 5123: exit 0 05:16:14 INFO - Browser initialized. 05:16:14 INFO - Running cycle 1/1 for v8_7 test... 05:16:14 INFO - TEST-INFO | started process 5248 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4_pegf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:26 INFO - PROCESS | 5248 | RSS: Main: 150495232 05:16:26 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | Cycle 1(1): loaded http://localhost:51971/tests/v8_7/run.html (next: http://localhost:51971/tests/v8_7/run.html) 05:16:48 INFO - PROCESS | 5248 | RSS: Main: 145121280 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | __start_tp_report 05:16:48 INFO - PROCESS | 5248 | _x_x_mozilla_page_load 05:16:48 INFO - PROCESS | 5248 | _x_x_mozilla_page_load_details 05:16:48 INFO - PROCESS | 5248 | |i|pagename|runs| 05:16:48 INFO - PROCESS | 5248 | |0;Richards;166.77785190126752 05:16:48 INFO - PROCESS | 5248 | |1;DeltaBlue;188.67924528301887 05:16:48 INFO - PROCESS | 5248 | |2;Encrypt;279.79854504756577 05:16:48 INFO - PROCESS | 5248 | |3;Decrypt;5273.684210526316 05:16:48 INFO - PROCESS | 5248 | |4;RayTrace;1074.1138560687432 05:16:48 INFO - PROCESS | 5248 | |5;Earley;709.7232079488999 05:16:48 INFO - PROCESS | 5248 | |6;Boyer;12419.753086419752 05:16:48 INFO - PROCESS | 5248 | |7;RegExp;25375 05:16:48 INFO - PROCESS | 5248 | |8;Splay;674.8071979434447 05:16:48 INFO - PROCESS | 5248 | |9;NavierStokes;4887.804878048781 05:16:48 INFO - PROCESS | 5248 | __end_tp_report 05:16:48 INFO - PROCESS | 5248 | __startTimestamp1451913408269__endTimestamp 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | ------- Summary: start ------- 05:16:48 INFO - PROCESS | 5248 | Number of tests: 10 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 166.8 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 188.7 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 279.8 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 5273.7 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 1074.1 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#5] Earley Cycles:1 Average:709.72 Median:709.72 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 709.7 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 12419.8 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 25375.0 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#8] Splay Cycles:1 Average:674.81 Median:674.81 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 674.8 05:16:48 INFO - PROCESS | 5248 | 05:16:48 INFO - PROCESS | 5248 | [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 05:16:48 INFO - PROCESS | 5248 | Values: 4887.8 05:16:48 INFO - PROCESS | 5248 | -------- Summary: end -------- 05:16:48 INFO - PROCESS | 5248 | 05:16:49 INFO - TEST-INFO | 5248: exit 0 05:16:49 INFO - TEST-OK | v8_7 | took 40056ms 05:16:49 INFO - SUITE-END | took 1213s 05:16:49 INFO - Completed test suite (00:20:13) 05:16:49 INFO - Working with test: dromaeo_css 05:16:49 INFO - Generating results file: dromaeo_css 05:16:49 INFO - Working with test: kraken 05:16:49 INFO - Generating results file: kraken 05:16:49 INFO - javascript benchmark 05:16:49 INFO - Working with test: v8_7 05:16:49 INFO - Generating results file: v8_7 05:16:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:16:49 INFO - process_Request line: dromaeo_css 6898.24 graph.html#tests=[[72,64,43]] 05:16:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:49 INFO - process_Request line: kraken 1522.00 graph.html#tests=[[232,64,43]] 05:16:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:49 INFO - process_Request line: v8_7 21034.13 graph.html#tests=[[230,64,43]] 05:16:49 INFO - RETURN: dromaeo_css: 6898.24 05:16:49 INFO - RETURN: kraken: 1522.00 05:16:49 INFO - RETURN: v8_7: 21034.13 05:16:49 INFO - javascript benchmark 05:16:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3159.984200079, 3200.5679233303526, 3224.2261857154276, 3256.3324518473714, 3264.885728999484, 5211.0, 5365.114756065244, 5390.164524498704, 5397.811076612319, 5401.648892821964, 5295.920561191585, 5360.356757189143, 5442.619016668835, 5478.424765399635, 5504.834854954348, 4846.982133751916, 4879.9024019519675, 4983.327250821148, 4986.002799440108, 5059.367579052619, 4812.879678008043, 4934.481879402647, 4953.975230123844, 4970.552650261476, 5023.346964894558, 4864.954034882482, 4869.805207791684, 4952.33143525623, 4968.453470118284, 4993.675411098267, 4845.563899249085, 4847.054824309261, 4855.271709243641, 4868.391451068616, 4896.583790377822, 4708.576228139484, 4787.880302992453, 4814.398200224972, 4863.756812159413, 4910.950890491085, 5145.742712864342, 5221.582273418117, 5279.60402969775, 5286.97356513215, 5363.088274993261, 5800.216970708942, 5832.154337621064, 5833.649981001154, 5837.532997360201, 5842.6202296851, 5707.400722924075, 5796.2464879565805, 5823.184754134425, 5851.678157701324, 5863.413658634145, 5482.91775623366, 5489.204065410493, 5489.505944465017, 5490.862728431781, 5493.7802487900435, 5972.492338151219, 5979.073243647242, 6010.579259451796, 6013.398660133952, 6018.458338749533, 5542.972285138549, 5637.661740295595, 5675.489205971482, 5728.112142617901, 5815.331236907725, 5801.593888427854, 5818.389069147678, 5825.621334613236, 5827.067669172997, 5835.9708201458725, 5746.655200687972, 5799.94200057994, 5806.0, 5816.825495235065, 5824.388439213906, 5634.690092044977, 5731.083026715789, 5750.108733146285, 5825.242718446575, 5882.088276317178, 4413.646908247332, 4414.55854414556, 4422.226110430662, 4440.045390241114, 4476.843310484118, 3953.4267531207815, 3973.543042550086, 3985.4021896715726, 3996.9000774980277, 4021.3163762160502, 5337.919931201035, 5341.572674186055, 5345.679259244458, 5346.8395948121615, 5464.480874316933, 5778.046622307356, 5792.044312688444, 5797.449242321973, 5818.94181058184, 5823.563232757476, 5386.057439947994, 5388.434214407509, 5389.541888939406, 5428.511433970962, 5435.646682965595, 4805.903881922342, 4891.5353041461, 4895.412550493964, 4915.21356582945, 4952.430470495867, 5972.701364931736, 5976.103584462366, 5976.342602313742, 5982.042873140276, 5983.940160598426, 5769.048107062287, 5823.301203855564, 5829.38791426911, 5834.824955251349, 5871.1486834407915, 5835.766569337179, 5973.581849270683, 6021.608595441282, 6033.336333003454, 6129.725578588854, 5726.885462290647, 5736.225609542658, 5758.424157584208, 5758.683272420057, 5771.163181338767, 5818.389069147848, 5849.3858144894175, 5864.120381942743, 5915.201447804491, 5918.585699001201, 5548.916766248591, 5652.349979752381, 5661.971690141523, 5739.598228123991, 5768.077107662753, 5695.316562012585, 5704.686242256716, 5713.571482138773, 5714.285714285715, 5715.685637289989, 5401.378841433286, 5645.814378980296, 5661.886762264649, 5687.0, 5691.516221121251, 5618.85952851182, 5635.211070450058, 5778.768849245983, 5795.39148389413, 5835.649861008353, 5590.357108932525, 5628.915566266591, 5636.689982051026, 5642.407547207484, 5654.85862853432], "unit": "score", "name": "dojo.html", "value": 5341.650342763689}, {"lowerIsBetter": false, "replicates": [529.0503546134688, 543.8585967648413, 559.2115117684065, 566.6147020026385, 568.3549171690136, 34153.487697684526, 34758.826205868936, 34761.82619086901, 34801.47797783032, 34883.82558087209, 34561.0, 34653.82673086637, 35043.82478087612, 35068.82465587675, 35649.82175089127, 8196.3033142183, 8237.0, 8287.875681864776, 8319.875201871977, 8327.708530201444, 7982.680692772282, 8153.836923261531, 8210.137935516774, 8214.753557393287, 8335.708250211244, 8158.061822890355, 8167.67329306827, 8224.588770561479, 8255.628496717662, 8262.17378262175, 8184.6316915738635, 8279.296259817922, 8292.17078292172, 8308.0, 8329.958350208271, 8170.836583268361, 8179.100298967109, 8254.339652827759, 8283.337333013344, 8323.875141872877, 35533.93398198058, 36260.456093158624, 36406.63593364059, 36427.0, 36444.45333320002, 3020.9244768880953, 3176.4600017996995, 3279.868805247811, 3476.7913925164316, 3519.6128425873135, 28627.284317892012, 28679.56980645292, 28933.42133157346, 28967.42065158706, 29719.405611887858, 3884.9805750971063, 3886.145048089416, 3932.233214523169, 3998.900027499307, 4004.0, 248731.0, 249892.0, 250093.0, 251091.99999999817, 251577.0, 40732.0, 40886.38670419946, 41368.0, 41547.7922610385, 41669.79165104216, 38803.0, 38812.80593597014, 38897.0, 38923.80538097348, 39114.21771564553, 13040.087193896527, 13070.869291306964, 13091.803622945663, 13169.604911852659, 13173.47306107764, 11328.603498877499, 11367.09063274936, 11381.317120972768, 11454.713632159262, 11456.54173833054, 13875.58373248784, 13912.165270083626, 13939.930300348433, 14014.369353379123, 14112.435502579987, 5689.175069614883, 5701.71491425427, 5756.597038207286, 5821.825345239565, 5905.527557795366, 900.9324300677345, 922.5663937949154, 940.0740270833223, 992.9007099290013, 996.9850452243222, 27240.59139112915, 27772.444551109267, 28728.71271287302, 30029.0, 30672.23319416988, 1005.1355833982769, 1030.953607087683, 1093.8632670916136, 1149.5631659969158, 1172.8827117288374, 14355.64110897215, 14519.346629401702, 14575.781363279559, 14603.561893143222, 14642.121472711671, 638875.0, 649448.0, 653912.0, 654809.0, 654965.0, 51327.0, 51456.22815657768, 51606.74196628993, 51695.48304516982, 51975.0, 1290.264549206943, 1310.5544115000946, 1317.6047185844209, 1330.946762129504, 1351.0812647399862, 26918.192454226406, 28069.859650701615, 28537.14388568263, 28683.0, 29670.554941675462, 47284.52715472801, 48099.75950120227, 48143.277850832965, 48247.27629085637, 48386.5161348382, 279059.0, 281156.0, 282272.0, 282350.0, 283137.0, 38467.0, 38794.2241155181, 39522.2095558093, 40029.79985100056, 41009.384859227735, 36408.0, 37127.0, 37597.43603845999, 37734.0, 38202.61797382102, 31571.36857262796, 31777.364452711277, 32281.0, 32343.0, 32360.0, 32430.513542297358, 32554.186145346557, 32605.0, 32980.340393192484, 33127.66872331342, 33272.0, 33387.83306083454, 33685.83157084199, 34183.0, 34353.0, 29541.409171816875, 30681.8465907669, 31571.684283156876, 31800.204994875312, 31949.840250798596, 24235.0, 24447.75552244455, 25458.236252912444, 26905.730942690323, 26976.73023269742], "unit": "score", "name": "ext.html", "value": 17465.329365249418}, {"lowerIsBetter": false, "replicates": [352.60684336964283, 355.0732587945462, 355.4011490638273, 355.60350209516383, 355.91991801844586, 14066.296685165751, 14430.567082987502, 16420.671586568278, 16576.0, 17131.486055418325, 15928.203589820521, 15931.601709957256, 16355.509334719947, 16440.177991100427, 16444.506664800047, 4635.791389387486, 4778.784954677048, 4803.135435621587, 4819.180739274332, 4822.180229361, 4717.764111794414, 5085.669431486942, 5216.7391630418515, 5291.6031297652635, 5310.123829568117, 5245.6852588844795, 5249.028929648009, 5254.448282930294, 5265.131253343194, 5265.842024739264, 5266.34170728659, 5280.181571856349, 5404.4595540446035, 5408.8377348679605, 5415.918761218585, 5209.895802083937, 5213.296205012351, 5219.660722053054, 5233.790648374061, 5310.601704872111, 19764.80235197644, 20283.391498255078, 20650.380488585368, 20723.58552828935, 20750.48123796902, 2087.3842216546154, 2141.3254824730316, 2230.965283448386, 2239.507308392151, 2253.3465295064575, 9591.328606997513, 9652.517374131265, 9730.708078757649, 9994.750131246705, 10081.243906707026, 1848.223746026672, 1858.6282743451363, 1871.8502519798383, 1896.3931541906456, 1909.0931807391378, 59524.70237648784, 61600.0, 62519.0, 63118.36881631217, 64647.67676161636, 9817.950910245403, 9824.754381140528, 9951.452670103068, 9986.700398988041, 10046.0, 12456.75086498283, 12511.93744031274, 12612.873871261354, 12687.746245075232, 12688.0, 7424.665890034961, 7440.516366436164, 7444.553326800409, 7467.290607392289, 7473.663685134182, 7090.964545177241, 7104.786856394317, 7218.242084581148, 7223.747168849065, 7267.854642907218, 4341.39220509129, 4350.912981740411, 4388.27593447084, 4398.956010439919, 4405.140997505456, 1647.2258038721782, 1691.188229649775, 1715.2624371520117, 1716.5536960390139, 1720.028184075993, 889.4529864133511, 899.9235065019546, 919.6367434863191, 941.9481928493999, 969.1568335547977, 15358.385664573516, 16411.91794041022, 16552.668946621, 17116.914415427844, 17193.398231061852, 867.0, 895.4582477601087, 928.3408779766442, 936.1434287626881, 963.1139351796364, 8798.560071996502, 9310.72067837966, 9373.156415922464, 10110.949445252727, 10323.587056517805, 535929.0, 569515.0, 574316.0, 587519.0, 592839.0, 77283.61358193173, 77385.0, 81232.59383703044, 81964.0, 82497.0, 1095.8465814785936, 1109.0683825586384, 1110.4503270880966, 1124.2973141786383, 1130.2879186112862, 15062.246887655792, 15189.31648075817, 15215.0, 15268.312925918139, 15551.300191491184, 34973.82513087418, 34990.47514287339, 35698.643013569534, 36139.45790813088, 37625.81187094047, 45282.77358613186, 47103.52896471129, 47296.763516182196, 48844.511554884, 49960.25059624036, 9499.952500237454, 9643.807123857623, 9686.370385924893, 9752.804943901225, 9769.609215631295, 11475.885241147482, 15383.0, 17003.829961700223, 17341.306347746453, 17370.652586947937, 14201.502947396792, 14412.279386030446, 14419.279036048365, 14645.0, 14861.182634955181, 13545.59363219105, 13807.102538334975, 13825.446982120602, 13852.584422467342, 14273.857261427253, 13946.721065578835, 14109.435622575393, 14920.626984325045, 15144.0, 15558.533244002698, 9156.404833685789, 9170.95414522923, 9272.165505104573, 9301.534923253945, 9349.672761453316, 14190.29048547589, 14575.0, 14589.562313130624, 14595.635109122357, 15139.772903406678], "unit": "score", "name": "jquery.html", "value": 8777.004469936426}, {"lowerIsBetter": false, "replicates": [1371.657085728568, 1381.7927310903362, 1487.1075757651372, 1666.6749983753173, 1687.1395588249989, 7377.926220737791, 7420.925790742091, 7482.289182527658, 7529.585872776995, 7557.659905304261, 7581.393488520919, 7607.201243869397, 7667.194944530827, 7675.194104619019, 7684.039495063117, 2257.0520381439833, 2266.002958698176, 2267.557826223887, 2290.7823756743164, 2296.9885150574223, 2266.4447210433386, 2267.5011497470614, 2272.284230467406, 2288.199130304397, 2317.9884100579475, 2185.0822654485155, 2203.7575866654656, 2234.82121430286, 2242.372135801978, 2256.4697296135396, 2221.0, 2257.0294773247497, 2269.9546009079727, 2287.3938406322336, 2288.6795848581214, 2269.217120093565, 2299.7700229977036, 2301.528186721718, 2301.9884900575557, 2306.8269879759087, 7136.250693677193, 7227.241139680363, 7241.384482319009, 7253.7098516059295, 7269.563826170447, 4617.076584683077, 4698.600618947394, 4726.0, 4731.976340118277, 4734.455537613184, 3093.90718278452, 3097.2876238465055, 3137.105924811418, 3163.4938409854312, 3183.0769076967654, 1045.9267851250415, 1066.306900514664, 1074.0601973273385, 1083.268793564341, 1110.0897264243324, 9897.406155630613, 10062.647807326708, 10151.340162889388, 10166.288359814816, 10196.133328667147, 4067.9796601017397, 4072.75563466193, 4122.814473348706, 4126.938095928564, 4127.814248358831, 8202.630881610341, 8254.504729716236, 8322.958385208036, 8324.084350721416, 8332.416730828905, 4561.908761824745, 4567.954320456753, 4570.040291538748, 4586.6789324747615, 4589.311603259471, 4166.791660416967, 4167.4790651168605, 4187.916241675211, 4198.307279298881, 4217.894552636209, 3413.8975830725117, 3431.4166591679473, 3432.5709286339206, 3461.8961431157104, 3478.3043391321835, 1020.7499162705185, 1026.4098143567478, 1031.3296357367772, 1033.1166852341291, 1040.599369242832, 978.256525040974, 1012.594962015185, 1026.2867307221409, 1120.8991190792867, 1283.5186804948144, 6866.416354609914, 6895.655217239118, 6899.137607799025, 6913.861722765517, 6922.238553759184, 1061.2093989977516, 1083.8807731149568, 1102.9889701103048, 1112.8831472695251, 1118.4966764955802, 5377.0321342158, 5510.421405752419, 5517.337919449692, 5532.197831314437, 5567.4432556744005, 8569.871451928226, 8660.350473714496, 8737.912620873836, 8744.95627521871, 9130.360874738837, 8609.053004169537, 8629.784255393666, 8649.740507784776, 8671.176238257356, 8705.564721763887, 6762.019507171432, 6793.490488213404, 6812.727490900407, 6817.147856517935, 6895.069165662571, 6909.7581584644295, 6928.064711263914, 6939.930600693929, 6946.2011868635755, 6954.130733658293, 7983.5209887406945, 8346.207110324509, 8377.287930525974, 8381.287590554628, 8430.36772242072, 8175.754727358189, 8307.08622051586, 8309.293710034715, 8310.293625041939, 8318.584070796314, 6685.732570697118, 6709.597424154566, 6721.193456785217, 6733.52865299444, 6843.0419741237265, 7203.927960720326, 7221.447388811431, 7249.0, 7302.890456643048, 7327.74352897646, 6584.176977877765, 6618.106555614931, 6686.231083425469, 6740.561863478858, 6760.1549806274215, 6350.142730731292, 6483.513736469689, 6540.149780528501, 6678.699458524476, 6696.397324240842, 6491.48068154537, 6516.51126165549, 6678.799636010927, 6694.4644428444635, 6713.0, 5870.970645146747, 5882.23530940975, 5882.882342353215, 5932.288125424977, 5961.672108034099, 5854.736536855767, 5882.0, 5942.257217847769, 5949.25634295713, 5955.047192449188], "unit": "score", "name": "mootools.html", "value": 4322.487558101784}, {"lowerIsBetter": false, "replicates": [337.2327953904866, 341.6617548626859, 345.4317647469911, 349.31011252775755, 355.5839667588921, 6219.875602487948, 6222.502199824009, 6250.28121765997, 6257.906131408033, 6423.164988551482, 6234.314225435199, 6263.154474145989, 6264.404881536247, 6282.968585157079, 6284.497240220783, 4689.835855745049, 4709.693869898463, 4716.268978308368, 4728.40894888139, 4733.313669517918, 4737.3604563384015, 4738.170820106485, 4741.8103275868925, 4743.051389722053, 4748.881277968044, 4507.774611269439, 4625.051864367797, 4646.79089440976, 4691.413573303337, 4743.976280118594, 4615.93076103857, 4636.049609829976, 4637.65217608679, 4654.9069018619775, 4679.087577922306, 4026.094128820992, 4028.536718277406, 4031.052702614883, 4031.8387264509383, 4033.4151548025666, 5811.82564523065, 5817.185594016841, 5833.941660583382, 5898.174255604176, 5899.174115623816, 5277.287566178555, 5341.786328546854, 5384.757685904144, 5427.104527752916, 5429.972850135724, 6531.640759758211, 6588.769393071268, 6594.175728033996, 6594.406503414716, 6613.4709223262025, 4502.954970450286, 4518.864434066983, 4522.502524722311, 4529.954700452986, 4533.6146427553695, 6763.222229443628, 6886.827829304308, 6947.471556257615, 6951.200611929642, 6955.0, 4635.304704294315, 4639.188142075123, 4640.373549570765, 4643.837465688753, 4651.67438279324, 4694.835680751157, 4707.811687532529, 4710.717356958594, 4711.882202944886, 4713.505081966413, 5472.808451704172, 5488.780448782084, 5496.31296087989, 5496.697681627549, 5506.807261745819, 6570.244421891448, 6635.137432133888, 6666.266710661824, 6688.398044176048, 6688.632125233062, 1648.3818568036986, 1667.5330907345963, 1668.4994501649458, 1669.9582510437335, 1670.4571014420362, 1108.4734750993375, 1110.3448965110624, 1113.1540029577418, 1114.2868564118808, 1129.7232178116415, 6275.152854364694, 6276.309605943343, 6280.560360774702, 6281.120643109968, 6283.7800676976085, 6784.525083244224, 6787.966060169668, 6790.049393084873, 6795.490338224653, 6845.760398386033, 6178.567500275028, 6276.623402595859, 6280.277768056732, 6290.622562646165, 6311.905321420182, 3717.9070523237137, 3738.831752571141, 3745.6628903398823, 3749.362608356586, 3752.924941501209, 7090.893636595455, 7159.821004474826, 7244.818879527948, 7269.600171990592, 7276.272372762682, 6870.828229294308, 6973.442124630017, 6983.266756990544, 7003.859922801617, 7038.155421349471, 7209.927900721031, 7211.206767255598, 7217.675204615805, 7222.783316500619, 7226.530275532074, 6787.490938179755, 6789.253182149861, 6831.98456455337, 6836.726530938707, 6842.828929276808, 6711.959646254838, 6785.321467853372, 6811.978203269549, 6847.281035491202, 6867.107276054081, 7161.069061022034, 7188.964055179691, 7226.963865180851, 7230.42156627458, 7237.710491580277, 4583.175028494769, 4673.485916549245, 4675.99466114787, 4681.648876334357, 4691.390119284471, 6737.393634572912, 6901.378875901193, 6918.0, 6939.861202776017, 6947.131608548932, 6614.801555953329, 6644.933550664431, 6674.566153200027, 6684.565503242274, 6737.898931515933, 6668.199816021915, 6684.298148694317, 6705.698243579148, 6716.966415167893, 6732.730690772314, 6490.8052758417325, 6537.607743535403, 6600.07598936159, 6601.141851559267, 6610.305917878746, 6735.259121496533, 6743.426808721314, 6744.0, 6744.494162937897, 6754.290799465985, 6410.679466026773, 6509.869802603826, 6527.445167160845, 6533.118029066015, 6543.985682219263], "unit": "score", "name": "prototype.html", "value": 4981.674639996232}, {"lowerIsBetter": false, "replicates": [731.3490993016214, 833.2417500074934, 833.3749687734199, 840.945338552994, 877.7410663854164, 13234.669133271662, 13397.66505837352, 13464.326783660814, 13477.123986940842, 13481.59555213344, 12197.451114699837, 12327.815082773743, 12344.81482777759, 12358.567450139248, 12518.56185033524, 784.8116452051495, 796.0487217774762, 799.588212070784, 802.0215337288498, 802.7230605441142, 795.5385876191824, 805.3355981315409, 807.7415227127321, 809.4576633655465, 812.5815205169342, 838.2372041442288, 840.5251033166242, 842.2293601354753, 848.4569875279826, 848.4654667559429, 825.9752207433787, 828.0808302783965, 838.9748307550752, 839.1943734015322, 839.6347588798892, 612.2285919741114, 613.6992873491956, 613.8618810767541, 614.124872057321, 615.3139249736556, 12280.201786883825, 12459.93770031144, 12502.187357821713, 12529.812052819216, 12533.623991280276, 10608.992145746142, 10675.466226688635, 10714.785704285949, 10716.571337146504, 10782.4608769562, 9848.409095454295, 9874.753131171707, 10058.849117263248, 10160.085592296655, 10258.384496930208, 3390.135515443546, 3486.511888335635, 3491.3715531204375, 3572.910677233064, 3682.3739964205884, 41549.753507394824, 41828.58171418277, 42402.78798605987, 42655.36016959748, 43381.3604231451, 8720.43317184381, 9004.81990360189, 9048.683296084606, 9098.681546145854, 9100.908990910006, 17561.38535151289, 17694.026828524296, 17837.554061148316, 18021.459356219333, 18029.7295540567, 7283.0, 7592.506487078323, 7720.3437707795465, 7919.960400198077, 8007.079185893696, 4368.27923392643, 4378.737275763465, 4398.846040388571, 4412.624926881187, 4428.889277768081, 2969.85150742462, 2991.7157870002316, 3003.594514740526, 3007.804492707967, 3008.5938398316384, 515.2837555797445, 533.2694208933785, 534.0627199265265, 536.1127334261803, 543.8857839853675, 527.1986580397773, 527.7704198673589, 552.2020680117272, 631.8294060603612, 657.9111570351076, 8159.26566609008, 8440.66237350499, 8547.700830470903, 8610.049370918941, 8646.610902509403, 680.3536640191738, 687.2714922182503, 689.4139981016197, 705.3792662457107, 708.7519368221082, 3950.9604903951167, 4255.97872010638, 4266.530681625019, 4288.927768057985, 4315.84207896052, 49620.75189624029, 50648.49351506438, 50965.49034509682, 52164.0, 53134.46865531295, 47096.29355559669, 47131.764341178074, 47383.05233895303, 47941.28088078681, 48160.0, 43663.78168109203, 44073.11853762971, 44382.77808610936, 44696.0, 44937.999999999345, 8726.476411415335, 8900.821983560421, 9045.728628141167, 9082.36423450352, 9157.908420915706, 33804.66195338015, 33965.83017084899, 34057.829710851285, 34383.312333752685, 34528.827355864065, 37856.43215351827, 40499.190016200104, 42600.0, 42761.0, 42932.78533607437, 10782.299150555189, 10927.508262128382, 11083.833742493707, 11152.052075573667, 11186.0, 11123.610673626385, 11418.371989540656, 11487.597934072268, 11577.247478913843, 11656.650300491, 10231.28381013322, 10486.632967846088, 10714.25000249975, 11209.383483908463, 11242.269252498561, 11473.655790326304, 11748.706282342668, 12056.156069075081, 12103.878961210276, 12114.818277726017, 10786.460676966277, 10813.891861081289, 10923.289986150874, 11349.0, 11726.824097638371, 8917.598708058284, 9052.54737263121, 9088.681896133603, 9394.24846012331, 9453.149216570542, 8950.23922966555, 9125.027448944824, 9132.49771262587, 9310.301727370339, 9572.856407153758], "unit": "score", "name": "yui.html", "value": 6110.617647984111}], "name": "dromaeo_css", "value": 6898.238935247798}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 113.0, 112.0, 123.0, 112.0, 111.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 147.0, 160.0, 129.0, 159.0, 159.0, 127.0, 157.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [166.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 165.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 72.0, 72.0, 71.0, 77.0, 136.0, 72.0, 71.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 145.0, 96.0, 97.0, 96.0, 139.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [110.0, 113.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 99.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 70.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 68.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [93.0, 85.0, 94.0, 91.0, 93.0, 84.0, 86.0, 88.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 121.0, 127.0, 115.0, 126.0, 141.0, 117.0, 122.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [144.0, 154.0, 154.0, 155.0, 154.0, 143.0, 154.0, 154.0, 152.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 69.0, 68.0, 68.0, 69.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1522.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [709.7232079488999], "unit": "score", "name": "Earley", "value": 939.0463669999997}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25375.0], "unit": "score", "name": "RegExp", "value": 35.90088669950742}, {"lowerIsBetter": false, "replicates": [674.8071979434447], "unit": "score", "name": "Splay", "value": 120.76190095238091}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 21034.1331386708}]} 05:16:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21034.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1522.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6898.24"}}} 05:16:49 INFO - Return code: 0 05:16:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:16:49 INFO - # TBPL SUCCESS # 05:16:49 INFO - Running post-action listener: _resource_record_post_action 05:16:49 INFO - Running post-run listener: _resource_record_post_run 05:16:50 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8536064; Write bytes: 913711104; Read time: 2328; Write time: 386496 05:16:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 10989568; Read time: 0; Write time: 1112 05:16:50 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 8507392; Write bytes: 902721536; Read time: 2296; Write time: 385384 05:16:50 INFO - Running post-run listener: _upload_blobber_files 05:16:50 INFO - Blob upload gear active. 05:16:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:16:50 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 05:16:50 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:16:50 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:16:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:16:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:52 INFO - (blobuploader) - INFO - Done attempting. 05:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:52 INFO - (blobuploader) - INFO - Done attempting. 05:16:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:52 INFO - Return code: 0 05:16:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:16:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efdc3769e6ea7252d0c8c193e3a2d6d8680f0ae8bea51ffee9163b74b1abb951c1bdbc3f16af07e7d6dd8905a71bfcf2766bc9850cf7da0a7ebf9fdec58486a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2489f823a06cc5e9536fd6af1897ace7f0e6540e7b371cbc7d3ac8df80b08588ad35fd29a091159415cc333e9f3901e7a1522e70fc8ef65f6a08a663a2a55b10"} 05:16:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:16:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:16:52 INFO - Contents: 05:16:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efdc3769e6ea7252d0c8c193e3a2d6d8680f0ae8bea51ffee9163b74b1abb951c1bdbc3f16af07e7d6dd8905a71bfcf2766bc9850cf7da0a7ebf9fdec58486a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2489f823a06cc5e9536fd6af1897ace7f0e6540e7b371cbc7d3ac8df80b08588ad35fd29a091159415cc333e9f3901e7a1522e70fc8ef65f6a08a663a2a55b10"} 05:16:52 INFO - Copying logs to upload dir... 05:16:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1286.011092 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-04 05:16:52.928602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:52.931920) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efdc3769e6ea7252d0c8c193e3a2d6d8680f0ae8bea51ffee9163b74b1abb951c1bdbc3f16af07e7d6dd8905a71bfcf2766bc9850cf7da0a7ebf9fdec58486a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2489f823a06cc5e9536fd6af1897ace7f0e6540e7b371cbc7d3ac8df80b08588ad35fd29a091159415cc333e9f3901e7a1522e70fc8ef65f6a08a663a2a55b10"} build_url:https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efdc3769e6ea7252d0c8c193e3a2d6d8680f0ae8bea51ffee9163b74b1abb951c1bdbc3f16af07e7d6dd8905a71bfcf2766bc9850cf7da0a7ebf9fdec58486a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2489f823a06cc5e9536fd6af1897ace7f0e6540e7b371cbc7d3ac8df80b08588ad35fd29a091159415cc333e9f3901e7a1522e70fc8ef65f6a08a663a2a55b10"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:52.956305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:52.956630) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1451912124.333162-2124419918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:53.041484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 05:16:53.041802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 05:16:53.042093) ========= ========= Total master_lag: 0.36 =========