builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1453633538.27 results: success (0) buildid: 20160124004010 builduid: 73af64cc5f084603afc6b29615f604ce revision: 7ede46ba62979809bafb3c1507745a4eeaec1c57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.275190) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.275642) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.275984) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.348296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.348609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.421135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.421437) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020099 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.474655) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.474972) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.475357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.475665) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 03:05:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.7M=0s 2016-01-24 03:05:39 (83.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172126 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.667116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.667530) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.725013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:38.725911) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ede46ba62979809bafb3c1507745a4eeaec1c57 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ede46ba62979809bafb3c1507745a4eeaec1c57 --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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 03:05:39,726 truncating revision to first 12 chars 2016-01-24 03:05:39,726 Setting DEBUG logging. 2016-01-24 03:05:39,726 attempt 1/10 2016-01-24 03:05:39,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ede46ba6297?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 03:05:40,001 unpacking tar archive at: mozilla-aurora-7ede46ba6297/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:39.303469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:39.304155) ========= echo 7ede46ba62979809bafb3c1507745a4eeaec1c57 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7ede46ba62979809bafb3c1507745a4eeaec1c57'] 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7ede46ba62979809bafb3c1507745a4eeaec1c57 program finished with exit code 0 elapsedTime=0.004607 script_repo_revision: '7ede46ba62979809bafb3c1507745a4eeaec1c57' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:39.361069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:39.361415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 03:05:39.382505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-24 03:05:39.382907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:05:40 INFO - MultiFileLogger online at 20160124 03:05:40 in /builds/slave/test-pgo 03:05:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:05:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:05:40 INFO - {'append_to_log': False, 03:05:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:05:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:05:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:05:40 INFO - 'branch': 'Mozilla-Aurora', 03:05:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:05:40 INFO - 'config_files': ('talos/linux_config.py',), 03:05:40 INFO - 'default_actions': ('clobber', 03:05:40 INFO - 'read-buildbot-config', 03:05:40 INFO - 'download-and-extract', 03:05:40 INFO - 'populate-webroot', 03:05:40 INFO - 'create-virtualenv', 03:05:40 INFO - 'install', 03:05:40 INFO - 'run-tests'), 03:05:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:05:40 INFO - 'download_minidump_stackwalk': True, 03:05:40 INFO - 'download_symbols': 'ondemand', 03:05:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:05:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:05:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:05:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:05:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:05:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:05:40 INFO - 'installer_path': 'installer.exe', 03:05:40 INFO - 'log_level': 'info', 03:05:40 INFO - 'log_name': 'talos', 03:05:40 INFO - 'log_to_console': True, 03:05:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:05:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:05:40 INFO - 'opt_config_files': (), 03:05:40 INFO - 'pip_index': False, 03:05:40 INFO - 'sps_profile': False, 03:05:40 INFO - 'sps_profile_interval': 0, 03:05:40 INFO - 'suite': 'dromaeojs', 03:05:40 INFO - 'system_bits': '32', 03:05:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:05:40 INFO - 'title': 'talos-linux64-ix-060', 03:05:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:05:40 INFO - 'use_talos_json': True, 03:05:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:05:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:05:40 INFO - 'work_dir': 'build'} 03:05:40 INFO - ##### 03:05:40 INFO - ##### Running clobber step. 03:05:40 INFO - ##### 03:05:40 INFO - Running pre-action listener: _resource_record_pre_action 03:05:40 INFO - Running main action method: clobber 03:05:40 INFO - rmtree: /builds/slave/test-pgo/build 03:05:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:05:45 INFO - Running post-action listener: _resource_record_post_action 03:05:45 INFO - ##### 03:05:45 INFO - ##### Running read-buildbot-config step. 03:05:45 INFO - ##### 03:05:45 INFO - Running pre-action listener: _resource_record_pre_action 03:05:45 INFO - Running main action method: read_buildbot_config 03:05:45 INFO - Using buildbot properties: 03:05:45 INFO - { 03:05:45 INFO - "properties": { 03:05:45 INFO - "buildnumber": 216, 03:05:45 INFO - "product": "firefox", 03:05:45 INFO - "script_repo_revision": "production", 03:05:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:05:45 INFO - "repository": "", 03:05:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:05:45 INFO - "buildid": "20160124004010", 03:05:45 INFO - "slavename": "talos-linux64-ix-060", 03:05:45 INFO - "stage_platform": "linux64-pgo", 03:05:45 INFO - "basedir": "/builds/slave/test-pgo", 03:05:45 INFO - "nightly_build": "True", 03:05:45 INFO - "project": "", 03:05:45 INFO - "platform": "ubuntu64_hw", 03:05:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:05:45 INFO - "slavebuilddir": "test", 03:05:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:05:45 INFO - "branch": "mozilla-aurora", 03:05:45 INFO - "repo_path": "releases/mozilla-aurora", 03:05:45 INFO - "pgo_build": "True", 03:05:45 INFO - "builduid": "73af64cc5f084603afc6b29615f604ce", 03:05:45 INFO - "revision": "7ede46ba62979809bafb3c1507745a4eeaec1c57" 03:05:45 INFO - }, 03:05:45 INFO - "sourcestamp": { 03:05:45 INFO - "repository": "", 03:05:45 INFO - "hasPatch": false, 03:05:45 INFO - "project": "", 03:05:45 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:05:45 INFO - "changes": [ 03:05:45 INFO - { 03:05:45 INFO - "category": null, 03:05:45 INFO - "files": [ 03:05:45 INFO - { 03:05:45 INFO - "url": null, 03:05:45 INFO - "name": "https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:05:45 INFO - } 03:05:45 INFO - ], 03:05:45 INFO - "repository": "", 03:05:45 INFO - "rev": "7ede46ba62979809bafb3c1507745a4eeaec1c57", 03:05:45 INFO - "who": "sendchange", 03:05:45 INFO - "when": 1453633475, 03:05:45 INFO - "number": 7507601, 03:05:45 INFO - "comments": "", 03:05:45 INFO - "project": "", 03:05:45 INFO - "at": "Sun 24 Jan 2016 03:04:35", 03:05:45 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:05:45 INFO - "revlink": "", 03:05:45 INFO - "properties": [ 03:05:45 INFO - [ 03:05:45 INFO - "buildid", 03:05:45 INFO - "20160124004010", 03:05:45 INFO - "Change" 03:05:45 INFO - ], 03:05:45 INFO - [ 03:05:45 INFO - "builduid", 03:05:45 INFO - "73af64cc5f084603afc6b29615f604ce", 03:05:45 INFO - "Change" 03:05:45 INFO - ], 03:05:45 INFO - [ 03:05:45 INFO - "nightly_build", 03:05:45 INFO - "True", 03:05:45 INFO - "Change" 03:05:45 INFO - ], 03:05:45 INFO - [ 03:05:45 INFO - "pgo_build", 03:05:45 INFO - "True", 03:05:45 INFO - "Change" 03:05:45 INFO - ] 03:05:45 INFO - ], 03:05:45 INFO - "revision": "7ede46ba62979809bafb3c1507745a4eeaec1c57" 03:05:45 INFO - } 03:05:45 INFO - ], 03:05:45 INFO - "revision": "7ede46ba62979809bafb3c1507745a4eeaec1c57" 03:05:45 INFO - } 03:05:45 INFO - } 03:05:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:05:45 INFO - Running post-action listener: _resource_record_post_action 03:05:45 INFO - ##### 03:05:45 INFO - ##### Running download-and-extract step. 03:05:45 INFO - ##### 03:05:45 INFO - Running pre-action listener: _resource_record_pre_action 03:05:45 INFO - Running main action method: download_and_extract 03:05:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:05: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')]} 03:05:45 INFO - https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/test_packages.json 03:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/test_packages.json 03:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:05:49 INFO - Downloaded 1302 bytes. 03:05:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:05:49 INFO - Using the following test package requirements: 03:05:49 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:05:49 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:05:49 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'jsshell-linux-x86_64.zip'], 03:05:49 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:05:49 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:05:49 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:05:49 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:05:49 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:05:49 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:05:49 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:05:49 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:05:49 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:05: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')]} 03:05:49 INFO - https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:05:54 INFO - Downloaded 23158843 bytes. 03:05:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:05:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:05:55 INFO - Return code: 0 03:05:55 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:55 INFO - https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:05:56 INFO - Downloaded 23158843 bytes. 03:05:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:05:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:05:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:05:58 INFO - Return code: 0 03:05: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')]} 03:05:58 INFO - https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:05:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:05:59 INFO - Downloaded 11132038 bytes. 03:05:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:05:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:05:59 INFO - Return code: 0 03:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:59 INFO - https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:06:00 INFO - Downloaded 58018462 bytes. 03:06:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:00 INFO - mkdir: /builds/slave/test-pgo/properties 03:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:06:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:06:00 INFO - Contents: 03:06:00 INFO - build_url:https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:00 INFO - Running post-action listener: _resource_record_post_action 03:06:00 INFO - Running post-action listener: set_extra_try_arguments 03:06:00 INFO - ##### 03:06:00 INFO - ##### Running populate-webroot step. 03:06:00 INFO - ##### 03:06:00 INFO - Running pre-action listener: _resource_record_pre_action 03:06:00 INFO - Running main action method: populate_webroot 03:06:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:06:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:06:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:06:00 INFO - '--tppagecycles', 03:06:00 INFO - '7'], 03:06:00 INFO - 'tests': ['tsvgm']}}, 03:06:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:06:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:06:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:06:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:06:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'tests': ['damp', 'tps']}, 03:06:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['damp', 'tps']}, 03:06:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:06:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:00 INFO - 'other': {'tests': ['a11yr', 03:06:00 INFO - 'ts_paint', 03:06:00 INFO - 'tpaint', 03:06:00 INFO - 'sessionrestore', 03:06:00 INFO - 'sessionrestore_no_auto_restore']}, 03:06:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['a11yr', 03:06:00 INFO - 'ts_paint', 03:06:00 INFO - 'tpaint', 03:06:00 INFO - 'sessionrestore', 03:06:00 INFO - 'sessionrestore_no_auto_restore']}, 03:06:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['a11yr', 03:06:00 INFO - 'ts_paint', 03:06:00 INFO - 'tpaint', 03:06:00 INFO - 'sessionrestore', 03:06:00 INFO - 'sessionrestore_no_auto_restore']}, 03:06:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['a11yr', 03:06:00 INFO - 'ts_paint', 03:06:00 INFO - 'tpaint', 03:06:00 INFO - 'sessionrestore', 03:06:00 INFO - 'sessionrestore_no_auto_restore']}, 03:06:00 INFO - 'other_l64': {'tests': ['a11yr', 03:06:00 INFO - 'ts_paint', 03:06:00 INFO - 'tpaint', 03:06:00 INFO - 'sessionrestore', 03:06:00 INFO - 'sessionrestore_no_auto_restore']}, 03:06:00 INFO - 'other_nol64': {'tests': ['a11yr', 03:06:00 INFO - 'ts_paint', 03:06:00 INFO - 'tpaint', 03:06:00 INFO - 'sessionrestore', 03:06:00 INFO - 'sessionrestore_no_auto_restore']}, 03:06:00 INFO - 'svgr': {'tests': ['tsvgx', 03:06:00 INFO - 'tsvgr_opacity', 03:06:00 INFO - 'tart', 03:06:00 INFO - 'tscrollx', 03:06:00 INFO - 'cart']}, 03:06:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['tsvgx', 03:06:00 INFO - 'tsvgr_opacity', 03:06:00 INFO - 'tart', 03:06:00 INFO - 'tscrollx', 03:06:00 INFO - 'cart']}, 03:06:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'tests': ['tp5o']}, 03:06:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'talos_options': ['--e10s'], 03:06:00 INFO - 'tests': ['tp5o']}, 03:06:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'talos_options': ['--xperf_path', 03:06:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:00 INFO - 'tests': ['tp5n']}, 03:06:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:00 INFO - 'talos_options': ['--e10s', 03:06:00 INFO - '--xperf_path', 03:06:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:00 INFO - 'tests': ['tp5n']}}, 03:06:00 INFO - 'talos.zip': {'path': '', 03:06:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:06:00 INFO - Running post-action listener: _resource_record_post_action 03:06:00 INFO - ##### 03:06:00 INFO - ##### Running create-virtualenv step. 03:06:00 INFO - ##### 03:06:00 INFO - Running pre-action listener: _resource_record_pre_action 03:06:00 INFO - Running main action method: create_virtualenv 03:06:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:06:00 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 03:06:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:06:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:00 INFO - Using real prefix '/usr' 03:06:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:06:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:03 INFO - Installing pip.................done. 03:06:03 INFO - Return code: 0 03:06:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:06:03 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')]} 03:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:03 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')]} 03:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:03 INFO - Using env: {'DISPLAY': ':0', 03:06:03 INFO - 'HOME': '/home/cltbld', 03:06:03 INFO - 'LANG': 'en_US.UTF-8', 03:06:03 INFO - 'LANGUAGE': 'en_US:en', 03:06:03 INFO - 'LOGNAME': 'cltbld', 03:06:03 INFO - 'MAIL': '/var/mail/cltbld', 03:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:03 INFO - 'MOZ_NO_REMOTE': '1', 03:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:03 INFO - 'NO_EM_RESTART': '1', 03:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:03 INFO - 'SHELL': '/bin/bash', 03:06:03 INFO - 'SHLVL': '1', 03:06:03 INFO - 'TERM': 'linux', 03:06:03 INFO - 'TMOUT': '86400', 03:06:03 INFO - 'USER': 'cltbld', 03:06:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:03 INFO - '_': '/tools/buildbot/bin/python'} 03:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:03 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 03:06:03 INFO - Cleaning up... 03:06:03 INFO - Return code: 0 03:06:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:06:03 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')]} 03:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:03 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')]} 03:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:03 INFO - Using env: {'DISPLAY': ':0', 03:06:03 INFO - 'HOME': '/home/cltbld', 03:06:03 INFO - 'LANG': 'en_US.UTF-8', 03:06:03 INFO - 'LANGUAGE': 'en_US:en', 03:06:03 INFO - 'LOGNAME': 'cltbld', 03:06:03 INFO - 'MAIL': '/var/mail/cltbld', 03:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:03 INFO - 'MOZ_NO_REMOTE': '1', 03:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:03 INFO - 'NO_EM_RESTART': '1', 03:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:03 INFO - 'SHELL': '/bin/bash', 03:06:03 INFO - 'SHLVL': '1', 03:06:03 INFO - 'TERM': 'linux', 03:06:03 INFO - 'TMOUT': '86400', 03:06:03 INFO - 'USER': 'cltbld', 03:06:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:03 INFO - '_': '/tools/buildbot/bin/python'} 03:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:03 INFO - Downloading/unpacking psutil>=0.7.1 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:05 INFO - Installing collected packages: psutil 03:06:05 INFO - Running setup.py install for psutil 03:06:05 INFO - building 'psutil._psutil_linux' extension 03:06:05 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 03:06:05 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 03:06:05 INFO - building 'psutil._psutil_posix' extension 03:06:05 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 03:06:06 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 03:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:06 INFO - Successfully installed psutil 03:06:06 INFO - Cleaning up... 03:06:06 INFO - Return code: 0 03:06:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:06:06 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')]} 03:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:06 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')]} 03:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:06 INFO - Using env: {'DISPLAY': ':0', 03:06:06 INFO - 'HOME': '/home/cltbld', 03:06:06 INFO - 'LANG': 'en_US.UTF-8', 03:06:06 INFO - 'LANGUAGE': 'en_US:en', 03:06:06 INFO - 'LOGNAME': 'cltbld', 03:06:06 INFO - 'MAIL': '/var/mail/cltbld', 03:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:06 INFO - 'MOZ_NO_REMOTE': '1', 03:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:06 INFO - 'NO_EM_RESTART': '1', 03:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:06 INFO - 'SHELL': '/bin/bash', 03:06:06 INFO - 'SHLVL': '1', 03:06:06 INFO - 'TERM': 'linux', 03:06:06 INFO - 'TMOUT': '86400', 03:06:06 INFO - 'USER': 'cltbld', 03:06:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:06 INFO - '_': '/tools/buildbot/bin/python'} 03:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:06:06 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 03:06:06 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 03:06:06 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 03:06:06 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 03:06:06 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 03:06:06 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 03:06:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:06:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:06:08 INFO - Installing collected packages: mozsystemmonitor 03:06:08 INFO - Running setup.py install for mozsystemmonitor 03:06:08 INFO - Successfully installed mozsystemmonitor 03:06:08 INFO - Cleaning up... 03:06:08 INFO - Return code: 0 03:06:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:06:08 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')]} 03:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:08 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')]} 03:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:08 INFO - Using env: {'DISPLAY': ':0', 03:06:08 INFO - 'HOME': '/home/cltbld', 03:06:08 INFO - 'LANG': 'en_US.UTF-8', 03:06:08 INFO - 'LANGUAGE': 'en_US:en', 03:06:08 INFO - 'LOGNAME': 'cltbld', 03:06:08 INFO - 'MAIL': '/var/mail/cltbld', 03:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:08 INFO - 'MOZ_NO_REMOTE': '1', 03:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:08 INFO - 'NO_EM_RESTART': '1', 03:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:08 INFO - 'SHELL': '/bin/bash', 03:06:08 INFO - 'SHLVL': '1', 03:06:08 INFO - 'TERM': 'linux', 03:06:08 INFO - 'TMOUT': '86400', 03:06:08 INFO - 'USER': 'cltbld', 03:06:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:08 INFO - '_': '/tools/buildbot/bin/python'} 03:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:06: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 03:06:08 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 03:06:08 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 03:06:08 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 03:06: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 03:06:08 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 03:06:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:06:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 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 03:06:10 INFO - Downloading docopt-0.6.1.tar.gz 03:06:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:11 INFO - Running setup.py install for blobuploader 03:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:06:11 INFO - Running setup.py install for requests 03:06:11 INFO - Running setup.py install for docopt 03:06:11 INFO - Successfully installed blobuploader requests docopt 03:06:11 INFO - Cleaning up... 03:06:11 INFO - Return code: 0 03:06:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:06:11 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')]} 03:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:11 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')]} 03:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 03:06:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 03:06:11 INFO - Using env: {'DISPLAY': ':0', 03:06:11 INFO - 'HOME': '/home/cltbld', 03:06:11 INFO - 'LANG': 'en_US.UTF-8', 03:06:11 INFO - 'LANGUAGE': 'en_US:en', 03:06:11 INFO - 'LOGNAME': 'cltbld', 03:06:11 INFO - 'MAIL': '/var/mail/cltbld', 03:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:11 INFO - 'MOZ_NO_REMOTE': '1', 03:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:11 INFO - 'NO_EM_RESTART': '1', 03:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:11 INFO - 'SHELL': '/bin/bash', 03:06:11 INFO - 'SHLVL': '1', 03:06:11 INFO - 'TERM': 'linux', 03:06:11 INFO - 'TMOUT': '86400', 03:06:11 INFO - 'USER': 'cltbld', 03:06:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:11 INFO - '_': '/tools/buildbot/bin/python'} 03:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:11 INFO - Running setup.py (path:/tmp/pip-C0pS3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:11 INFO - Running setup.py (path:/tmp/pip-e29hGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:11 INFO - Running setup.py (path:/tmp/pip-BdtCtR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:12 INFO - Running setup.py (path:/tmp/pip-w1InFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:12 INFO - Running setup.py (path:/tmp/pip-6nt65d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:12 INFO - Running setup.py (path:/tmp/pip-rJF3Y4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:12 INFO - Running setup.py (path:/tmp/pip-QOD5nM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:12 INFO - Running setup.py (path:/tmp/pip-7nYQGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:12 INFO - Running setup.py (path:/tmp/pip-41kphk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:12 INFO - Running setup.py (path:/tmp/pip-fLiYCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:12 INFO - Running setup.py (path:/tmp/pip-mTHOpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:12 INFO - Running setup.py (path:/tmp/pip-RIjinC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:12 INFO - Running setup.py (path:/tmp/pip-2J5BiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:12 INFO - Running setup.py (path:/tmp/pip-x8LOqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:12 INFO - Running setup.py (path:/tmp/pip-13LQX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:12 INFO - Running setup.py (path:/tmp/pip-HdTueR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:13 INFO - Running setup.py (path:/tmp/pip-MFDQL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:13 INFO - Running setup.py install for manifestparser 03:06:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Running setup.py install for mozcrash 03:06:13 INFO - Running setup.py install for mozdebug 03:06:13 INFO - Running setup.py install for mozdevice 03:06:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Running setup.py install for mozfile 03:06:13 INFO - Running setup.py install for mozhttpd 03:06:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Running setup.py install for mozinfo 03:06:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Running setup.py install for mozInstall 03:06:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:06:13 INFO - Running setup.py install for mozleak 03:06:13 INFO - Running setup.py install for mozlog 03:06:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Running setup.py install for moznetwork 03:06:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Running setup.py install for mozprocess 03:06:14 INFO - Running setup.py install for mozprofile 03:06:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Running setup.py install for mozrunner 03:06:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Running setup.py install for mozscreenshot 03:06:14 INFO - Running setup.py install for moztest 03:06:14 INFO - Running setup.py install for mozversion 03:06:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:06:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:14 INFO - Cleaning up... 03:06:14 INFO - Return code: 0 03:06:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:06: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')]} 03:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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')]} 03:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:14 INFO - Using env: {'DISPLAY': ':0', 03:06:14 INFO - 'HOME': '/home/cltbld', 03:06:14 INFO - 'LANG': 'en_US.UTF-8', 03:06:14 INFO - 'LANGUAGE': 'en_US:en', 03:06:14 INFO - 'LOGNAME': 'cltbld', 03:06:14 INFO - 'MAIL': '/var/mail/cltbld', 03:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:14 INFO - 'MOZ_NO_REMOTE': '1', 03:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:14 INFO - 'NO_EM_RESTART': '1', 03:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:14 INFO - 'SHELL': '/bin/bash', 03:06:14 INFO - 'SHLVL': '1', 03:06:14 INFO - 'TERM': 'linux', 03:06:14 INFO - 'TMOUT': '86400', 03:06:14 INFO - 'USER': 'cltbld', 03:06:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:14 INFO - '_': '/tools/buildbot/bin/python'} 03:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:15 INFO - Running setup.py (path:/tmp/pip-ZGOlE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:15 INFO - Running setup.py (path:/tmp/pip-AGM8V9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:15 INFO - Running setup.py (path:/tmp/pip-kJ6cPX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:15 INFO - Running setup.py (path:/tmp/pip-VRWqnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:15 INFO - Running setup.py (path:/tmp/pip-rNNDjw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:15 INFO - Running setup.py (path:/tmp/pip-aeVhiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:15 INFO - Running setup.py (path:/tmp/pip-BwXwwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:15 INFO - Running setup.py (path:/tmp/pip-kHfgWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:15 INFO - Running setup.py (path:/tmp/pip-S7cItz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:15 INFO - Running setup.py (path:/tmp/pip-QN4PIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:15 INFO - Running setup.py (path:/tmp/pip-kfyVCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:15 INFO - Running setup.py (path:/tmp/pip-HuSiI0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:15 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)) 03:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:15 INFO - Running setup.py (path:/tmp/pip-UDVpvN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 03:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:16 INFO - Running setup.py (path:/tmp/pip-tiup2a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:16 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)) 03:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:16 INFO - Running setup.py (path:/tmp/pip-lhpF9l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:16 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)) 03:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:16 INFO - Running setup.py (path:/tmp/pip-RIgdUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:16 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)) 03:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:16 INFO - Running setup.py (path:/tmp/pip-e6LiKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:16 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)) 03:06:16 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)) 03:06:16 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)) 03:06:16 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)) 03:06:16 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)) 03:06:16 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)) 03:06:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:18 INFO - Downloading blessings-1.6.tar.gz 03:06:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:18 INFO - Installing collected packages: blessings 03:06:18 INFO - Running setup.py install for blessings 03:06:18 INFO - Successfully installed blessings 03:06:18 INFO - Cleaning up... 03:06:18 INFO - Return code: 0 03:06:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:06:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:06:18 INFO - Reading from file tmpfile_stdout 03:06:18 INFO - Current package versions: 03:06:18 INFO - argparse == 1.2.1 03:06:18 INFO - blessings == 1.6 03:06:18 INFO - blobuploader == 1.2.4 03:06:18 INFO - docopt == 0.6.1 03:06:18 INFO - manifestparser == 1.1 03:06:18 INFO - mozInstall == 1.12 03:06:18 INFO - mozcrash == 0.16 03:06:18 INFO - mozdebug == 0.1 03:06:18 INFO - mozdevice == 0.47 03:06:18 INFO - mozfile == 1.2 03:06:18 INFO - mozhttpd == 0.7 03:06:18 INFO - mozinfo == 0.9 03:06:18 INFO - mozleak == 0.1 03:06:18 INFO - mozlog == 3.1 03:06:18 INFO - moznetwork == 0.27 03:06:18 INFO - mozprocess == 0.22 03:06:18 INFO - mozprofile == 0.27 03:06:18 INFO - mozrunner == 6.11 03:06:18 INFO - mozscreenshot == 0.1 03:06:18 INFO - mozsystemmonitor == 0.0 03:06:18 INFO - moztest == 0.7 03:06:18 INFO - mozversion == 1.4 03:06:18 INFO - psutil == 3.1.1 03:06:18 INFO - requests == 1.2.3 03:06:18 INFO - wsgiref == 0.1.2 03:06:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:06:18 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')]} 03:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:18 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')]} 03:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:18 INFO - Using env: {'DISPLAY': ':0', 03:06:18 INFO - 'HOME': '/home/cltbld', 03:06:18 INFO - 'LANG': 'en_US.UTF-8', 03:06:18 INFO - 'LANGUAGE': 'en_US:en', 03:06:18 INFO - 'LOGNAME': 'cltbld', 03:06:18 INFO - 'MAIL': '/var/mail/cltbld', 03:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:18 INFO - 'MOZ_NO_REMOTE': '1', 03:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:18 INFO - 'NO_EM_RESTART': '1', 03:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:18 INFO - 'SHELL': '/bin/bash', 03:06:18 INFO - 'SHLVL': '1', 03:06:18 INFO - 'TERM': 'linux', 03:06:18 INFO - 'TMOUT': '86400', 03:06:18 INFO - 'USER': 'cltbld', 03:06:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:18 INFO - '_': '/tools/buildbot/bin/python'} 03:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:18 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 1)) 03:06:18 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 2)) 03:06:18 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 3)) 03:06:18 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 4)) 03:06:18 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 5)) 03:06:18 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 6)) 03:06:18 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 7)) 03:06:18 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 8)) 03:06:18 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:06:18 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 3)) 03:06:18 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:06:18 INFO - Cleaning up... 03:06:18 INFO - Return code: 0 03:06:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:06:18 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')]} 03:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:18 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')]} 03:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:18 INFO - Using env: {'DISPLAY': ':0', 03:06:18 INFO - 'HOME': '/home/cltbld', 03:06:18 INFO - 'LANG': 'en_US.UTF-8', 03:06:18 INFO - 'LANGUAGE': 'en_US:en', 03:06:18 INFO - 'LOGNAME': 'cltbld', 03:06:18 INFO - 'MAIL': '/var/mail/cltbld', 03:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:18 INFO - 'MOZ_NO_REMOTE': '1', 03:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:18 INFO - 'NO_EM_RESTART': '1', 03:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:18 INFO - 'SHELL': '/bin/bash', 03:06:18 INFO - 'SHLVL': '1', 03:06:18 INFO - 'TERM': 'linux', 03:06:18 INFO - 'TMOUT': '86400', 03:06:18 INFO - 'USER': 'cltbld', 03:06:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:18 INFO - '_': '/tools/buildbot/bin/python'} 03:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:19 INFO - Downloading/unpacking jsonschema 03:06:19 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 03:06:19 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 03:06:19 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 03:06:19 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 03:06:19 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 03:06:19 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 03:06:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:20 INFO - Downloading/unpacking functools32 (from jsonschema) 03:06:20 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 03:06:20 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 03:06:20 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 03:06:20 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 03:06:20 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 03:06:20 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 03:06:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:21 INFO - warning: no files found matching '*.txt' 03:06:21 INFO - no previously-included directories found matching 'build' 03:06:21 INFO - no previously-included directories found matching 'dist' 03:06:21 INFO - no previously-included directories found matching '.git*' 03:06:21 INFO - Installing collected packages: jsonschema, functools32 03:06:21 INFO - Running setup.py install for functools32 03:06:21 INFO - warning: no files found matching '*.txt' 03:06:21 INFO - no previously-included directories found matching 'build' 03:06:21 INFO - no previously-included directories found matching 'dist' 03:06:21 INFO - no previously-included directories found matching '.git*' 03:06:21 INFO - Successfully installed jsonschema functools32 03:06:21 INFO - Cleaning up... 03:06:21 INFO - Return code: 0 03:06:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:06:21 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')]} 03:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:21 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')]} 03:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1146759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b48600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', '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 03:06:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:06:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:06:21 INFO - Using env: {'DISPLAY': ':0', 03:06:21 INFO - 'HOME': '/home/cltbld', 03:06:21 INFO - 'LANG': 'en_US.UTF-8', 03:06:21 INFO - 'LANGUAGE': 'en_US:en', 03:06:21 INFO - 'LOGNAME': 'cltbld', 03:06:21 INFO - 'MAIL': '/var/mail/cltbld', 03:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:21 INFO - 'MOZ_NO_REMOTE': '1', 03:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:21 INFO - 'NO_EM_RESTART': '1', 03:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:21 INFO - 'SHELL': '/bin/bash', 03:06:21 INFO - 'SHLVL': '1', 03:06:21 INFO - 'TERM': 'linux', 03:06:21 INFO - 'TMOUT': '86400', 03:06:21 INFO - 'USER': 'cltbld', 03:06:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:21 INFO - '_': '/tools/buildbot/bin/python'} 03:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:21 INFO - Downloading/unpacking flake8 03:06:21 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 03:06:21 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 03:06:21 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 03:06:21 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 03:06:21 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 03:06:21 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 03:06:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:06:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:06:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 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 03:06:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:06:23 INFO - no previously-included directories found matching 'docs/_build' 03:06:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:06:24 INFO - Running setup.py install for pep8 03:06:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:06:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:06:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:06:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:06:24 INFO - no previously-included directories found matching 'docs/_build' 03:06:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:06:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:06:24 INFO - Cleaning up... 03:06:24 INFO - Return code: 0 03:06:24 INFO - Running post-action listener: _resource_record_post_action 03:06:24 INFO - Running post-action listener: _start_resource_monitoring 03:06:24 INFO - Starting resource monitoring. 03:06:24 INFO - ##### 03:06:24 INFO - ##### Running install step. 03:06:24 INFO - ##### 03:06:24 INFO - Running pre-action listener: _resource_record_pre_action 03:06:24 INFO - Running main action method: install 03:06:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:06:24 INFO - Reading from file tmpfile_stdout 03:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:06:24 INFO - Reading from file tmpfile_stdout 03:06:24 INFO - Output received: 03:06:24 INFO - Usage: mozinstall [options] installer 03:06:24 INFO - Options: 03:06:24 INFO - -h, --help show this help message and exit 03:06:24 INFO - -d DEST, --destination=DEST 03:06:24 INFO - Directory to install application into. [default: 03:06:24 INFO - "/builds/slave/test-pgo"] 03:06:24 INFO - --app=APP Application being installed. [default: firefox] 03:06:24 INFO - mkdir: /builds/slave/test-pgo/build/application 03:06:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:06:39 INFO - Reading from file tmpfile_stdout 03:06:39 INFO - Output received: 03:06:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:06:39 INFO - Running post-action listener: _resource_record_post_action 03:06:39 INFO - ##### 03:06:39 INFO - ##### Running run-tests step. 03:06:39 INFO - ##### 03:06:39 INFO - Running pre-action listener: _resource_record_pre_action 03:06:39 INFO - Running main action method: run_tests 03:06:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:06:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:06:39 INFO - Python 2.7.3 03:06:39 INFO - Return code: 0 03:06:39 INFO - grabbing minidump binary from tooltool 03:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:39 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 0x1bd7350>, '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 0x1bd8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd86e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:06:39 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 03:06:39 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 03:06:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:06:39 INFO - Return code: 0 03:06:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:06:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:06:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:06:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:06:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:06:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:06:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:06:40 INFO - Return code: 0 03:06:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:06:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 03:06:40 INFO - Using env: {'DISPLAY': ':0', 03:06:40 INFO - 'HOME': '/home/cltbld', 03:06:40 INFO - 'LANG': 'en_US.UTF-8', 03:06:40 INFO - 'LANGUAGE': 'en_US:en', 03:06:40 INFO - 'LOGNAME': 'cltbld', 03:06:40 INFO - 'MAIL': '/var/mail/cltbld', 03:06:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:06:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:40 INFO - 'MOZ_NO_REMOTE': '1', 03:06:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:40 INFO - 'NO_EM_RESTART': '1', 03:06:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:06:40 INFO - 'SHELL': '/bin/bash', 03:06:40 INFO - 'SHLVL': '1', 03:06:40 INFO - 'TERM': 'linux', 03:06:40 INFO - 'TMOUT': '86400', 03:06:40 INFO - 'USER': 'cltbld', 03:06:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845', 03:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:40 INFO - '_': '/tools/buildbot/bin/python'} 03:06:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 03:06:40 INFO - mozversion INFO | application_buildid: 20160124004010 03:06:40 INFO - mozversion INFO | application_changeset: 7ede46ba62979809bafb3c1507745a4eeaec1c57 03:06:40 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:06:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:06:40 INFO - mozversion INFO | application_name: Firefox 03:06:40 INFO - mozversion INFO | application_remotingname: firefox-dev 03:06:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:06:40 INFO - mozversion INFO | application_vendor: Mozilla 03:06:40 INFO - mozversion INFO | application_version: 45.0a2 03:06:40 INFO - mozversion INFO | platform_buildid: 20160124004010 03:06:40 INFO - mozversion INFO | platform_changeset: 7ede46ba62979809bafb3c1507745a4eeaec1c57 03:06:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:06:40 INFO - mozversion INFO | platform_version: 45.0a2 03:06:40 INFO - 2016-01-24 03:06:40,462 DEBUG : using testdate: 1453633600 03:06:40 INFO - 2016-01-24 03:06:40,462 DEBUG : actual date: 1453633600 03:06:40 INFO - 2016-01-24 03:06:40,470 INFO : starting webserver on 'localhost:54211' 03:06:40 INFO - 2016-01-24 03:06:40,471 INFO : Starting test suite talos-linux64-ix-060 03:06:40 INFO - 2016-01-24 03:06:40,472 INFO : Starting test dromaeo_css 03:06:40 INFO - 2016-01-24 03:06:40,472 DEBUG : operating with platform_type : linux_ 03:06:40 INFO - 2016-01-24 03:06:40,472 INFO : Initialising browser for dromaeo_css test... 03:06:40 INFO - 2016-01-24 03:06:40,486 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppGnW8j/profile http://localhost:54211/getInfo.html 03:06:44 INFO - 2016-01-24 03:06:44,505 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:06:44 INFO - 2016-01-24 03:06:44,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:06:44 INFO - 2016-01-24 03:06:44,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:06:44 INFO - 2016-01-24 03:06:44,505 DEBUG : BROWSER_OUTPUT: __metrics 03:06:44 INFO - 2016-01-24 03:06:44,674 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:06:45 INFO - 2016-01-24 03:06:45,490 INFO : Browser initialized. 03:06:45 INFO - 2016-01-24 03:06:45,491 INFO : Running cycle 1/1 for dromaeo_css test... 03:06:45 INFO - 2016-01-24 03:06:45,491 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppGnW8j/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:06:57 INFO - 2016-01-24 03:06:57,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 137297920 03:06:57 INFO - 2016-01-24 03:06:57,276 DEBUG : BROWSER_OUTPUT: 03:07:49 INFO - 2016-01-24 03:07:49,077 DEBUG : BROWSER_OUTPUT: 1453633669073 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] 03:09:56 INFO - 2016-01-24 03:09:56,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54211/tests/dromaeo/cssquery-ext.html) 03:09:57 INFO - 2016-01-24 03:09:57,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 260583424 03:09:57 INFO - 2016-01-24 03:09:57,477 DEBUG : BROWSER_OUTPUT: 03:12:59 INFO - 2016-01-24 03:12:59,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-ext.html (next: http://localhost:54211/tests/dromaeo/cssquery-jquery.html) 03:13:00 INFO - 2016-01-24 03:13:00,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 218976256 03:13:00 INFO - 2016-01-24 03:13:00,316 DEBUG : BROWSER_OUTPUT: 03:16:02 INFO - 2016-01-24 03:16:02,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54211/tests/dromaeo/cssquery-mootools.html) 03:16:02 INFO - 2016-01-24 03:16:02,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 212537344 03:16:02 INFO - 2016-01-24 03:16:02,678 DEBUG : BROWSER_OUTPUT: 03:19:04 INFO - 2016-01-24 03:19:04,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54211/tests/dromaeo/cssquery-prototype.html) 03:19:04 INFO - 2016-01-24 03:19:04,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 200466432 03:19:04 INFO - 2016-01-24 03:19:04,988 DEBUG : BROWSER_OUTPUT: 03:22:07 INFO - 2016-01-24 03:22:07,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54211/tests/dromaeo/cssquery-yui.html) 03:22:07 INFO - 2016-01-24 03:22:07,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 200830976 03:22:07 INFO - 2016-01-24 03:22:07,958 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-yui.html (next: http://localhost:54211/tests/dromaeo/cssquery-dojo.html) 03:25:10 INFO - 2016-01-24 03:25:10,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 247386112 03:25:10 INFO - 2016-01-24 03:25:10,394 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,394 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:25:10 INFO - 2016-01-24 03:25:10,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:25:10 INFO - 2016-01-24 03:25:10,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:25:10 INFO - 2016-01-24 03:25:10,395 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:25:10 INFO - 2016-01-24 03:25:10,395 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3274.099622603784;3311.0728995881163;3339.7996120232788;3367.5453813735153;3393.4570468725;5285;5305.495977882095;5336.092864213083;5341.572674186065;5343.866403339918;5381.757820898059;5409.702466364358;5413.404525502192;5427;5436.75534600943;4831.975840120795;4930.063287975291;4964.70211787293;4991.276264941581;5022.347094877679;4969.62727795415;5036.597072234213;5039.798408063673;5052.9747351263195;5055.342805435306;4986.127427700156;5024.271480635306;5026.52248036436;5031.371078615173;5034.370703662043;4798.328234047236;4925.507449255082;5019.47295533971;5022.799088036474;5023.974880125613;4938;5020.548150666421;5033.597312215014;5037.345145131109;5062.2406639004075;5004.399472063339;5091.389033315989;5140.460251673558;5222.63441559091;5291.867703307448;5761.88476230473;5813.912791308091;5815.505682017034;5815.912761308584;5838.4453476919625;5800.680962547058;5830.970845145789;5834.708264586754;5834.766609335621;5837.328707198684;5288.524032837025;5421.918671219935;5432.266644003088;5438.592105592057;5543.196236545678;5842.357340692521;5855.092460668603;5855.297364316224;5878.382769809108;5887.999040163182;5683.346415162227;5693.231413759172;5696.914546281809;5722.313322401338;5746.770129194869;5651.8304450866535;5741.425857414225;5755.884882302331;5764.855878602984;5790.218320526759;5740.885182296414;5752.7698892043845;5753.021986262345;5760.049591817387;5851.356350801409;5708.828735137952;5752.165935939265;5753.367129615739;5768.480836724715;5772.5670574707065;4356.912861742748;4391.121775644884;4465.330200469891;4485.0805584855025;4487.842925497657;4075.49056367954;4088.34093486334;4092.6725861930972;4093.1813637272667;4115.814788334532;5559.972200139055;5563.499285064364;5569.805056823073;5578.553715702815;5593.300837395325;5555.611107222456;5651.0675738503505;5793.884122317614;5859.501942334864;5885.028970219866;5479.643823151562;5490.286262785812;5491.121420572689;5500.22996780451;5503.9174412383845;5067.822626208139;5088.643794934319;5088.821891233789;5094.465081166498;5103.668261562986;5736.942630573724;5844.415558444207;5947.613405128653;5970.671613061323;6071.180390647206;5870.236869206976;5873.089671100986;5883.676397798162;5886.05823068307;5889.49939255151;6004.87990240184;6044.365341639241;6057.545684073624;6061.030235162353;6062.575619706755;5553.805616803393;5608.663480191201;5659.03796354629;5710.685912274865;5726.513246373938;5752.568557358131;5829.3296270927685;5854.648721076749;5870.882582348244;5872.383399742966;5546.389897111234;5735.627184233012;5755.65466072037;5758.337791153904;5760.33756118035;5582.358028826737;5643.068893632505;5653.660780353192;5658.094704847204;5683.772649094155;5595.944040559705;5619.859503512282;5634.098544232903;5641.492265696107;5641.576881733804;5535.446455354593;5592.720363981866;5687.544996400361;5691.288588926384;5698.373178950395;5456.727163641723;5525.751341189576;5533.114701647717;5538.556915446674;5553.916691249715 03:25:10 INFO - 2016-01-24 03:25:10,395 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.2520634952339;609.6585911889342;612.4396177497591;614.2046050364783;616.8581226317947;32418.67581324186;40693.59306406935;41073.17853642929;41107.58892411075;41135.79432102843;44626.33060504087;45374.54625453745;45551;45641.31538026924;45724;8139.95930020352;8251.793705157359;9181.540922953842;9367.15695587397;10477;10901.34591924487;10949.562017519289;11053.336799792038;11057.447127643625;11067.833982490269;10946.616868409568;10973.177011724112;10983;11093.223474356799;11097.056750176245;8329.33365330772;8547.10255423181;10727.731806704816;10990.560377584887;11018.44907754609;10711.892881071246;10834.945825270823;10868.565257389695;10878.945605272002;10883.455827208609;42922.57077429217;43321.56678433207;43376.78311608453;43460.78269608632;43480.347794783105;3608.5308909841815;3639.1266096137;3666.5600127984544;4045.2314060328445;4264.0832221072615;31917.84041079803;32157.83921080403;32175.51736723951;32861.50707739386;33695.663043369495;3550.520679708258;3566.465030245458;3592.982035089834;3614.8554057837655;3630.7836874647023;294793;299070;299408;299745;458441.70779146225;51968;67701.3229867705;68601.31398686049;68680.31319686839;68800.3119968804;59232;59759.40240597625;59864.40135598588;59899.401005989384;59967.70016149891;17485.388011419538;17653.20560574777;17669.20488578017;17670.91164544195;17681.646367072586;13672.384742686603;13919.443222270997;13925.164490130624;13938.094023888414;13951.790723139162;19852.60294794096;20306.18775249003;20333.89833050825;20338.491537711674;20397.18411263533;7490.475666703387;7675.279702982625;7706.190849960785;7783.766487005399;7788.454808163374;996.367306760198;1065.9040686338267;1100.9009189173014;1132.4451019000794;1215.0522592377959;29907.252318692208;30385.987674342996;31328;32099.679003210134;32559;1085.1535802074395;1095.5453486803046;1100.4497751124438;1125.9774804503863;1213.5691829400612;12666.873331266754;13751.656208594864;13758.005089262;14810.703785924437;15564.766528502081;265510;268754;268925;269457;269868;49476.50523494791;49536.50463495391;49565.75217123891;49576.752116239906;49667;1325.5890673891124;1359.5989183190982;1400.5098215624653;1448.5364683301243;1449.173970836634;27937.44125117527;28011.0196143134;28339.291517711397;28463.573046403908;28815.135545933656;43133.784331078146;43536.346954795066;43567.12865742731;45440.31839522476;46311.76844115893;414218;418134;423491;424549;424648;30740.23149421193;31151.376972460876;31169.8441507791;31174.844125779226;31181.53227701632;44149.77925110354;44848.10303793971;45066.32400513929;45954.770226148656;46091.30863037124;36413.81793091124;36633.45049824308;37620.05949851275;37888.81055594704;37899.81050094732;36693;37435.43846842245;38174.61825381822;38280;38375.42436863505;37898.24203515859;38199;38455.80772096122;38713.80643096766;38888.22223555457;29504.262393440335;33069.83465082659;34134.487982679784;34504.96485105451;34791.304173916884;25847.483050339262;26610.600840987787;26659;26683.199504014912;26710.59934100951 03:25:10 INFO - 2016-01-24 03:25:10,395 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.9259144466829;379.94300854871767;383.0920717898579;386.1639550373442;390.6542709701915;14797.482088126892;16337.509874703777;17910.820891791078;19857.900710496426;19887;10863.18526110541;11113.388763617997;11117;18779.718304225415;19218.80781192191;5063.41770696371;5169.121249387595;5172.120739474299;5177.119889618755;5178.8705282368055;3761.755485893422;3850.7304488685804;5163.922541161867;5425.6202065855405;5584.776608935637;5524.33707955044;5543.196236545698;5548.77804887804;5563.860903477425;5571.192177134313;5514.531264842493;6154.784582539634;6157.599756015889;6163.66099864505;6175.289841668198;5471.671699698031;5486.972565137149;5495.945040549584;5501.14732216507;5507.5593952483705;12760.106792524526;13045.152065115737;13104.344782760823;13734.931325343408;22181.667274990887;2324.732655744594;2363.243761996162;2396.748341424143;2473.5423946569763;2509.6611957385885;9727.221822254203;9873.60505579776;10006.9499652502;11247.887521124847;14210.644733881632;1927.4314077347217;1934.8935808530525;1972.960540789176;1988.443235893952;2007.688808234726;64683.3531664682;65976.67011664911;66336.66831665859;68000.3199967999;68137.65931170313;10967.232293739362;11011.669649910515;11015.779684406267;11019.669409917715;11031.779364412827;14444.711105777826;14515.129092254287;14529.055611385225;14535.78196327056;14550.054246473945;8241.670333186605;8282.420230583923;8309.127541608164;8349.791255218668;8369.121242269473;8061.113277539466;8074.515529068275;8094.716684915999;8141.307988821017;8170.673173073129;4719.457262414798;4763.428388593391;4777.8088876445245;4824.879378015507;4842.273658951185;1676.91615419231;1804.6300508395748;1813.7098064309648;1838.5587459009741;1906.7997860224755;948.5446985447024;968.6416026070258;1022.2333250062453;1065.63235683689;1076.3757020927842;15412;17456.738148927776;17488;17940.551486212687;18368.35710750144;957.2150836314295;981.1365997921783;981.7153025622632;1044.1907521670614;1055.6885718712997;9966.80066398668;10323.225758068025;10338;10436.686899393031;10446;675582;679144;686186;694252;699088;85635.5718221405;88723.55638221768;89174;89636;93584.53207734054;1191.314993878506;1192.9045676345872;1196.1208511743862;1198.02361075723;1209.0508950473836;15664.92167539155;16088.276027578553;16518.504444866674;16664.50006499807;16821.07484088338;37813.81093094627;38200.426993595676;38445;38756.224875501764;39522.60477395189;47182.76408617935;48131.75934120307;48599.51400486091;49244.753776232326;52842;9780.755481112745;10209.183265338606;10212.183025358103;10223.897761022294;10426.582936682447;11871.643850684493;12151.878481215075;12191.08566857507;12225.410696609384;12993.4152963115;15172;15188.772168417703;15454.304556294768;15592.298346574204;15648.139352335731;14728.705425891636;15018.549443516711;15099.471518496799;15317.693646127238;15428.30572624212;15433.614159646098;15581.688366232838;15603.219839007777;15865.127417992122;15974.121423321829;10213.74465638365;10213.948930255301;10215.080642742189;10221.488925553842;10415.739606509595;15151.090934543963;15262.847371526143;15421.768673470131;15425.228738562802;15464.304106315469 03:25:10 INFO - 2016-01-24 03:25:10,396 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1361.0540674231413;1769.6195318006628;1802.593099042809;1832.871698981071;1833.6424397242536;7141.321574450425;7863.213678632134;8212.630431630576;8225.012998440188;8228.136045715204;8144.959275203631;8306;8308.459950103254;8313.875291870612;8317.708880189195;1985.2257619528395;2016.4253187841468;2326.1858349577683;2342.1451170322794;2387.617981123021;2366;2370.229675355508;2371.3834403055243;2371.9525609487887;2378.702662167229;2272.943176420586;2340.918067867625;2342.051469154995;2343.238447504559;2345.8006069484113;2326.8603883766946;2329.26628112145;2365.988170059156;2366.25462979161;2367;2367.644853272023;2374.7625237476286;2392.0910054179476;2394.820388470872;2409.9397515062087;8160.9591952040455;8311.459755115899;8316.043654979694;8317.293030092389;8323.958380208122;4920.852374428737;4973.15456372414;5029.4216165141115;5042.823501177441;5048.9495105048845;3067.3558552703958;3088.861001254949;3134.5611614374006;3169.635491918436;3194.105650417887;1027.1936529824127;1027.6095083868156;1048.9003544663244;1049.826778581533;1061.050359927868;11641.126915481289;11664.416779161093;11670.124740644485;11681.415929203591;11689.06487481008;4345.152695224401;4449.9777501112285;4516.277395616686;4544.977275113603;4577.702449340783;9329.440233586007;9362.34463587556;9391.577379017961;9398.577064031999;9404.24766018717;4994.200927851526;5046.268291097844;5047.823326183639;5048.747562621854;5052.444231134572;4588.839390621379;4644.071185762861;4654.767261636905;4658.184817656965;4662.417197850269;3266.1671273825023;3313.122022663996;3372.578427696538;3390.6439823818637;3518.419460788992;1066.1204506282347;1098.7198264442516;1098.9725256868642;1114.8216285394299;1116.7598966222301;1140.7319279969201;1148.3282279866205;1156.3177725142207;1321.8281623388898;1377.5867239828012;7733.8453230935065;7799.298063174341;7878.763637090897;7889.605519724106;7899.091604465445;591.7721677154327;593.7506247376112;603.6891001134419;664.2162248546762;797.7487091566138;5934.851628709317;5946.672932988728;6039;6049.304330002018;6058.939410605837;9803.264755143393;9932.10611044995;10037.598496060076;10074.395536267848;10091.44497052669;9709;9778.755531111638;9957.153641940371;10071.143952764098;10091.344062635904;7829.7259595913865;7886.802829929297;7939.2060793920145;7941.682332706627;7953.5227886327;7461.291177338144;7591.658375373232;7598.0502437195355;7600.3539699126195;7602.7339043133225;8842.46945183291;8887.688930887389;8933.330000250136;8958.910410895807;9039.638414463348;9045.819083618422;9138.862917056116;9300.627974880928;9336.813263734823;9371.34400591952;7001.089858318386;7006.509544331848;7008.159020917318;7080.114985626797;7117.466190035664;6684.197896252481;7072.893906591508;7536.434767392358;7674.808129796576;7679.040119985002;7567.31894129531;7611.543307401574;7642.847143057219;7684.538927664358;7707.267809558083;7492.850142997218;7512.887306690294;7528.397728181842;7597.126330471845;7605;7505.962470187614;7598.468107232441;7612.885806712793;7626.58053807046;7637.541747495168;6988.091548098715;6997.790066298019;7011.474139439664;7021.332973367522;7037.401820845081;6693.129893114059;6988.126484189476;7067.151941767021;7090.113735783028;7099.822504437224 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.59681366428606;357.8461261657486;359.68886912820403;367.5864652266199;373.0580284780928;6063.6058656187315;6077.817665470037;6103.786367477139;6116.9295373309715;6132.233470816137;5733.48398644122;5834.56240781942;5875.2949646042425;6043.395660433955;6044.24446944132;4718.079974404993;4719.952800471986;4724.45668748095;4735;4735.3844000280005;4456.866294011184;4744.762761861911;4747.76261186941;4764.595009424203;4767.713937163764;4505.076459325846;4594.494605593382;4667.509911459299;4703.412073490814;4714.4106986626675;4650.279206722963;4678.789454474557;4682.648801339913;4687.1328804171335;4692.718436893797;4167.791610419466;4174.812133454002;4177.749335039907;4177.8328866845595;4179.435776170209;5666.093425052013;5775.422457754233;5780.132980052984;5784.479396854261;5785.6528608283215;5433.402325744165;5434.701091439969;5434.782608695687;5439.401665816757;5444.101723215665;6458.741650333981;6461.418472337512;6461.483081353481;6462.739765745681;6467.74129034838;4549.135664223787;4555.180067587833;4556.066006468699;4560.931586026212;4571.994161284512;6527.543071984963;6585.275619681831;6648.66756662165;6665.233498147727;6667.666616669196;4663.836765713251;4668.906621867543;4669.976650116728;4670.906581868344;4675.485696573374;4729.219678752967;4729.597984171384;4730;4734.360861283682;4734.958309171977;5416.485433883775;5424.647397919122;5427.213054107132;5428.240046393508;5428.37573679032;6235.438810507076;6418.807435776934;6435.452986496107;6438.45273151778;6483.773067942694;1639.4098124675108;1674.2382216091648;1674.2800595743704;1675.1205617050903;1675.2293944785292;1130.9434528273553;1135.3528488761326;1142.5486932661552;1158.1661203933154;1161.4076820821442;6298.968505157536;6309.211348581427;6310.211223597051;6314.210723659543;6316.336784637639;6454.483641308684;6712.127423434922;6713.12729345182;6720.0255962886085;6723.966380168068;6152.661603611844;6198.783042593487;6283.151774510474;6286.717097730613;6292.244930608356;3524.9295014099575;3593.083763640307;3613.2050948791225;3627.6190999944624;3647.2887786881834;6833.726650933907;6961.443084553223;6982.546134501241;6984.965075174591;6987.161540615057;6890.586564806128;6913.51605387618;6916.861662766716;6918;6918.342757438036;6961.060256865359;6978.197507286727;6978.755743548952;6979.406750426169;6980.267071957473;6627.569208001464;6731.225909020525;6733.091032710521;6742.6628668567355;6742.831429214113;6618.834529136618;6622.37087476689;6624.56940298879;6629.2376376715365;6632.1709786276715;6954.095967524189;6965.303469653197;6968.0941477607585;6971.058907047483;6977.058097157022;4584.656150788771;4680.368150299802;4682.41469816273;4683.250679891201;4689.132510485571;6703.899441508479;6708.899366509604;6723.058771772054;6725.461963042847;6726.091977582963;6542.672866356568;6557.967210163919;6558.049082883051;6558.409743123142;6559.639219842955;6421.8073457796345;6501.934980650133;6532.8366790830605;6541.051547525487;6547.345265473415;6437.25971513282;6443.67781610927;6445.0332450132855;6449.419552240321;6449.677516124269;6543.738250469928;6552.737890484518;6568.113304703804;6569.113169722217;6573.901391479036;6305;6404.583702059351;6418.422341989243;6427.807165785034;6430.614163150226 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: |5;yui.html;771.1632878327015;863.7840539865034;865.9523726195057;868.8522951098313;879.4327658660167;14653.194074325907;14850.405983760651;14937.626559336022;14974.32615532301;14974.475893343722;13739.381727822247;14456.13263204206;14467.710645787078;14485.92757036216;14509.056911300784;763.9732609358673;769.1808224241165;904.276578737011;906.7370462565881;922.3082687984012;903.5933829776594;904.7195369435464;912.2975309012056;912.5300470257822;913.3332667152982;935.2004036548755;936.2089034765612;937.1752857485403;937.4562753602894;937.7561833923161;778.1129512355891;781.8201813582851;943.1417410156724;945.4941606240697;948.2793077261263;701.5019336271254;702.0767690487045;703.1843062048;703.282651695268;705.28413660135;14202.573922782332;14213.50252741149;14282.714345713131;14318.069325493809;14340.42638294467;12497.437615307334;13214;13395.933020334836;13402.128861623964;13448.152063346459;10079.344842585282;10138.695839124837;10436.37381757097;10465;10518.737031574195;3676.7977761223124;3714.758540694846;3745.925081498382;3746.2132952080096;3753.4932784074344;47753;47781.28328075082;47879.28181077287;47955.5204447958;48252.51747482515;9882.604695812088;9909.157721593601;9913.553890074963;10912.127029837595;11149.275297105662;19017.33439329617;19175.61648767017;19250.326238581583;19330.903345483464;19366.32217872396;7732.265434783687;7754.263344982218;7853.646585903648;7872.842543149105;8063.798405039804;4420.425344705168;4456.376107344974;4575.450945886515;4588.334691469785;4668.85993420198;3277.737780977516;3296.159479332755;3296.7032967033083;3297.4888892221743;3300.851461684182;576.824068659063;589.7257775134498;591.9822405327847;593.2288025566746;598.7335635642097;673.7237732529737;697.3235961117708;703.7936070419171;704.1972151747012;728.8287252495659;9571.521423928776;9603.423794572209;9900.207983361313;10138.645147419806;10250.846237306447;575.4906907386909;590.9172715819789;594.5273507561499;702.9261927497641;715.4634024481638;4059.837606495766;4093.3655283431117;4144.295469770146;4147.771872546979;4254;58919.41080589139;59128.704356477945;59275.70362148162;59323.70338148368;59595;52338;52689.2096618551;52816.207756883676;53208.73395633075;53499.73250133725;46198.53801461942;46492.76753616278;46540.76729616398;47663.5233647666;48617;7980.960095199487;8155.10293867686;8165.836683266182;8206.384521161057;8236.876446853183;35059.12352191216;35665.930022099375;35699;36101;36793.816030919676;42088;45562;46511.53488465072;47084.52915470801;47227.76386118047;9842.114209720872;11526.942365288456;11951;12027.398630068637;12181;12921;12947.093703440669;13015.349232538525;13022.218666880017;13137.802932956205;11198.664040078811;11649.184557080924;11915.82126268124;12264.141510094209;12485.56300529477;11274.436278185894;11316.83024754613;11509.827352589886;11812.70468238301;11873.881261187624;11702;11879.109066820196;11984.46069926838;12118.878811211775;12372.752544948871;10410.895891040993;10462.581496740046;10577.365358078232;10731.89268107309;10839.723658031902;10304.742381440525;10421;10432.687019389126;10453.738656533647;10503.94748026255 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: __startTimestamp1453634710387__endTimestamp 03:25:10 INFO - 2016-01-24 03:25:10,400 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,401 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:25:10 INFO - 2016-01-24 03:25:10,401 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:25:10 INFO - 2016-01-24 03:25:10,401 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,401 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5394.07 Median:5578.55 stddev:568.99 (10.2%) stddev-sans-first:545.89 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: Values: 3274.1 3311.1 3339.8 3367.5 3393.5 5285.0 5305.5 5336.1 5341.6 5343.9 5381.8 5409.7 5413.4 5427.0 5436.8 4832.0 4930.1 4964.7 4991.3 5022.3 4969.6 5036.6 5039.8 5053.0 5055.3 4986.1 5024.3 5026.5 5031.4 5034.4 4798.3 4925.5 5019.5 5022.8 5024.0 4938.0 5020.5 5033.6 5037.3 5062.2 5004.4 5091.4 5140.5 5222.6 5291.9 5761.9 5813.9 5815.5 5815.9 5838.4 5800.7 5831.0 5834.7 5834.8 5837.3 5288.5 5421.9 5432.3 5438.6 5543.2 5842.4 5855.1 5855.3 5878.4 5888.0 5683.3 5693.2 5696.9 5722.3 5746.8 5651.8 5741.4 5755.9 5764.9 5790.2 5740.9 5752.8 5753.0 5760.0 5851.4 5708.8 5752.2 5753.4 5768.5 5772.6 4356.9 4391.1 4465.3 4485.1 4487.8 4075.5 4088.3 4092.7 4093.2 4115.8 5560.0 5563.5 5569.8 5578.6 5593.3 5555.6 5651.1 5793.9 5859.5 5885.0 5479.6 5490.3 5491.1 5500.2 5503.9 5067.8 5088.6 5088.8 5094.5 5103.7 5736.9 5844.4 5947.6 5970.7 6071.2 5870.2 5873.1 5883.7 5886.1 5889.5 6004.9 6044.4 6057.5 6061.0 6062.6 5553.8 5608.7 5659.0 5710.7 5726.5 5752.6 5829.3 5854.6 5870.9 5872.4 5546.4 5735.6 5755.7 5758.3 5760.3 5582.4 5643.1 5653.7 5658.1 5683.8 5595.9 5619.9 5634.1 5641.5 5641.6 5535.4 5592.7 5687.5 5691.3 5698.4 5456.7 5525.8 5533.1 5538.6 5553.9 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51260.58 Median:34319.73 stddev:91457.94 (266.5%) stddev-sans-first:91635.28 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: Values: 560.3 609.7 612.4 614.2 616.9 32418.7 40693.6 41073.2 41107.6 41135.8 44626.3 45374.5 45551.0 45641.3 45724.0 8140.0 8251.8 9181.5 9367.2 10477.0 10901.3 10949.6 11053.3 11057.4 11067.8 10946.6 10973.2 10983.0 11093.2 11097.1 8329.3 8547.1 10727.7 10990.6 11018.4 10711.9 10834.9 10868.6 10878.9 10883.5 42922.6 43321.6 43376.8 43460.8 43480.3 3608.5 3639.1 3666.6 4045.2 4264.1 31917.8 32157.8 32175.5 32861.5 33695.7 3550.5 3566.5 3593.0 3614.9 3630.8 294793.0 299070.0 299408.0 299745.0 458441.7 51968.0 67701.3 68601.3 68680.3 68800.3 59232.0 59759.4 59864.4 59899.4 59967.7 17485.4 17653.2 17669.2 17670.9 17681.6 13672.4 13919.4 13925.2 13938.1 13951.8 19852.6 20306.2 20333.9 20338.5 20397.2 7490.5 7675.3 7706.2 7783.8 7788.5 996.4 1065.9 1100.9 1132.4 1215.1 29907.3 30386.0 31328.0 32099.7 32559.0 1085.2 1095.5 1100.4 1126.0 1213.6 12666.9 13751.7 13758.0 14810.7 15564.8 265510.0 268754.0 268925.0 269457.0 269868.0 49476.5 49536.5 49565.8 49576.8 49667.0 1325.6 1359.6 1400.5 1448.5 1449.2 27937.4 28011.0 28339.3 28463.6 28815.1 43133.8 43536.3 43567.1 45440.3 46311.8 414218.0 418134.0 423491.0 424549.0 424648.0 30740.2 31151.4 31169.8 31174.8 31181.5 44149.8 44848.1 45066.3 45954.8 46091.3 36413.8 36633.5 37620.1 37888.8 37899.8 36693.0 37435.4 38174.6 38280.0 38375.4 37898.2 38199.0 38455.8 38713.8 38888.2 29504.3 33069.8 34134.5 34505.0 34791.3 25847.5 26610.6 26659.0 26683.2 26710.6 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33619.47 Median:10915.43 stddev:112243.23 (1028.3%) stddev-sans-first:112530.35 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: Values: 379.9 379.9 383.1 386.2 390.7 14797.5 16337.5 17910.8 19857.9 19887.0 10863.2 11113.4 11117.0 18779.7 19218.8 5063.4 5169.1 5172.1 5177.1 5178.9 3761.8 3850.7 5163.9 5425.6 5584.8 5524.3 5543.2 5548.8 5563.9 5571.2 5514.5 6154.8 6157.6 6163.7 6175.3 5471.7 5487.0 5495.9 5501.1 5507.6 12760.1 13045.2 13104.3 13734.9 22181.7 2324.7 2363.2 2396.7 2473.5 2509.7 9727.2 9873.6 10006.9 11247.9 14210.6 1927.4 1934.9 1973.0 1988.4 2007.7 64683.4 65976.7 66336.7 68000.3 68137.7 10967.2 11011.7 11015.8 11019.7 11031.8 14444.7 14515.1 14529.1 14535.8 14550.1 8241.7 8282.4 8309.1 8349.8 8369.1 8061.1 8074.5 8094.7 8141.3 8170.7 4719.5 4763.4 4777.8 4824.9 4842.3 1676.9 1804.6 1813.7 1838.6 1906.8 948.5 968.6 1022.2 1065.6 1076.4 15412.0 17456.7 17488.0 17940.6 18368.4 957.2 981.1 981.7 1044.2 1055.7 9966.8 10323.2 10338.0 10436.7 10446.0 675582.0 679144.0 686186.0 694252.0 699088.0 85635.6 88723.6 89174.0 89636.0 93584.5 1191.3 1192.9 1196.1 1198.0 1209.1 15664.9 16088.3 16518.5 16664.5 16821.1 37813.8 38200.4 38445.0 38756.2 39522.6 47182.8 48131.8 48599.5 49244.8 52842.0 9780.8 10209.2 10212.2 10223.9 10426.6 11871.6 12151.9 12191.1 12225.4 12993.4 15172.0 15188.8 15454.3 15592.3 15648.1 14728.7 15018.5 15099.5 15317.7 15428.3 15433.6 15581.7 15603.2 15865.1 15974.1 10213.7 10213.9 10215.1 10221.5 10415.7 15151.1 15262.8 15421.8 15425.2 15464.3 03:25:10 INFO - 2016-01-24 03:25:10,402 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,403 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5754.83 Median:6044.15 stddev:3060.30 (50.6%) stddev-sans-first:3051.07 03:25:10 INFO - 2016-01-24 03:25:10,404 DEBUG : BROWSER_OUTPUT: Values: 1361.1 1769.6 1802.6 1832.9 1833.6 7141.3 7863.2 8212.6 8225.0 8228.1 8145.0 8306.0 8308.5 8313.9 8317.7 1985.2 2016.4 2326.2 2342.1 2387.6 2366.0 2370.2 2371.4 2372.0 2378.7 2272.9 2340.9 2342.1 2343.2 2345.8 2326.9 2329.3 2366.0 2366.3 2367.0 2367.6 2374.8 2392.1 2394.8 2409.9 8161.0 8311.5 8316.0 8317.3 8324.0 4920.9 4973.2 5029.4 5042.8 5048.9 3067.4 3088.9 3134.6 3169.6 3194.1 1027.2 1027.6 1048.9 1049.8 1061.1 11641.1 11664.4 11670.1 11681.4 11689.1 4345.2 4450.0 4516.3 4545.0 4577.7 9329.4 9362.3 9391.6 9398.6 9404.2 4994.2 5046.3 5047.8 5048.7 5052.4 4588.8 4644.1 4654.8 4658.2 4662.4 3266.2 3313.1 3372.6 3390.6 3518.4 1066.1 1098.7 1099.0 1114.8 1116.8 1140.7 1148.3 1156.3 1321.8 1377.6 7733.8 7799.3 7878.8 7889.6 7899.1 591.8 593.8 603.7 664.2 797.7 5934.9 5946.7 6039.0 6049.3 6058.9 9803.3 9932.1 10037.6 10074.4 10091.4 9709.0 9778.8 9957.2 10071.1 10091.3 7829.7 7886.8 7939.2 7941.7 7953.5 7461.3 7591.7 7598.1 7600.4 7602.7 8842.5 8887.7 8933.3 8958.9 9039.6 9045.8 9138.9 9300.6 9336.8 9371.3 7001.1 7006.5 7008.2 7080.1 7117.5 6684.2 7072.9 7536.4 7674.8 7679.0 7567.3 7611.5 7642.8 7684.5 7707.3 7492.9 7512.9 7528.4 7597.1 7605.0 7506.0 7598.5 7612.9 7626.6 7637.5 6988.1 6997.8 7011.5 7021.3 7037.4 6693.1 6988.1 7067.2 7090.1 7099.8 03:25:10 INFO - 2016-01-24 03:25:10,404 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,404 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5443.65 Median:6175.72 stddev:1626.11 (26.3%) stddev-sans-first:1585.10 03:25:10 INFO - 2016-01-24 03:25:10,404 DEBUG : BROWSER_OUTPUT: Values: 350.6 357.8 359.7 367.6 373.1 6063.6 6077.8 6103.8 6116.9 6132.2 5733.5 5834.6 5875.3 6043.4 6044.2 4718.1 4720.0 4724.5 4735.0 4735.4 4456.9 4744.8 4747.8 4764.6 4767.7 4505.1 4594.5 4667.5 4703.4 4714.4 4650.3 4678.8 4682.6 4687.1 4692.7 4167.8 4174.8 4177.7 4177.8 4179.4 5666.1 5775.4 5780.1 5784.5 5785.7 5433.4 5434.7 5434.8 5439.4 5444.1 6458.7 6461.4 6461.5 6462.7 6467.7 4549.1 4555.2 4556.1 4560.9 4572.0 6527.5 6585.3 6648.7 6665.2 6667.7 4663.8 4668.9 4670.0 4670.9 4675.5 4729.2 4729.6 4730.0 4734.4 4735.0 5416.5 5424.6 5427.2 5428.2 5428.4 6235.4 6418.8 6435.5 6438.5 6483.8 1639.4 1674.2 1674.3 1675.1 1675.2 1130.9 1135.4 1142.5 1158.2 1161.4 6299.0 6309.2 6310.2 6314.2 6316.3 6454.5 6712.1 6713.1 6720.0 6724.0 6152.7 6198.8 6283.2 6286.7 6292.2 3524.9 3593.1 3613.2 3627.6 3647.3 6833.7 6961.4 6982.5 6985.0 6987.2 6890.6 6913.5 6916.9 6918.0 6918.3 6961.1 6978.2 6978.8 6979.4 6980.3 6627.6 6731.2 6733.1 6742.7 6742.8 6618.8 6622.4 6624.6 6629.2 6632.2 6954.1 6965.3 6968.1 6971.1 6977.1 4584.7 4680.4 4682.4 4683.3 4689.1 6703.9 6708.9 6723.1 6725.5 6726.1 6542.7 6558.0 6558.0 6558.4 6559.6 6421.8 6501.9 6532.8 6541.1 6547.3 6437.3 6443.7 6445.0 6449.4 6449.7 6543.7 6552.7 6568.1 6569.1 6573.9 6305.0 6404.6 6418.4 6427.8 6430.6 03:25:10 INFO - 2016-01-24 03:25:10,404 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2016-01-24 03:25:10,404 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14305.53 Median:25009.19 stddev:16258.54 (65.0%) stddev-sans-first:16272.38 03:25:10 INFO - 2016-01-24 03:25:10,405 DEBUG : BROWSER_OUTPUT: Values: 771.2 863.8 866.0 868.9 879.4 14653.2 14850.4 14937.6 14974.3 14974.5 13739.4 14456.1 14467.7 14485.9 14509.1 764.0 769.2 904.3 906.7 922.3 903.6 904.7 912.3 912.5 913.3 935.2 936.2 937.2 937.5 937.8 778.1 781.8 943.1 945.5 948.3 701.5 702.1 703.2 703.3 705.3 14202.6 14213.5 14282.7 14318.1 14340.4 12497.4 13214.0 13395.9 13402.1 13448.2 10079.3 10138.7 10436.4 10465.0 10518.7 3676.8 3714.8 3745.9 3746.2 3753.5 47753.0 47781.3 47879.3 47955.5 48252.5 9882.6 9909.2 9913.6 10912.1 11149.3 19017.3 19175.6 19250.3 19330.9 19366.3 7732.3 7754.3 7853.6 7872.8 8063.8 4420.4 4456.4 4575.5 4588.3 4668.9 3277.7 3296.2 3296.7 3297.5 3300.9 576.8 589.7 592.0 593.2 598.7 673.7 697.3 703.8 704.2 728.8 9571.5 9603.4 9900.2 10138.6 10250.8 575.5 590.9 594.5 702.9 715.5 4059.8 4093.4 4144.3 4147.8 4254.0 58919.4 59128.7 59275.7 59323.7 59595.0 52338.0 52689.2 52816.2 53208.7 53499.7 46198.5 46492.8 46540.8 47663.5 48617.0 7981.0 8155.1 8165.8 8206.4 8236.9 35059.1 35665.9 35699.0 36101.0 36793.8 42088.0 45562.0 46511.5 47084.5 47227.8 9842.1 11526.9 11951.0 12027.4 12181.0 12921.0 12947.1 13015.3 13022.2 13137.8 11198.7 11649.2 11915.8 12264.1 12485.6 11274.4 11316.8 11509.8 11812.7 11873.9 11702.0 11879.1 11984.5 12118.9 12372.8 10410.9 10462.6 10577.4 10731.9 10839.7 10304.7 10421.0 10432.7 10453.7 10503.9 03:25:10 INFO - 2016-01-24 03:25:10,405 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:25:10 INFO - 2016-01-24 03:25:10,405 DEBUG : BROWSER_OUTPUT: 03:25:11 INFO - 2016-01-24 03:25:11,088 INFO : Browser exited with error code: 0 03:25:11 INFO - 2016-01-24 03:25:11,106 INFO : Completed test dromaeo_css (00:18:30) 03:25:11 INFO - 2016-01-24 03:25:11,107 INFO : Starting test kraken 03:25:11 INFO - 2016-01-24 03:25:11,107 DEBUG : operating with platform_type : linux_ 03:25:11 INFO - 2016-01-24 03:25:11,107 INFO : Initialising browser for kraken test... 03:25:11 INFO - 2016-01-24 03:25:11,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW3eaN4/profile http://localhost:54211/getInfo.html 03:25:14 INFO - 2016-01-24 03:25:14,785 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:25:14 INFO - 2016-01-24 03:25:14,785 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:25:14 INFO - 2016-01-24 03:25:14,785 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:25:14 INFO - 2016-01-24 03:25:14,785 DEBUG : BROWSER_OUTPUT: __metrics 03:25:14 INFO - 2016-01-24 03:25:14,927 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:15 INFO - 2016-01-24 03:25:15,984 INFO : Browser initialized. 03:25:15 INFO - 2016-01-24 03:25:15,984 INFO : Running cycle 1/1 for kraken test... 03:25:15 INFO - 2016-01-24 03:25:15,985 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW3eaN4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:25:27 INFO - 2016-01-24 03:25:27,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 136908800 03:25:27 INFO - 2016-01-24 03:25:27,781 DEBUG : BROWSER_OUTPUT: 03:25:30 INFO - 2016-01-24 03:25:30,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-beat-detection) 03:25:30 INFO - 2016-01-24 03:25:30,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 168173568 03:25:30 INFO - 2016-01-24 03:25:30,799 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2016-01-24 03:25:33,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-dft) 03:25:33 INFO - 2016-01-24 03:25:33,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 167133184 03:25:33 INFO - 2016-01-24 03:25:33,926 DEBUG : BROWSER_OUTPUT: 03:25:36 INFO - 2016-01-24 03:25:36,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-fft) 03:25:37 INFO - 2016-01-24 03:25:37,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 163377152 03:25:37 INFO - 2016-01-24 03:25:37,330 DEBUG : BROWSER_OUTPUT: 03:25:39 INFO - 2016-01-24 03:25:39,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-oscillator) 03:25:39 INFO - 2016-01-24 03:25:39,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 163704832 03:25:39 INFO - 2016-01-24 03:25:39,884 DEBUG : BROWSER_OUTPUT: 03:25:42 INFO - 2016-01-24 03:25:42,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:25:42 INFO - 2016-01-24 03:25:42,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 163966976 03:25:42 INFO - 2016-01-24 03:25:42,624 DEBUG : BROWSER_OUTPUT: 03:25:45 INFO - 2016-01-24 03:25:45,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54211/tests/kraken/driver.html?testName=imaging-darkroom) 03:25:46 INFO - 2016-01-24 03:25:46,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 161996800 03:25:46 INFO - 2016-01-24 03:25:46,062 DEBUG : BROWSER_OUTPUT: 03:25:49 INFO - 2016-01-24 03:25:49,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54211/tests/kraken/driver.html?testName=imaging-desaturate) 03:25:49 INFO - 2016-01-24 03:25:49,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 163459072 03:25:49 INFO - 2016-01-24 03:25:49,934 DEBUG : BROWSER_OUTPUT: 03:25:52 INFO - 2016-01-24 03:25:52,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54211/tests/kraken/driver.html?testName=json-parse-financial) 03:25:53 INFO - 2016-01-24 03:25:53,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 164917248 03:25:53 INFO - 2016-01-24 03:25:53,178 DEBUG : BROWSER_OUTPUT: 03:25:54 INFO - 2016-01-24 03:25:54,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:25:55 INFO - 2016-01-24 03:25:55,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 170405888 03:25:55 INFO - 2016-01-24 03:25:55,326 DEBUG : BROWSER_OUTPUT: 03:25:57 INFO - 2016-01-24 03:25:57,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:25:57 INFO - 2016-01-24 03:25:57,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 166174720 03:25:57 INFO - 2016-01-24 03:25:57,676 DEBUG : BROWSER_OUTPUT: 03:25:59 INFO - 2016-01-24 03:25:59,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:00 INFO - 2016-01-24 03:26:00,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 176586752 03:26:00 INFO - 2016-01-24 03:26:00,234 DEBUG : BROWSER_OUTPUT: 03:26:02 INFO - 2016-01-24 03:26:02,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:26:03 INFO - 2016-01-24 03:26:03,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 183959552 03:26:03 INFO - 2016-01-24 03:26:03,170 DEBUG : BROWSER_OUTPUT: 03:26:05 INFO - 2016-01-24 03:26:05,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:26:06 INFO - 2016-01-24 03:26:06,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 180969472 03:26:06 INFO - 2016-01-24 03:26:06,210 DEBUG : BROWSER_OUTPUT: 03:26:07 INFO - 2016-01-24 03:26:07,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54211/tests/kraken/driver.html?testName=ai-astar) 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 238755840 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:26:08 INFO - 2016-01-24 03:26:08,115 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;103;110;112;112;100;109;110;110 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;122;150;160;129;154;148;122;153;121 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;168;160;163;161;162;162;162;161 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;71;71;142;72;72;71;72;155;72 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;139;91;96;94;139;91;92;142 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;108;110;108;109 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;146 03:26:08 INFO - 2016-01-24 03:26:08,116 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;95;95;96;95;95 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;56;56;55;56;58;56;54;55 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;66;65;65;64;64;65 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;80;80;79;80;79;80;81;83 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;119;111;123;117;112;113;126;113;117 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;144;143;144;144;131;143;144;141;132 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;67;67;65;65;66;64;64;65 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:26:08 INFO - 2016-01-24 03:26:08,117 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:26:08 INFO - 2016-01-24 03:26:08,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 03:26:08 INFO - 2016-01-24 03:26:08,118 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:26:08 INFO - 2016-01-24 03:26:08,118 DEBUG : BROWSER_OUTPUT: __startTimestamp1453634768113__endTimestamp 03:26:08 INFO - 2016-01-24 03:26:08,118 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:26:08 INFO - 2016-01-24 03:26:08,121 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:26:08 INFO - 2016-01-24 03:26:08,121 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.92 (3.6%) stddev-sans-first:4.13 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 103.0 110.0 112.0 112.0 100.0 109.0 110.0 110.0 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.70 Median:149.00 stddev:15.34 (10.3%) stddev-sans-first:16.04 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: Values: 148.0 122.0 150.0 160.0 129.0 154.0 148.0 122.0 153.0 121.0 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.33 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 168.0 160.0 163.0 161.0 162.0 162.0 162.0 161.0 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:72.00 stddev:32.34 (44.9%) stddev-sans-first:34.08 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: Values: 77.0 71.0 71.0 142.0 72.0 72.0 71.0 72.0 155.0 72.0 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.00 stddev:22.90 (24.9%) stddev-sans-first:23.73 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 139.0 91.0 96.0 94.0 139.0 91.0 92.0 142.0 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,122 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 108.0 110.0 108.0 109.0 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.06 (1.9%) stddev-sans-first:1.09 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 56.0 56.0 55.0 56.0 58.0 56.0 54.0 55.0 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 66.0 65.0 65.0 64.0 64.0 65.0 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,123 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.16 (1.4%) stddev-sans-first:1.20 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 80.0 80.0 79.0 80.0 79.0 80.0 81.0 83.0 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:117.00 stddev:4.88 (4.2%) stddev-sans-first:5.17 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: Values: 116.0 119.0 111.0 123.0 117.0 112.0 113.0 126.0 113.0 117.0 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:143.50 stddev:5.69 (4.0%) stddev-sans-first:5.29 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: Values: 132.0 144.0 143.0 144.0 144.0 131.0 143.0 144.0 141.0 132.0 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 67.0 67.0 65.0 65.0 66.0 64.0 64.0 65.0 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:26:08 INFO - 2016-01-24 03:26:08,124 DEBUG : BROWSER_OUTPUT: 03:26:08 INFO - 2016-01-24 03:26:08,908 INFO : Browser exited with error code: 0 03:26:08 INFO - 2016-01-24 03:26:08,961 INFO : Completed test kraken (00:00:57) 03:26:08 INFO - 2016-01-24 03:26:08,961 INFO : Starting test v8_7 03:26:08 INFO - 2016-01-24 03:26:08,961 DEBUG : operating with platform_type : linux_ 03:26:08 INFO - 2016-01-24 03:26:08,961 INFO : Initialising browser for v8_7 test... 03:26:08 INFO - 2016-01-24 03:26:08,968 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3bcFrz/profile http://localhost:54211/getInfo.html 03:26:12 INFO - 2016-01-24 03:26:12,911 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:26:12 INFO - 2016-01-24 03:26:12,912 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:26:12 INFO - 2016-01-24 03:26:12,912 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:26:12 INFO - 2016-01-24 03:26:12,912 DEBUG : BROWSER_OUTPUT: __metrics 03:26:13 INFO - 2016-01-24 03:26:13,053 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:13 INFO - 2016-01-24 03:26:13,838 INFO : Browser initialized. 03:26:13 INFO - 2016-01-24 03:26:13,839 INFO : Running cycle 1/1 for v8_7 test... 03:26:13 INFO - 2016-01-24 03:26:13,839 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3bcFrz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:26:25 INFO - 2016-01-24 03:26:25,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 137408512 03:26:25 INFO - 2016-01-24 03:26:25,629 DEBUG : BROWSER_OUTPUT: 03:26:46 INFO - 2016-01-24 03:26:46,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54211/tests/v8_7/run.html (next: http://localhost:54211/tests/v8_7/run.html) 03:26:47 INFO - 2016-01-24 03:26:47,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 424562688 03:26:47 INFO - 2016-01-24 03:26:47,230 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,231 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:26:47 INFO - 2016-01-24 03:26:47,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:26:47 INFO - 2016-01-24 03:26:47,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:26:47 INFO - 2016-01-24 03:26:47,232 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:26:47 INFO - 2016-01-24 03:26:47,232 DEBUG : BROWSER_OUTPUT: |0;Richards;171.3796058269066 03:26:47 INFO - 2016-01-24 03:26:47,232 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.3080140538732 03:26:47 INFO - 2016-01-24 03:26:47,232 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 03:26:47 INFO - 2016-01-24 03:26:47,233 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 03:26:47 INFO - 2016-01-24 03:26:47,233 DEBUG : BROWSER_OUTPUT: |4;RayTrace;953.2888465204957 03:26:47 INFO - 2016-01-24 03:26:47,233 DEBUG : BROWSER_OUTPUT: |5;Earley;552.791597567717 03:26:47 INFO - 2016-01-24 03:26:47,233 DEBUG : BROWSER_OUTPUT: |6;Boyer;11054.945054945056 03:26:47 INFO - 2016-01-24 03:26:47,233 DEBUG : BROWSER_OUTPUT: |7;RegExp;23928.571428571428 03:26:47 INFO - 2016-01-24 03:26:47,233 DEBUG : BROWSER_OUTPUT: |8;Splay;522.466039707419 03:26:47 INFO - 2016-01-24 03:26:47,234 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 03:26:47 INFO - 2016-01-24 03:26:47,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:26:47 INFO - 2016-01-24 03:26:47,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1453634807230__endTimestamp 03:26:47 INFO - 2016-01-24 03:26:47,234 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,234 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:26:47 INFO - 2016-01-24 03:26:47,234 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:26:47 INFO - 2016-01-24 03:26:47,235 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,235 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.38 Median:171.38 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,235 DEBUG : BROWSER_OUTPUT: Values: 171.4 03:26:47 INFO - 2016-01-24 03:26:47,235 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,235 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,236 DEBUG : BROWSER_OUTPUT: Values: 167.3 03:26:47 INFO - 2016-01-24 03:26:47,236 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,236 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,236 DEBUG : BROWSER_OUTPUT: Values: 279.2 03:26:47 INFO - 2016-01-24 03:26:47,236 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,236 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,237 DEBUG : BROWSER_OUTPUT: Values: 5128.2 03:26:47 INFO - 2016-01-24 03:26:47,237 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,237 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,237 DEBUG : BROWSER_OUTPUT: Values: 953.3 03:26:47 INFO - 2016-01-24 03:26:47,237 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,237 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:552.79 Median:552.79 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,238 DEBUG : BROWSER_OUTPUT: Values: 552.8 03:26:47 INFO - 2016-01-24 03:26:47,238 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,238 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11054.95 Median:11054.95 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,238 DEBUG : BROWSER_OUTPUT: Values: 11054.9 03:26:47 INFO - 2016-01-24 03:26:47,238 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,238 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23928.57 Median:23928.57 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,239 DEBUG : BROWSER_OUTPUT: Values: 23928.6 03:26:47 INFO - 2016-01-24 03:26:47,239 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,239 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:522.47 Median:522.47 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,239 DEBUG : BROWSER_OUTPUT: Values: 522.5 03:26:47 INFO - 2016-01-24 03:26:47,239 DEBUG : BROWSER_OUTPUT: 03:26:47 INFO - 2016-01-24 03:26:47,240 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:26:47 INFO - 2016-01-24 03:26:47,240 DEBUG : BROWSER_OUTPUT: Values: 4830.9 03:26:47 INFO - 2016-01-24 03:26:47,240 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:26:47 INFO - 2016-01-24 03:26:47,240 DEBUG : BROWSER_OUTPUT: 03:26:48 INFO - 2016-01-24 03:26:48,012 INFO : Browser exited with error code: 0 03:26:48 INFO - 2016-01-24 03:26:48,024 INFO : Completed test v8_7 (00:00:39) 03:26:48 INFO - 2016-01-24 03:26:48,289 INFO : Completed test suite (00:20:07) 03:26:48 INFO - 2016-01-24 03:26:48,290 DEBUG : Working with test: dromaeo_css 03:26:48 INFO - 2016-01-24 03:26:48,290 DEBUG : Generating results file: dromaeo_css 03:26:48 INFO - 2016-01-24 03:26:48,291 DEBUG : Working with test: kraken 03:26:48 INFO - 2016-01-24 03:26:48,291 DEBUG : Generating results file: kraken 03:26:48 INFO - 2016-01-24 03:26:48,291 INFO : javascript benchmark 03:26:48 INFO - 2016-01-24 03:26:48,291 DEBUG : Working with test: v8_7 03:26:48 INFO - 2016-01-24 03:26:48,292 DEBUG : Generating results file: v8_7 03:26:48 INFO - 2016-01-24 03:26:48,292 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:26:48 INFO - 2016-01-24 03:26:48,460 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:26:48 INFO - 2016-01-24 03:26:48,461 DEBUG : process_Request line: dromaeo_css 7275.90 graph.html#tests=[[72,52,35]] 03:26:48 INFO - 2016-01-24 03:26:48,461 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:26:48 INFO - 2016-01-24 03:26:48,492 DEBUG : process_Request line: kraken 1478.20 graph.html#tests=[[232,52,35]] 03:26:48 INFO - 2016-01-24 03:26:48,492 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:26:48 INFO - 2016-01-24 03:26:48,609 DEBUG : process_Request line: v8_7 23090.48 graph.html#tests=[[230,52,35]] 03:26:48 INFO - 2016-01-24 03:26:48,610 INFO : javascript benchmark 03:26:48 INFO - 2016-01-24 03:26:48,614 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3274.099622603784, 3311.0728995881163, 3339.7996120232788, 3367.5453813735153, 3393.4570468725, 5285.0, 5305.495977882095, 5336.092864213083, 5341.572674186065, 5343.866403339918, 5381.757820898059, 5409.702466364358, 5413.404525502192, 5427.0, 5436.75534600943, 4831.975840120795, 4930.063287975291, 4964.70211787293, 4991.276264941581, 5022.347094877679, 4969.62727795415, 5036.597072234213, 5039.798408063673, 5052.9747351263195, 5055.342805435306, 4986.127427700156, 5024.271480635306, 5026.52248036436, 5031.371078615173, 5034.370703662043, 4798.328234047236, 4925.507449255082, 5019.47295533971, 5022.799088036474, 5023.974880125613, 4938.0, 5020.548150666421, 5033.597312215014, 5037.345145131109, 5062.2406639004075, 5004.399472063339, 5091.389033315989, 5140.460251673558, 5222.63441559091, 5291.867703307448, 5761.88476230473, 5813.912791308091, 5815.505682017034, 5815.912761308584, 5838.4453476919625, 5800.680962547058, 5830.970845145789, 5834.708264586754, 5834.766609335621, 5837.328707198684, 5288.524032837025, 5421.918671219935, 5432.266644003088, 5438.592105592057, 5543.196236545678, 5842.357340692521, 5855.092460668603, 5855.297364316224, 5878.382769809108, 5887.999040163182, 5683.346415162227, 5693.231413759172, 5696.914546281809, 5722.313322401338, 5746.770129194869, 5651.8304450866535, 5741.425857414225, 5755.884882302331, 5764.855878602984, 5790.218320526759, 5740.885182296414, 5752.7698892043845, 5753.021986262345, 5760.049591817387, 5851.356350801409, 5708.828735137952, 5752.165935939265, 5753.367129615739, 5768.480836724715, 5772.5670574707065, 4356.912861742748, 4391.121775644884, 4465.330200469891, 4485.0805584855025, 4487.842925497657, 4075.49056367954, 4088.34093486334, 4092.6725861930972, 4093.1813637272667, 4115.814788334532, 5559.972200139055, 5563.499285064364, 5569.805056823073, 5578.553715702815, 5593.300837395325, 5555.611107222456, 5651.0675738503505, 5793.884122317614, 5859.501942334864, 5885.028970219866, 5479.643823151562, 5490.286262785812, 5491.121420572689, 5500.22996780451, 5503.9174412383845, 5067.822626208139, 5088.643794934319, 5088.821891233789, 5094.465081166498, 5103.668261562986, 5736.942630573724, 5844.415558444207, 5947.613405128653, 5970.671613061323, 6071.180390647206, 5870.236869206976, 5873.089671100986, 5883.676397798162, 5886.05823068307, 5889.49939255151, 6004.87990240184, 6044.365341639241, 6057.545684073624, 6061.030235162353, 6062.575619706755, 5553.805616803393, 5608.663480191201, 5659.03796354629, 5710.685912274865, 5726.513246373938, 5752.568557358131, 5829.3296270927685, 5854.648721076749, 5870.882582348244, 5872.383399742966, 5546.389897111234, 5735.627184233012, 5755.65466072037, 5758.337791153904, 5760.33756118035, 5582.358028826737, 5643.068893632505, 5653.660780353192, 5658.094704847204, 5683.772649094155, 5595.944040559705, 5619.859503512282, 5634.098544232903, 5641.492265696107, 5641.576881733804, 5535.446455354593, 5592.720363981866, 5687.544996400361, 5691.288588926384, 5698.373178950395, 5456.727163641723, 5525.751341189576, 5533.114701647717, 5538.556915446674, 5553.916691249715], "unit": "ms", "name": "dojo.html", "value": 5359.314557382623}, {"lowerIsBetter": false, "replicates": [560.2520634952339, 609.6585911889342, 612.4396177497591, 614.2046050364783, 616.8581226317947, 32418.67581324186, 40693.59306406935, 41073.17853642929, 41107.58892411075, 41135.79432102843, 44626.33060504087, 45374.54625453745, 45551.0, 45641.31538026924, 45724.0, 8139.95930020352, 8251.793705157359, 9181.540922953842, 9367.15695587397, 10477.0, 10901.34591924487, 10949.562017519289, 11053.336799792038, 11057.447127643625, 11067.833982490269, 10946.616868409568, 10973.177011724112, 10983.0, 11093.223474356799, 11097.056750176245, 8329.33365330772, 8547.10255423181, 10727.731806704816, 10990.560377584887, 11018.44907754609, 10711.892881071246, 10834.945825270823, 10868.565257389695, 10878.945605272002, 10883.455827208609, 42922.57077429217, 43321.56678433207, 43376.78311608453, 43460.78269608632, 43480.347794783105, 3608.5308909841815, 3639.1266096137, 3666.5600127984544, 4045.2314060328445, 4264.0832221072615, 31917.84041079803, 32157.83921080403, 32175.51736723951, 32861.50707739386, 33695.663043369495, 3550.520679708258, 3566.465030245458, 3592.982035089834, 3614.8554057837655, 3630.7836874647023, 294793.0, 299070.0, 299408.0, 299745.0, 458441.70779146225, 51968.0, 67701.3229867705, 68601.31398686049, 68680.31319686839, 68800.3119968804, 59232.0, 59759.40240597625, 59864.40135598588, 59899.401005989384, 59967.70016149891, 17485.388011419538, 17653.20560574777, 17669.20488578017, 17670.91164544195, 17681.646367072586, 13672.384742686603, 13919.443222270997, 13925.164490130624, 13938.094023888414, 13951.790723139162, 19852.60294794096, 20306.18775249003, 20333.89833050825, 20338.491537711674, 20397.18411263533, 7490.475666703387, 7675.279702982625, 7706.190849960785, 7783.766487005399, 7788.454808163374, 996.367306760198, 1065.9040686338267, 1100.9009189173014, 1132.4451019000794, 1215.0522592377959, 29907.252318692208, 30385.987674342996, 31328.0, 32099.679003210134, 32559.0, 1085.1535802074395, 1095.5453486803046, 1100.4497751124438, 1125.9774804503863, 1213.5691829400612, 12666.873331266754, 13751.656208594864, 13758.005089262, 14810.703785924437, 15564.766528502081, 265510.0, 268754.0, 268925.0, 269457.0, 269868.0, 49476.50523494791, 49536.50463495391, 49565.75217123891, 49576.752116239906, 49667.0, 1325.5890673891124, 1359.5989183190982, 1400.5098215624653, 1448.5364683301243, 1449.173970836634, 27937.44125117527, 28011.0196143134, 28339.291517711397, 28463.573046403908, 28815.135545933656, 43133.784331078146, 43536.346954795066, 43567.12865742731, 45440.31839522476, 46311.76844115893, 414218.0, 418134.0, 423491.0, 424549.0, 424648.0, 30740.23149421193, 31151.376972460876, 31169.8441507791, 31174.844125779226, 31181.53227701632, 44149.77925110354, 44848.10303793971, 45066.32400513929, 45954.770226148656, 46091.30863037124, 36413.81793091124, 36633.45049824308, 37620.05949851275, 37888.81055594704, 37899.81050094732, 36693.0, 37435.43846842245, 38174.61825381822, 38280.0, 38375.42436863505, 37898.24203515859, 38199.0, 38455.80772096122, 38713.80643096766, 38888.22223555457, 29504.262393440335, 33069.83465082659, 34134.487982679784, 34504.96485105451, 34791.304173916884, 25847.483050339262, 26610.600840987787, 26659.0, 26683.199504014912, 26710.59934100951], "unit": "ms", "name": "ext.html", "value": 19752.467020926273}, {"lowerIsBetter": false, "replicates": [379.9259144466829, 379.94300854871767, 383.0920717898579, 386.1639550373442, 390.6542709701915, 14797.482088126892, 16337.509874703777, 17910.820891791078, 19857.900710496426, 19887.0, 10863.18526110541, 11113.388763617997, 11117.0, 18779.718304225415, 19218.80781192191, 5063.41770696371, 5169.121249387595, 5172.120739474299, 5177.119889618755, 5178.8705282368055, 3761.755485893422, 3850.7304488685804, 5163.922541161867, 5425.6202065855405, 5584.776608935637, 5524.33707955044, 5543.196236545698, 5548.77804887804, 5563.860903477425, 5571.192177134313, 5514.531264842493, 6154.784582539634, 6157.599756015889, 6163.66099864505, 6175.289841668198, 5471.671699698031, 5486.972565137149, 5495.945040549584, 5501.14732216507, 5507.5593952483705, 12760.106792524526, 13045.152065115737, 13104.344782760823, 13734.931325343408, 22181.667274990887, 2324.732655744594, 2363.243761996162, 2396.748341424143, 2473.5423946569763, 2509.6611957385885, 9727.221822254203, 9873.60505579776, 10006.9499652502, 11247.887521124847, 14210.644733881632, 1927.4314077347217, 1934.8935808530525, 1972.960540789176, 1988.443235893952, 2007.688808234726, 64683.3531664682, 65976.67011664911, 66336.66831665859, 68000.3199967999, 68137.65931170313, 10967.232293739362, 11011.669649910515, 11015.779684406267, 11019.669409917715, 11031.779364412827, 14444.711105777826, 14515.129092254287, 14529.055611385225, 14535.78196327056, 14550.054246473945, 8241.670333186605, 8282.420230583923, 8309.127541608164, 8349.791255218668, 8369.121242269473, 8061.113277539466, 8074.515529068275, 8094.716684915999, 8141.307988821017, 8170.673173073129, 4719.457262414798, 4763.428388593391, 4777.8088876445245, 4824.879378015507, 4842.273658951185, 1676.91615419231, 1804.6300508395748, 1813.7098064309648, 1838.5587459009741, 1906.7997860224755, 948.5446985447024, 968.6416026070258, 1022.2333250062453, 1065.63235683689, 1076.3757020927842, 15412.0, 17456.738148927776, 17488.0, 17940.551486212687, 18368.35710750144, 957.2150836314295, 981.1365997921783, 981.7153025622632, 1044.1907521670614, 1055.6885718712997, 9966.80066398668, 10323.225758068025, 10338.0, 10436.686899393031, 10446.0, 675582.0, 679144.0, 686186.0, 694252.0, 699088.0, 85635.5718221405, 88723.55638221768, 89174.0, 89636.0, 93584.53207734054, 1191.314993878506, 1192.9045676345872, 1196.1208511743862, 1198.02361075723, 1209.0508950473836, 15664.92167539155, 16088.276027578553, 16518.504444866674, 16664.50006499807, 16821.07484088338, 37813.81093094627, 38200.426993595676, 38445.0, 38756.224875501764, 39522.60477395189, 47182.76408617935, 48131.75934120307, 48599.51400486091, 49244.753776232326, 52842.0, 9780.755481112745, 10209.183265338606, 10212.183025358103, 10223.897761022294, 10426.582936682447, 11871.643850684493, 12151.878481215075, 12191.08566857507, 12225.410696609384, 12993.4152963115, 15172.0, 15188.772168417703, 15454.304556294768, 15592.298346574204, 15648.139352335731, 14728.705425891636, 15018.549443516711, 15099.471518496799, 15317.693646127238, 15428.30572624212, 15433.614159646098, 15581.688366232838, 15603.219839007777, 15865.127417992122, 15974.121423321829, 10213.74465638365, 10213.948930255301, 10215.080642742189, 10221.488925553842, 10415.739606509595, 15151.090934543963, 15262.847371526143, 15421.768673470131, 15425.228738562802, 15464.304106315469], "unit": "ms", "name": "jquery.html", "value": 9263.717864296426}, {"lowerIsBetter": false, "replicates": [1361.0540674231413, 1769.6195318006628, 1802.593099042809, 1832.871698981071, 1833.6424397242536, 7141.321574450425, 7863.213678632134, 8212.630431630576, 8225.012998440188, 8228.136045715204, 8144.959275203631, 8306.0, 8308.459950103254, 8313.875291870612, 8317.708880189195, 1985.2257619528395, 2016.4253187841468, 2326.1858349577683, 2342.1451170322794, 2387.617981123021, 2366.0, 2370.229675355508, 2371.3834403055243, 2371.9525609487887, 2378.702662167229, 2272.943176420586, 2340.918067867625, 2342.051469154995, 2343.238447504559, 2345.8006069484113, 2326.8603883766946, 2329.26628112145, 2365.988170059156, 2366.25462979161, 2367.0, 2367.644853272023, 2374.7625237476286, 2392.0910054179476, 2394.820388470872, 2409.9397515062087, 8160.9591952040455, 8311.459755115899, 8316.043654979694, 8317.293030092389, 8323.958380208122, 4920.852374428737, 4973.15456372414, 5029.4216165141115, 5042.823501177441, 5048.9495105048845, 3067.3558552703958, 3088.861001254949, 3134.5611614374006, 3169.635491918436, 3194.105650417887, 1027.1936529824127, 1027.6095083868156, 1048.9003544663244, 1049.826778581533, 1061.050359927868, 11641.126915481289, 11664.416779161093, 11670.124740644485, 11681.415929203591, 11689.06487481008, 4345.152695224401, 4449.9777501112285, 4516.277395616686, 4544.977275113603, 4577.702449340783, 9329.440233586007, 9362.34463587556, 9391.577379017961, 9398.577064031999, 9404.24766018717, 4994.200927851526, 5046.268291097844, 5047.823326183639, 5048.747562621854, 5052.444231134572, 4588.839390621379, 4644.071185762861, 4654.767261636905, 4658.184817656965, 4662.417197850269, 3266.1671273825023, 3313.122022663996, 3372.578427696538, 3390.6439823818637, 3518.419460788992, 1066.1204506282347, 1098.7198264442516, 1098.9725256868642, 1114.8216285394299, 1116.7598966222301, 1140.7319279969201, 1148.3282279866205, 1156.3177725142207, 1321.8281623388898, 1377.5867239828012, 7733.8453230935065, 7799.298063174341, 7878.763637090897, 7889.605519724106, 7899.091604465445, 591.7721677154327, 593.7506247376112, 603.6891001134419, 664.2162248546762, 797.7487091566138, 5934.851628709317, 5946.672932988728, 6039.0, 6049.304330002018, 6058.939410605837, 9803.264755143393, 9932.10611044995, 10037.598496060076, 10074.395536267848, 10091.44497052669, 9709.0, 9778.755531111638, 9957.153641940371, 10071.143952764098, 10091.344062635904, 7829.7259595913865, 7886.802829929297, 7939.2060793920145, 7941.682332706627, 7953.5227886327, 7461.291177338144, 7591.658375373232, 7598.0502437195355, 7600.3539699126195, 7602.7339043133225, 8842.46945183291, 8887.688930887389, 8933.330000250136, 8958.910410895807, 9039.638414463348, 9045.819083618422, 9138.862917056116, 9300.627974880928, 9336.813263734823, 9371.34400591952, 7001.089858318386, 7006.509544331848, 7008.159020917318, 7080.114985626797, 7117.466190035664, 6684.197896252481, 7072.893906591508, 7536.434767392358, 7674.808129796576, 7679.040119985002, 7567.31894129531, 7611.543307401574, 7642.847143057219, 7684.538927664358, 7707.267809558083, 7492.850142997218, 7512.887306690294, 7528.397728181842, 7597.126330471845, 7605.0, 7505.962470187614, 7598.468107232441, 7612.885806712793, 7626.58053807046, 7637.541747495168, 6988.091548098715, 6997.790066298019, 7011.474139439664, 7021.332973367522, 7037.401820845081, 6693.129893114059, 6988.126484189476, 7067.151941767021, 7090.113735783028, 7099.822504437224], "unit": "ms", "name": "mootools.html", "value": 4630.002346802811}, {"lowerIsBetter": false, "replicates": [350.59681366428606, 357.8461261657486, 359.68886912820403, 367.5864652266199, 373.0580284780928, 6063.6058656187315, 6077.817665470037, 6103.786367477139, 6116.9295373309715, 6132.233470816137, 5733.48398644122, 5834.56240781942, 5875.2949646042425, 6043.395660433955, 6044.24446944132, 4718.079974404993, 4719.952800471986, 4724.45668748095, 4735.0, 4735.3844000280005, 4456.866294011184, 4744.762761861911, 4747.76261186941, 4764.595009424203, 4767.713937163764, 4505.076459325846, 4594.494605593382, 4667.509911459299, 4703.412073490814, 4714.4106986626675, 4650.279206722963, 4678.789454474557, 4682.648801339913, 4687.1328804171335, 4692.718436893797, 4167.791610419466, 4174.812133454002, 4177.749335039907, 4177.8328866845595, 4179.435776170209, 5666.093425052013, 5775.422457754233, 5780.132980052984, 5784.479396854261, 5785.6528608283215, 5433.402325744165, 5434.701091439969, 5434.782608695687, 5439.401665816757, 5444.101723215665, 6458.741650333981, 6461.418472337512, 6461.483081353481, 6462.739765745681, 6467.74129034838, 4549.135664223787, 4555.180067587833, 4556.066006468699, 4560.931586026212, 4571.994161284512, 6527.543071984963, 6585.275619681831, 6648.66756662165, 6665.233498147727, 6667.666616669196, 4663.836765713251, 4668.906621867543, 4669.976650116728, 4670.906581868344, 4675.485696573374, 4729.219678752967, 4729.597984171384, 4730.0, 4734.360861283682, 4734.958309171977, 5416.485433883775, 5424.647397919122, 5427.213054107132, 5428.240046393508, 5428.37573679032, 6235.438810507076, 6418.807435776934, 6435.452986496107, 6438.45273151778, 6483.773067942694, 1639.4098124675108, 1674.2382216091648, 1674.2800595743704, 1675.1205617050903, 1675.2293944785292, 1130.9434528273553, 1135.3528488761326, 1142.5486932661552, 1158.1661203933154, 1161.4076820821442, 6298.968505157536, 6309.211348581427, 6310.211223597051, 6314.210723659543, 6316.336784637639, 6454.483641308684, 6712.127423434922, 6713.12729345182, 6720.0255962886085, 6723.966380168068, 6152.661603611844, 6198.783042593487, 6283.151774510474, 6286.717097730613, 6292.244930608356, 3524.9295014099575, 3593.083763640307, 3613.2050948791225, 3627.6190999944624, 3647.2887786881834, 6833.726650933907, 6961.443084553223, 6982.546134501241, 6984.965075174591, 6987.161540615057, 6890.586564806128, 6913.51605387618, 6916.861662766716, 6918.0, 6918.342757438036, 6961.060256865359, 6978.197507286727, 6978.755743548952, 6979.406750426169, 6980.267071957473, 6627.569208001464, 6731.225909020525, 6733.091032710521, 6742.6628668567355, 6742.831429214113, 6618.834529136618, 6622.37087476689, 6624.56940298879, 6629.2376376715365, 6632.1709786276715, 6954.095967524189, 6965.303469653197, 6968.0941477607585, 6971.058907047483, 6977.058097157022, 4584.656150788771, 4680.368150299802, 4682.41469816273, 4683.250679891201, 4689.132510485571, 6703.899441508479, 6708.899366509604, 6723.058771772054, 6725.461963042847, 6726.091977582963, 6542.672866356568, 6557.967210163919, 6558.049082883051, 6558.409743123142, 6559.639219842955, 6421.8073457796345, 6501.934980650133, 6532.8366790830605, 6541.051547525487, 6547.345265473415, 6437.25971513282, 6443.67781610927, 6445.0332450132855, 6449.419552240321, 6449.677516124269, 6543.738250469928, 6552.737890484518, 6568.113304703804, 6569.113169722217, 6573.901391479036, 6305.0, 6404.583702059351, 6418.422341989243, 6427.807165785034, 6430.614163150226], "unit": "ms", "name": "prototype.html", "value": 4923.487352976167}, {"lowerIsBetter": false, "replicates": [771.1632878327015, 863.7840539865034, 865.9523726195057, 868.8522951098313, 879.4327658660167, 14653.194074325907, 14850.405983760651, 14937.626559336022, 14974.32615532301, 14974.475893343722, 13739.381727822247, 14456.13263204206, 14467.710645787078, 14485.92757036216, 14509.056911300784, 763.9732609358673, 769.1808224241165, 904.276578737011, 906.7370462565881, 922.3082687984012, 903.5933829776594, 904.7195369435464, 912.2975309012056, 912.5300470257822, 913.3332667152982, 935.2004036548755, 936.2089034765612, 937.1752857485403, 937.4562753602894, 937.7561833923161, 778.1129512355891, 781.8201813582851, 943.1417410156724, 945.4941606240697, 948.2793077261263, 701.5019336271254, 702.0767690487045, 703.1843062048, 703.282651695268, 705.28413660135, 14202.573922782332, 14213.50252741149, 14282.714345713131, 14318.069325493809, 14340.42638294467, 12497.437615307334, 13214.0, 13395.933020334836, 13402.128861623964, 13448.152063346459, 10079.344842585282, 10138.695839124837, 10436.37381757097, 10465.0, 10518.737031574195, 3676.7977761223124, 3714.758540694846, 3745.925081498382, 3746.2132952080096, 3753.4932784074344, 47753.0, 47781.28328075082, 47879.28181077287, 47955.5204447958, 48252.51747482515, 9882.604695812088, 9909.157721593601, 9913.553890074963, 10912.127029837595, 11149.275297105662, 19017.33439329617, 19175.61648767017, 19250.326238581583, 19330.903345483464, 19366.32217872396, 7732.265434783687, 7754.263344982218, 7853.646585903648, 7872.842543149105, 8063.798405039804, 4420.425344705168, 4456.376107344974, 4575.450945886515, 4588.334691469785, 4668.85993420198, 3277.737780977516, 3296.159479332755, 3296.7032967033083, 3297.4888892221743, 3300.851461684182, 576.824068659063, 589.7257775134498, 591.9822405327847, 593.2288025566746, 598.7335635642097, 673.7237732529737, 697.3235961117708, 703.7936070419171, 704.1972151747012, 728.8287252495659, 9571.521423928776, 9603.423794572209, 9900.207983361313, 10138.645147419806, 10250.846237306447, 575.4906907386909, 590.9172715819789, 594.5273507561499, 702.9261927497641, 715.4634024481638, 4059.837606495766, 4093.3655283431117, 4144.295469770146, 4147.771872546979, 4254.0, 58919.41080589139, 59128.704356477945, 59275.70362148162, 59323.70338148368, 59595.0, 52338.0, 52689.2096618551, 52816.207756883676, 53208.73395633075, 53499.73250133725, 46198.53801461942, 46492.76753616278, 46540.76729616398, 47663.5233647666, 48617.0, 7980.960095199487, 8155.10293867686, 8165.836683266182, 8206.384521161057, 8236.876446853183, 35059.12352191216, 35665.930022099375, 35699.0, 36101.0, 36793.816030919676, 42088.0, 45562.0, 46511.53488465072, 47084.52915470801, 47227.76386118047, 9842.114209720872, 11526.942365288456, 11951.0, 12027.398630068637, 12181.0, 12921.0, 12947.093703440669, 13015.349232538525, 13022.218666880017, 13137.802932956205, 11198.664040078811, 11649.184557080924, 11915.82126268124, 12264.141510094209, 12485.56300529477, 11274.436278185894, 11316.83024754613, 11509.827352589886, 11812.70468238301, 11873.881261187624, 11702.0, 11879.109066820196, 11984.46069926838, 12118.878811211775, 12372.752544948871, 10410.895891040993, 10462.581496740046, 10577.365358078232, 10731.89268107309, 10839.723658031902, 10304.742381440525, 10421.0, 10432.687019389126, 10453.738656533647, 10503.94748026255], "unit": "ms", "name": "yui.html", "value": 6636.085221754002}], "name": "dromaeo_css", "value": 7275.902196848203}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 103.0, 110.0, 112.0, 112.0, 100.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [148.0, 122.0, 150.0, 160.0, 129.0, 154.0, 148.0, 122.0, 153.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 168.0, 160.0, 163.0, 161.0, 162.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [77.0, 71.0, 71.0, 142.0, 72.0, 72.0, 71.0, 72.0, 155.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 139.0, 91.0, 96.0, 94.0, 139.0, 91.0, 92.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 108.0, 110.0, 108.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 58.0, 56.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 80.0, 80.0, 79.0, 80.0, 79.0, 80.0, 81.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 111.0, 123.0, 117.0, 112.0, 113.0, 126.0, 113.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [132.0, 144.0, 143.0, 144.0, 144.0, 131.0, 143.0, 144.0, 141.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 67.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1478.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.3796058269066], "unit": "score", "name": "Richards", "value": 205.98717000000005}, {"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "DeltaBlue", "value": 395.1872859999999}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [953.2888465204957], "unit": "score", "name": "RayTrace", "value": 776.2484609999998}, {"lowerIsBetter": false, "replicates": [552.791597567717], "unit": "score", "name": "Earley", "value": 1205.631567}, {"lowerIsBetter": false, "replicates": [11054.945054945056], "unit": "score", "name": "Boyer", "value": 60.28641451292241}, {"lowerIsBetter": false, "replicates": [23928.571428571428], "unit": "score", "name": "RegExp", "value": 38.071014925373106}, {"lowerIsBetter": false, "replicates": [522.466039707419], "unit": "score", "name": "Splay", "value": 155.97377400000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23090.47944683132}]} 03:26:48 INFO - RETURN: dromaeo_css: 7275.90 03:26:48 INFO - RETURN: kraken: 1478.20 03:26:48 INFO - RETURN: v8_7: 23090.48 03:26:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23090.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1478.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7275.90"}}} 03:26:48 INFO - Return code: 0 03:26:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:26:48 INFO - # TBPL SUCCESS # 03:26:48 INFO - Running post-action listener: _resource_record_post_action 03:26:48 INFO - Running post-run listener: _resource_record_post_run 03:26:49 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 282624; Write bytes: 502755328; Read time: 188; Write time: 384728 03:26:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237035520; Read time: 0; Write time: 238116 03:26:49 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 282624; Write bytes: 265359360; Read time: 188; Write time: 146584 03:26:49 INFO - Running post-run listener: _upload_blobber_files 03:26:49 INFO - Blob upload gear active. 03:26:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:26:49 INFO - Copying logs to upload dir... 03:26:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.561669 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-24 03:26:48.965007) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-24 03:26:48.968273) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009885 build_url: 'https://queue.taskcluster.net/v1/task/m2FcFxP8Tzq9WqH3zrAdjg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-24 03:26:49.020255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:26:49.020662) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453608685.784263-607191845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 03:26:49.070937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 03:26:49.071296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 03:26:49.071639) ========= ========= Total master_lag: 0.33 =========