builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1448372498.39 results: success (0) buildid: 20151124043003 builduid: cec94a7fe8234e4392cf82658b5d4f49 revision: 45273bbed8efaface6f5ec56d984cb9faf4fbb6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.394714) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.395155) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.395465) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007546 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.453865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.454222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.544330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.544744) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024339 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.595045) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.595353) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.595727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:38.601049) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 05:41:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.4M=0s 2015-11-24 05:41:39 (60.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.389870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.004753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.008107) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.060273 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.079195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.079523) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45273bbed8efaface6f5ec56d984cb9faf4fbb6a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45273bbed8efaface6f5ec56d984cb9faf4fbb6a --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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 05:41:39,242 truncating revision to first 12 chars 2015-11-24 05:41:39,242 Setting DEBUG logging. 2015-11-24 05:41:39,243 attempt 1/10 2015-11-24 05:41:39,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45273bbed8ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 05:41:39,523 unpacking tar archive at: mozilla-central-45273bbed8ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.678252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.678571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.694319) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.694570) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:41:39.694929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-24 05:41:39.695216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:40 INFO - MultiFileLogger online at 20151124 05:41:40 in /builds/slave/test-pgo 05:41:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:41:40 INFO - {'append_to_log': False, 05:41:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:41:40 INFO - 'blob_upload_branch': 'Firefox', 05:41:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:41:40 INFO - 'branch': 'Firefox', 05:41:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:40 INFO - 'config_files': ('talos/linux_config.py',), 05:41:40 INFO - 'default_actions': ('clobber', 05:41:40 INFO - 'read-buildbot-config', 05:41:40 INFO - 'download-and-extract', 05:41:40 INFO - 'populate-webroot', 05:41:40 INFO - 'create-virtualenv', 05:41:40 INFO - 'install', 05:41:40 INFO - 'run-tests'), 05:41:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:40 INFO - 'download_minidump_stackwalk': True, 05:41:40 INFO - 'download_symbols': 'ondemand', 05:41:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:40 INFO - 'installer_path': 'installer.exe', 05:41:40 INFO - 'log_level': 'info', 05:41:40 INFO - 'log_name': 'talos', 05:41:40 INFO - 'log_to_console': True, 05:41:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:40 INFO - 'opt_config_files': (), 05:41:40 INFO - 'pip_index': False, 05:41:40 INFO - 'sps_profile': False, 05:41:40 INFO - 'sps_profile_interval': 0, 05:41:40 INFO - 'suite': 'dromaeojs', 05:41:40 INFO - 'system_bits': '64', 05:41:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:40 INFO - 'title': 'talos-linux64-ix-029', 05:41:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:40 INFO - 'use_talos_json': True, 05:41:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:41:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:40 INFO - 'work_dir': 'build'} 05:41:40 INFO - ##### 05:41:40 INFO - ##### Running clobber step. 05:41:40 INFO - ##### 05:41:40 INFO - Running pre-action listener: _resource_record_pre_action 05:41:40 INFO - Running main action method: clobber 05:41:40 INFO - rmtree: /builds/slave/test-pgo/build 05:41:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:41:41 INFO - Running post-action listener: _resource_record_post_action 05:41:41 INFO - ##### 05:41:41 INFO - ##### Running read-buildbot-config step. 05:41:41 INFO - ##### 05:41:41 INFO - Running pre-action listener: _resource_record_pre_action 05:41:41 INFO - Running main action method: read_buildbot_config 05:41:41 INFO - Using buildbot properties: 05:41:41 INFO - { 05:41:41 INFO - "properties": { 05:41:41 INFO - "buildnumber": 577, 05:41:41 INFO - "product": "firefox", 05:41:41 INFO - "script_repo_revision": "production", 05:41:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:41:41 INFO - "repository": "", 05:41:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:41:41 INFO - "buildid": "20151124043003", 05:41:41 INFO - "slavename": "talos-linux64-ix-029", 05:41:41 INFO - "stage_platform": "linux64-pgo", 05:41:41 INFO - "basedir": "/builds/slave/test-pgo", 05:41:41 INFO - "nightly_build": "True", 05:41:41 INFO - "project": "", 05:41:41 INFO - "platform": "ubuntu64_hw", 05:41:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:41:41 INFO - "slavebuilddir": "test", 05:41:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:41:41 INFO - "branch": "mozilla-central", 05:41:41 INFO - "repo_path": "mozilla-central", 05:41:41 INFO - "pgo_build": "True", 05:41:41 INFO - "builduid": "cec94a7fe8234e4392cf82658b5d4f49", 05:41:41 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:41:41 INFO - }, 05:41:41 INFO - "sourcestamp": { 05:41:41 INFO - "repository": "", 05:41:41 INFO - "hasPatch": false, 05:41:41 INFO - "project": "", 05:41:41 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:41:41 INFO - "changes": [ 05:41:41 INFO - { 05:41:41 INFO - "category": null, 05:41:41 INFO - "files": [ 05:41:41 INFO - { 05:41:41 INFO - "url": null, 05:41:41 INFO - "name": "https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:41:41 INFO - } 05:41:41 INFO - ], 05:41:41 INFO - "repository": "", 05:41:41 INFO - "rev": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a", 05:41:41 INFO - "who": "sendchange", 05:41:41 INFO - "when": 1448372490, 05:41:41 INFO - "number": 6700149, 05:41:41 INFO - "comments": "", 05:41:41 INFO - "project": "", 05:41:41 INFO - "at": "Tue 24 Nov 2015 05:41:30", 05:41:41 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:41:41 INFO - "revlink": "", 05:41:41 INFO - "properties": [ 05:41:41 INFO - [ 05:41:41 INFO - "buildid", 05:41:41 INFO - "20151124030553", 05:41:41 INFO - "Change" 05:41:41 INFO - ], 05:41:41 INFO - [ 05:41:41 INFO - "builduid", 05:41:41 INFO - "02d4a55c39f24d7aa7b615644e0e2224", 05:41:41 INFO - "Change" 05:41:41 INFO - ], 05:41:41 INFO - [ 05:41:41 INFO - "nightly_build", 05:41:41 INFO - "True", 05:41:41 INFO - "Change" 05:41:41 INFO - ], 05:41:41 INFO - [ 05:41:41 INFO - "pgo_build", 05:41:41 INFO - "True", 05:41:41 INFO - "Change" 05:41:41 INFO - ] 05:41:41 INFO - ], 05:41:41 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:41:41 INFO - }, 05:41:41 INFO - { 05:41:41 INFO - "category": null, 05:41:41 INFO - "files": [ 05:41:41 INFO - { 05:41:41 INFO - "url": null, 05:41:41 INFO - "name": "https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:41:41 INFO - } 05:41:41 INFO - ], 05:41:41 INFO - "repository": "", 05:41:41 INFO - "rev": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a", 05:41:41 INFO - "who": "sendchange", 05:41:41 INFO - "when": 1448372491, 05:41:41 INFO - "number": 6700151, 05:41:41 INFO - "comments": "", 05:41:41 INFO - "project": "", 05:41:41 INFO - "at": "Tue 24 Nov 2015 05:41:31", 05:41:41 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:41:41 INFO - "revlink": "", 05:41:41 INFO - "properties": [ 05:41:41 INFO - [ 05:41:41 INFO - "buildid", 05:41:41 INFO - "20151124043003", 05:41:41 INFO - "Change" 05:41:41 INFO - ], 05:41:41 INFO - [ 05:41:41 INFO - "builduid", 05:41:41 INFO - "cec94a7fe8234e4392cf82658b5d4f49", 05:41:41 INFO - "Change" 05:41:41 INFO - ], 05:41:41 INFO - [ 05:41:41 INFO - "pgo_build", 05:41:41 INFO - "True", 05:41:41 INFO - "Change" 05:41:41 INFO - ] 05:41:41 INFO - ], 05:41:41 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:41:41 INFO - } 05:41:41 INFO - ], 05:41:41 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:41:41 INFO - } 05:41:41 INFO - } 05:41:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:41:41 INFO - Running post-action listener: _resource_record_post_action 05:41:41 INFO - ##### 05:41:41 INFO - ##### Running download-and-extract step. 05:41:41 INFO - ##### 05:41:41 INFO - Running pre-action listener: _resource_record_pre_action 05:41:41 INFO - Running main action method: download_and_extract 05:41:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:41 INFO - https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/test_packages.json 05:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/test_packages.json 05:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:41:44 INFO - Downloaded 1302 bytes. 05:41:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:41:44 INFO - Using the following test package requirements: 05:41:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'jsshell-linux-x86_64.zip'], 05:41:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:41:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:41:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:44 INFO - https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:50 INFO - Downloaded 22525937 bytes. 05:41:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:41:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:41:51 INFO - Return code: 0 05:41:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:51 INFO - https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:52 INFO - Downloaded 22525937 bytes. 05:41:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:41:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:41:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:41:54 INFO - Return code: 0 05:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:54 INFO - https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:41:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:41:55 INFO - Downloaded 11130997 bytes. 05:41:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:41:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:41:55 INFO - Return code: 0 05:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:55 INFO - https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:41:56 INFO - Downloaded 57624301 bytes. 05:41:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:56 INFO - mkdir: /builds/slave/test-pgo/properties 05:41:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:41:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:41:56 INFO - Contents: 05:41:56 INFO - build_url:https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:56 INFO - Running post-action listener: _resource_record_post_action 05:41:56 INFO - Running post-action listener: set_extra_try_arguments 05:41:56 INFO - ##### 05:41:56 INFO - ##### Running populate-webroot step. 05:41:56 INFO - ##### 05:41:56 INFO - Running pre-action listener: _resource_record_pre_action 05:41:56 INFO - Running main action method: populate_webroot 05:41:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:41:56 INFO - '../fennec_ids.txt'], 05:41:56 INFO - 'tests': ['tcheck2']}, 05:41:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:56 INFO - '--tppagecycles', 05:41:56 INFO - '7'], 05:41:56 INFO - 'tests': ['tsvgm']}}, 05:41:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:41:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:41:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:41:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'tests': ['damp', 'tps']}, 05:41:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['damp', 'tps']}, 05:41:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:41:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:56 INFO - 'other': {'tests': ['a11yr', 05:41:56 INFO - 'ts_paint', 05:41:56 INFO - 'tpaint', 05:41:56 INFO - 'sessionrestore', 05:41:56 INFO - 'sessionrestore_no_auto_restore']}, 05:41:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['a11yr', 05:41:56 INFO - 'ts_paint', 05:41:56 INFO - 'tpaint', 05:41:56 INFO - 'sessionrestore', 05:41:56 INFO - 'sessionrestore_no_auto_restore']}, 05:41:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['a11yr', 05:41:56 INFO - 'ts_paint', 05:41:56 INFO - 'tpaint', 05:41:56 INFO - 'sessionrestore', 05:41:56 INFO - 'sessionrestore_no_auto_restore']}, 05:41:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['a11yr', 05:41:56 INFO - 'ts_paint', 05:41:56 INFO - 'tpaint', 05:41:56 INFO - 'sessionrestore', 05:41:56 INFO - 'sessionrestore_no_auto_restore']}, 05:41:56 INFO - 'other_l64': {'tests': ['a11yr', 05:41:56 INFO - 'ts_paint', 05:41:56 INFO - 'tpaint', 05:41:56 INFO - 'sessionrestore', 05:41:56 INFO - 'sessionrestore_no_auto_restore']}, 05:41:56 INFO - 'other_nol64': {'tests': ['a11yr', 05:41:56 INFO - 'ts_paint', 05:41:56 INFO - 'tpaint', 05:41:56 INFO - 'sessionrestore', 05:41:56 INFO - 'sessionrestore_no_auto_restore']}, 05:41:56 INFO - 'svgr': {'tests': ['tsvgx', 05:41:56 INFO - 'tsvgr_opacity', 05:41:56 INFO - 'tart', 05:41:56 INFO - 'tscrollx', 05:41:56 INFO - 'cart']}, 05:41:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['tsvgx', 05:41:56 INFO - 'tsvgr_opacity', 05:41:56 INFO - 'tart', 05:41:56 INFO - 'tscrollx', 05:41:56 INFO - 'cart']}, 05:41:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'tests': ['tp5o']}, 05:41:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'talos_options': ['--e10s'], 05:41:56 INFO - 'tests': ['tp5o']}, 05:41:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'talos_options': ['--xperf_path', 05:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:56 INFO - 'tests': ['tp5n']}, 05:41:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:56 INFO - 'talos_options': ['--e10s', 05:41:56 INFO - '--xperf_path', 05:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:56 INFO - 'tests': ['tp5n']}}, 05:41:56 INFO - 'talos.zip': {'path': '', 05:41:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:56 INFO - Running post-action listener: _resource_record_post_action 05:41:56 INFO - ##### 05:41:56 INFO - ##### Running create-virtualenv step. 05:41:56 INFO - ##### 05:41:56 INFO - Running pre-action listener: _resource_record_pre_action 05:41:56 INFO - Running main action method: create_virtualenv 05:41:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:41:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:41:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:41:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:56 INFO - Using real prefix '/usr' 05:41:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:41:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:59 INFO - Installing pip.................done. 05:41:59 INFO - Return code: 0 05:41:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:41:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:41:59 INFO - Using env: {'DISPLAY': ':0', 05:41:59 INFO - 'HOME': '/home/cltbld', 05:41:59 INFO - 'LANG': 'en_US.UTF-8', 05:41:59 INFO - 'LANGUAGE': 'en_US:en', 05:41:59 INFO - 'LOGNAME': 'cltbld', 05:41:59 INFO - 'MAIL': '/var/mail/cltbld', 05:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:59 INFO - 'MOZ_NO_REMOTE': '1', 05:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:59 INFO - 'NO_EM_RESTART': '1', 05:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:59 INFO - 'SHELL': '/bin/bash', 05:41:59 INFO - 'SHLVL': '1', 05:41:59 INFO - 'TERM': 'linux', 05:41:59 INFO - 'TMOUT': '86400', 05:41:59 INFO - 'USER': 'cltbld', 05:41:59 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:59 INFO - '_': '/tools/buildbot/bin/python'} 05:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:42:01 INFO - Cleaning up... 05:42:01 INFO - Return code: 0 05:42:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:42:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:42:01 INFO - Using env: {'DISPLAY': ':0', 05:42:01 INFO - 'HOME': '/home/cltbld', 05:42:01 INFO - 'LANG': 'en_US.UTF-8', 05:42:01 INFO - 'LANGUAGE': 'en_US:en', 05:42:01 INFO - 'LOGNAME': 'cltbld', 05:42:01 INFO - 'MAIL': '/var/mail/cltbld', 05:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:01 INFO - 'MOZ_NO_REMOTE': '1', 05:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:01 INFO - 'NO_EM_RESTART': '1', 05:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:01 INFO - 'SHELL': '/bin/bash', 05:42:01 INFO - 'SHLVL': '1', 05:42:01 INFO - 'TERM': 'linux', 05:42:01 INFO - 'TMOUT': '86400', 05:42:01 INFO - 'USER': 'cltbld', 05:42:01 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:01 INFO - '_': '/tools/buildbot/bin/python'} 05:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:01 INFO - Downloading/unpacking psutil>=0.7.1 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:42:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:42:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:42:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:03 INFO - Installing collected packages: psutil 05:42:03 INFO - Running setup.py install for psutil 05:42:03 INFO - building 'psutil._psutil_linux' extension 05:42:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:42:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:42:04 INFO - building 'psutil._psutil_posix' extension 05:42:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:42:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:42:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:04 INFO - Successfully installed psutil 05:42:04 INFO - Cleaning up... 05:42:04 INFO - Return code: 0 05:42:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:42:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:42:04 INFO - Using env: {'DISPLAY': ':0', 05:42:04 INFO - 'HOME': '/home/cltbld', 05:42:04 INFO - 'LANG': 'en_US.UTF-8', 05:42:04 INFO - 'LANGUAGE': 'en_US:en', 05:42:04 INFO - 'LOGNAME': 'cltbld', 05:42:04 INFO - 'MAIL': '/var/mail/cltbld', 05:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:04 INFO - 'MOZ_NO_REMOTE': '1', 05:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:04 INFO - 'NO_EM_RESTART': '1', 05:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:04 INFO - 'SHELL': '/bin/bash', 05:42:04 INFO - 'SHLVL': '1', 05:42:04 INFO - 'TERM': 'linux', 05:42:04 INFO - 'TMOUT': '86400', 05:42:04 INFO - 'USER': 'cltbld', 05:42:04 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:04 INFO - '_': '/tools/buildbot/bin/python'} 05:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:42:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:42:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:42:06 INFO - Installing collected packages: mozsystemmonitor 05:42:06 INFO - Running setup.py install for mozsystemmonitor 05:42:06 INFO - Successfully installed mozsystemmonitor 05:42:06 INFO - Cleaning up... 05:42:06 INFO - Return code: 0 05:42:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:42: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')]} 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:42:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:42:06 INFO - Using env: {'DISPLAY': ':0', 05:42:06 INFO - 'HOME': '/home/cltbld', 05:42:06 INFO - 'LANG': 'en_US.UTF-8', 05:42:06 INFO - 'LANGUAGE': 'en_US:en', 05:42:06 INFO - 'LOGNAME': 'cltbld', 05:42:06 INFO - 'MAIL': '/var/mail/cltbld', 05:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:06 INFO - 'MOZ_NO_REMOTE': '1', 05:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:06 INFO - 'NO_EM_RESTART': '1', 05:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:06 INFO - 'SHELL': '/bin/bash', 05:42:06 INFO - 'SHLVL': '1', 05:42:06 INFO - 'TERM': 'linux', 05:42:06 INFO - 'TMOUT': '86400', 05:42:06 INFO - 'USER': 'cltbld', 05:42:06 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:06 INFO - '_': '/tools/buildbot/bin/python'} 05:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:42:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:09 INFO - Downloading docopt-0.6.1.tar.gz 05:42:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:42:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:09 INFO - Running setup.py install for blobuploader 05:42:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:42:09 INFO - Running setup.py install for requests 05:42:09 INFO - Running setup.py install for docopt 05:42:09 INFO - Successfully installed blobuploader requests docopt 05:42:09 INFO - Cleaning up... 05:42:10 INFO - Return code: 0 05:42:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:42:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:10 INFO - Using env: {'DISPLAY': ':0', 05:42:10 INFO - 'HOME': '/home/cltbld', 05:42:10 INFO - 'LANG': 'en_US.UTF-8', 05:42:10 INFO - 'LANGUAGE': 'en_US:en', 05:42:10 INFO - 'LOGNAME': 'cltbld', 05:42:10 INFO - 'MAIL': '/var/mail/cltbld', 05:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:10 INFO - 'MOZ_NO_REMOTE': '1', 05:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:10 INFO - 'NO_EM_RESTART': '1', 05:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:10 INFO - 'SHELL': '/bin/bash', 05:42:10 INFO - 'SHLVL': '1', 05:42:10 INFO - 'TERM': 'linux', 05:42:10 INFO - 'TMOUT': '86400', 05:42:10 INFO - 'USER': 'cltbld', 05:42:10 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:10 INFO - '_': '/tools/buildbot/bin/python'} 05:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:42:10 INFO - Running setup.py (path:/tmp/pip-gxxYXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:42:10 INFO - Running setup.py (path:/tmp/pip-7rJiuT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:42:10 INFO - Running setup.py (path:/tmp/pip-ilRtBW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:42:10 INFO - Running setup.py (path:/tmp/pip-fwv5wh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:42:10 INFO - Running setup.py (path:/tmp/pip-AUW2Z2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:42:10 INFO - Running setup.py (path:/tmp/pip-JPNp0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:42:10 INFO - Running setup.py (path:/tmp/pip-sEHyVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:42:10 INFO - Running setup.py (path:/tmp/pip-ry7v2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:42:10 INFO - Running setup.py (path:/tmp/pip-DdiCDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:42:10 INFO - Running setup.py (path:/tmp/pip-qRmTlQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:42:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:42:10 INFO - Running setup.py (path:/tmp/pip-petgS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:42:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:42:11 INFO - Running setup.py (path:/tmp/pip-GoIflI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:42:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:42:11 INFO - Running setup.py (path:/tmp/pip-A5GFGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:42:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:42:11 INFO - Running setup.py (path:/tmp/pip-XX9oTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:42:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:42:11 INFO - Running setup.py (path:/tmp/pip-kTcuUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:42:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:42:11 INFO - Running setup.py (path:/tmp/pip-0Iq51g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:42:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:42:11 INFO - Running setup.py (path:/tmp/pip-mBpRsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:42:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:11 INFO - Running setup.py install for manifestparser 05:42:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:42:11 INFO - Running setup.py install for mozcrash 05:42:11 INFO - Running setup.py install for mozdebug 05:42:11 INFO - Running setup.py install for mozdevice 05:42:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:42:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:42:11 INFO - Running setup.py install for mozfile 05:42:11 INFO - Running setup.py install for mozhttpd 05:42:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for mozinfo 05:42:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for mozInstall 05:42:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for mozleak 05:42:12 INFO - Running setup.py install for mozlog 05:42:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for moznetwork 05:42:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for mozprocess 05:42:12 INFO - Running setup.py install for mozprofile 05:42:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for mozrunner 05:42:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:42:12 INFO - Running setup.py install for mozscreenshot 05:42:13 INFO - Running setup.py install for moztest 05:42:13 INFO - Running setup.py install for mozversion 05:42:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:42:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:13 INFO - Cleaning up... 05:42:13 INFO - Return code: 0 05:42:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:42:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:13 INFO - Using env: {'DISPLAY': ':0', 05:42:13 INFO - 'HOME': '/home/cltbld', 05:42:13 INFO - 'LANG': 'en_US.UTF-8', 05:42:13 INFO - 'LANGUAGE': 'en_US:en', 05:42:13 INFO - 'LOGNAME': 'cltbld', 05:42:13 INFO - 'MAIL': '/var/mail/cltbld', 05:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:13 INFO - 'MOZ_NO_REMOTE': '1', 05:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:13 INFO - 'NO_EM_RESTART': '1', 05:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:13 INFO - 'SHELL': '/bin/bash', 05:42:13 INFO - 'SHLVL': '1', 05:42:13 INFO - 'TERM': 'linux', 05:42:13 INFO - 'TMOUT': '86400', 05:42:13 INFO - 'USER': 'cltbld', 05:42:13 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:13 INFO - '_': '/tools/buildbot/bin/python'} 05:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:42:13 INFO - Running setup.py (path:/tmp/pip-Gkq1QI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:42:13 INFO - Running setup.py (path:/tmp/pip-VohoV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:42:13 INFO - Running setup.py (path:/tmp/pip-yql7Mt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:42:13 INFO - Running setup.py (path:/tmp/pip-b0Aoig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:42:13 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)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:42:13 INFO - Running setup.py (path:/tmp/pip-3YS_A_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:42:13 INFO - Running setup.py (path:/tmp/pip-9bRCVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:42:13 INFO - Running setup.py (path:/tmp/pip-LHfgHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:42:13 INFO - Running setup.py (path:/tmp/pip-zZ2kVl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:42:14 INFO - Running setup.py (path:/tmp/pip-tYO9Py-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:42:14 INFO - Running setup.py (path:/tmp/pip-mMTuV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:42:14 INFO - Running setup.py (path:/tmp/pip-IUDh5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:42:14 INFO - Running setup.py (path:/tmp/pip-fK_SM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:42:14 INFO - Running setup.py (path:/tmp/pip-lnyVLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:42:14 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)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:42:14 INFO - Running setup.py (path:/tmp/pip-6tdl2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:42:14 INFO - Running setup.py (path:/tmp/pip-Y3Mwq7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:42:14 INFO - Running setup.py (path:/tmp/pip-b0VOps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:42:14 INFO - Running setup.py (path:/tmp/pip-jhaC5U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:14 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)) 05:42:14 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)) 05:42:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:16 INFO - Downloading blessings-1.5.1.tar.gz 05:42:16 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:42:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:16 INFO - Installing collected packages: blessings 05:42:16 INFO - Running setup.py install for blessings 05:42:16 INFO - Successfully installed blessings 05:42:16 INFO - Cleaning up... 05:42:16 INFO - Return code: 0 05:42:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:42:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:42:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:42:16 INFO - Reading from file tmpfile_stdout 05:42:16 INFO - Current package versions: 05:42:16 INFO - argparse == 1.2.1 05:42:16 INFO - blessings == 1.5.1 05:42:16 INFO - blobuploader == 1.2.4 05:42:16 INFO - docopt == 0.6.1 05:42:16 INFO - manifestparser == 1.1 05:42:16 INFO - mozInstall == 1.12 05:42:16 INFO - mozcrash == 0.16 05:42:16 INFO - mozdebug == 0.1 05:42:16 INFO - mozdevice == 0.47 05:42:16 INFO - mozfile == 1.2 05:42:16 INFO - mozhttpd == 0.7 05:42:16 INFO - mozinfo == 0.9 05:42:16 INFO - mozleak == 0.1 05:42:16 INFO - mozlog == 3.1 05:42:16 INFO - moznetwork == 0.27 05:42:16 INFO - mozprocess == 0.22 05:42:16 INFO - mozprofile == 0.27 05:42:16 INFO - mozrunner == 6.11 05:42:16 INFO - mozscreenshot == 0.1 05:42:16 INFO - mozsystemmonitor == 0.0 05:42:16 INFO - moztest == 0.7 05:42:16 INFO - mozversion == 1.4 05:42:16 INFO - psutil == 3.1.1 05:42:16 INFO - requests == 1.2.3 05:42:16 INFO - wsgiref == 0.1.2 05:42:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf4169dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:42:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:16 INFO - Using env: {'DISPLAY': ':0', 05:42:16 INFO - 'HOME': '/home/cltbld', 05:42:16 INFO - 'LANG': 'en_US.UTF-8', 05:42:16 INFO - 'LANGUAGE': 'en_US:en', 05:42:16 INFO - 'LOGNAME': 'cltbld', 05:42:16 INFO - 'MAIL': '/var/mail/cltbld', 05:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:16 INFO - 'MOZ_NO_REMOTE': '1', 05:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:16 INFO - 'NO_EM_RESTART': '1', 05:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:16 INFO - 'SHELL': '/bin/bash', 05:42:16 INFO - 'SHLVL': '1', 05:42:16 INFO - 'TERM': 'linux', 05:42:16 INFO - 'TMOUT': '86400', 05:42:16 INFO - 'USER': 'cltbld', 05:42:16 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:16 INFO - '_': '/tools/buildbot/bin/python'} 05:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 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)) 05:42:17 INFO - Cleaning up... 05:42:17 INFO - Return code: 0 05:42:17 INFO - Running post-action listener: _resource_record_post_action 05:42:17 INFO - Running post-action listener: _start_resource_monitoring 05:42:17 INFO - Starting resource monitoring. 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running install step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: install 05:42:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:42:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:42:17 INFO - Reading from file tmpfile_stdout 05:42:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:42:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:42:17 INFO - Reading from file tmpfile_stdout 05:42:17 INFO - Output received: 05:42:17 INFO - Usage: mozinstall [options] installer 05:42:17 INFO - Options: 05:42:17 INFO - -h, --help show this help message and exit 05:42:17 INFO - -d DEST, --destination=DEST 05:42:17 INFO - Directory to install application into. [default: 05:42:17 INFO - "/builds/slave/test-pgo"] 05:42:17 INFO - --app=APP Application being installed. [default: firefox] 05:42:17 INFO - mkdir: /builds/slave/test-pgo/build/application 05:42:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:42:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:42:31 INFO - Reading from file tmpfile_stdout 05:42:31 INFO - Output received: 05:42:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:42:31 INFO - Running post-action listener: _resource_record_post_action 05:42:31 INFO - ##### 05:42:31 INFO - ##### Running run-tests step. 05:42:31 INFO - ##### 05:42:31 INFO - Running pre-action listener: _resource_record_pre_action 05:42:31 INFO - Running main action method: run_tests 05:42:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:42:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:42:31 INFO - Python 2.7.3 05:42:31 INFO - Return code: 0 05:42:31 INFO - grabbing minidump binary from tooltool 05:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:31 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 0xe63d70>, '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 0xe64b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:42:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:42:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:42:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:32 INFO - Return code: 0 05:42:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:42:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:42:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:42:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:42:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:42:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:42:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 05:42:32 INFO - Using env: {'DISPLAY': ':0', 05:42:32 INFO - 'HOME': '/home/cltbld', 05:42:32 INFO - 'LANG': 'en_US.UTF-8', 05:42:32 INFO - 'LANGUAGE': 'en_US:en', 05:42:32 INFO - 'LOGNAME': 'cltbld', 05:42:32 INFO - 'MAIL': '/var/mail/cltbld', 05:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:32 INFO - 'MOZ_NO_REMOTE': '1', 05:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:32 INFO - 'NO_EM_RESTART': '1', 05:42:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:42:32 INFO - 'SHELL': '/bin/bash', 05:42:32 INFO - 'SHLVL': '1', 05:42:32 INFO - 'TERM': 'linux', 05:42:32 INFO - 'TMOUT': '86400', 05:42:32 INFO - 'USER': 'cltbld', 05:42:32 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542', 05:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:32 INFO - '_': '/tools/buildbot/bin/python'} 05:42:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 05:42:32 INFO - mozversion INFO | application_buildid: 20151124043003 05:42:32 INFO - mozversion INFO | application_changeset: 45273bbed8efaface6f5ec56d984cb9faf4fbb6a 05:42:32 INFO - mozversion INFO | application_display_name: Nightly 05:42:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:32 INFO - mozversion INFO | application_name: Firefox 05:42:32 INFO - mozversion INFO | application_remotingname: firefox 05:42:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:42:32 INFO - mozversion INFO | application_vendor: Mozilla 05:42:32 INFO - mozversion INFO | application_version: 45.0a1 05:42:32 INFO - mozversion INFO | platform_buildid: 20151124043003 05:42:32 INFO - mozversion INFO | platform_changeset: 45273bbed8efaface6f5ec56d984cb9faf4fbb6a 05:42:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:42:32 INFO - mozversion INFO | platform_version: 45.0a1 05:42:32 INFO - 2015-11-24 05:42:32,449 DEBUG : using testdate: 1448372552 05:42:32 INFO - 2015-11-24 05:42:32,449 DEBUG : actual date: 1448372552 05:42:32 INFO - 2015-11-24 05:42:32,456 INFO : starting webserver on 'localhost:34860' 05:42:32 INFO - 2015-11-24 05:42:32,456 INFO : Starting test suite talos-linux64-ix-029 05:42:32 INFO - 2015-11-24 05:42:32,457 INFO : Starting test dromaeo_css 05:42:32 INFO - 2015-11-24 05:42:32,457 DEBUG : operating with platform_type : linux_ 05:42:32 INFO - 2015-11-24 05:42:32,457 INFO : Initialising browser for dromaeo_css test... 05:42:32 INFO - 2015-11-24 05:42:32,593 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZuYrpE/profile http://localhost:34860/getInfo.html 05:42:37 INFO - 2015-11-24 05:42:37,798 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:42:37 INFO - 2015-11-24 05:42:37,798 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:42:37 INFO - 2015-11-24 05:42:37,798 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:42:37 INFO - 2015-11-24 05:42:37,798 DEBUG : BROWSER_OUTPUT: __metrics 05:42:37 INFO - 2015-11-24 05:42:37,967 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:39 INFO - 2015-11-24 05:42:39,162 INFO : Browser initialized. 05:42:39 INFO - 2015-11-24 05:42:39,163 INFO : Running cycle 1/1 for dromaeo_css test... 05:42:39 INFO - 2015-11-24 05:42:39,163 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZuYrpE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:42:50 INFO - 2015-11-24 05:42:50,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 140460032 05:42:50 INFO - 2015-11-24 05:42:50,937 DEBUG : BROWSER_OUTPUT: 05:43:41 INFO - 2015-11-24 05:43:41,695 DEBUG : BROWSER_OUTPUT: 1448372621693 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:45:52 INFO - 2015-11-24 05:45:52,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34860/tests/dromaeo/cssquery-ext.html) 05:45:53 INFO - 2015-11-24 05:45:53,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 243924992 05:45:53 INFO - 2015-11-24 05:45:53,186 DEBUG : BROWSER_OUTPUT: 05:48:55 INFO - 2015-11-24 05:48:55,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/dromaeo/cssquery-ext.html (next: http://localhost:34860/tests/dromaeo/cssquery-jquery.html) 05:48:55 INFO - 2015-11-24 05:48:55,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 225304576 05:48:55 INFO - 2015-11-24 05:48:55,990 DEBUG : BROWSER_OUTPUT: 05:51:57 INFO - 2015-11-24 05:51:57,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34860/tests/dromaeo/cssquery-mootools.html) 05:51:58 INFO - 2015-11-24 05:51:58,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 218185728 05:51:58 INFO - 2015-11-24 05:51:58,556 DEBUG : BROWSER_OUTPUT: 05:55:00 INFO - 2015-11-24 05:55:00,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34860/tests/dromaeo/cssquery-prototype.html) 05:55:01 INFO - 2015-11-24 05:55:01,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 199311360 05:55:01 INFO - 2015-11-24 05:55:01,043 DEBUG : BROWSER_OUTPUT: 05:58:03 INFO - 2015-11-24 05:58:03,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34860/tests/dromaeo/cssquery-yui.html) 05:58:04 INFO - 2015-11-24 05:58:04,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 203821056 05:58:04 INFO - 2015-11-24 05:58:04,051 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/dromaeo/cssquery-yui.html (next: http://localhost:34860/tests/dromaeo/cssquery-dojo.html) 06:01:06 INFO - 2015-11-24 06:01:06,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 286052352 06:01:06 INFO - 2015-11-24 06:01:06,732 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:01:06 INFO - 2015-11-24 06:01:06,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:01:06 INFO - 2015-11-24 06:01:06,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:01:06 INFO - 2015-11-24 06:01:06,733 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:01:06 INFO - 2015-11-24 06:01:06,736 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3197.2326641606014;3245.318483118545;3286.2605913669413;3288.4738441849295;3323.08615130839;5341.813036543722;5441.238226648267;5457.045017121997;5510.752016159272;5533.225348451215;5348.518633323;5388.811391601294;5438.619296649236;5447.863803404917;5451.127819548873;4944.851654450364;4981.452040275585;5046.7224302663335;5070.847874563769;5134.4095429025765;4911.68074075184;5117.590592752571;5130.333056702623;5131.230315452674;5200.063988482072;4900.583450406738;4968.527989840959;4976.576990955773;4980.850574482772;5002.974985125051;5027.84916452507;5029.723365214912;5033.194688849767;5041.143005689041;5080;4857.562819346241;4981.27771473138;4985.052839960432;4993.176125939216;5059.241113832918;5240.4497527759795;5286.365636123652;5324.600654950894;5343.572514198855;5369.892602147936;5995.250593675791;5997.280326360821;5998;5999.73001214942;6002.789902353396;5814.5057670098095;5945.524358051345;5990.041593345088;6007.669578173199;6015.458608725192;5418;5511.889762204773;5512.421195774426;5534.833954981357;5537.335519737658;6059.878802423927;6105.755769769248;6111.388861113853;6122.245686735527;6134.631922084689;5856.355800861902;5896.3219229788265;5906.350301466835;5907.793227237026;5908.645481271137;5815.447532484407;5873.236479257755;5936.8812623748145;5968.791092311835;6051.394860513913;5862.941370586324;5867.3839246879315;5870.207521984477;5876.970615146983;5879.617824841372;5806.680632565165;5875.706214689249;5901.02633065548;5902.3507414184405;5923.08192230205;4508.481524624644;4541.568550987651;4555.612772914339;4557.111363284194;4559.794809233593;3990.1221731219084;4059.715819892638;4082.4896887889013;4097.057676734368;4107.034846810997;5583.916241256385;5585.553155747531;5591.944080559224;5596.104623260258;5621.072523033736;5864.2083318752275;5895.35151133375;5898.380670029585;5906.0255057914965;5911.497522710618;5494.36814766307;5544.22380866679;5563.36021357541;5625.6905870176715;5627.915581266284;5125.282460455539;5137.768800403991;5147.279380886679;5152.433232344439;5158.226266060121;6059.787907423307;6073.301570319381;6079.513638908788;6087.147799308101;6089.756409743649;5791.449812267828;5795.94204057954;5868.559858010752;5899.439553242435;5915.290165180206;6073.589209560717;6100.951132821025;6125.307137552789;6126.468382904274;6131.491756816045;5802.071668533014;5802.767889284381;5806.071028635567;5818.650880947157;5867.647941123546;5813.302403711582;5871.295444546682;5877.682275641614;5892.410758924073;5950.910736338872;5731.914021289601;5829.15477255804;5836.328822185503;5839.5912286141265;5897.734601943009;5818.069108942549;5839.211706419749;5847.649141051551;5856.531477481876;5861.179434879035;5630.408807075362;5669.489745922887;5711.314642242957;5734.22587950638;5763.193152958505;5692.857678558069;5787.39232380594;5830.912536312044;5832.854178645568;5835.153902684172;5631.465010823965;5681.147827825859;5682.77268909239;5688.260526131577;5690.118031705092 06:01:06 INFO - 2015-11-24 06:01:06,738 DEBUG : BROWSER_OUTPUT: |1;ext.html;589.4105894105894;590.9556783241256;598.3537779198466;600.1867469578724;600.6216083867163;32080.518792218107;32799.508007379845;32938.50592241118;32940.34119317612;33011.504827427605;40770;41335.586644133626;41402.7929860351;41447.58552414475;41503.79248103763;8826.514541700204;8957.462552246854;8963.507007114606;8972;8973.730788076367;7811.882821757678;7990.720324788634;8004.719834805783;8812.206901378875;10352.327098738595;10307.12389446898;10384.688459346231;10401.375917444977;10417.27079104463;10418.9479052605;10257.410101434252;10285.177185825116;10351.120154786851;10357.171426285917;10369.948150259239;7777.494462859952;7988.680452781882;10689.732756681067;10906.61826836065;10960.890391096147;40160.196796063916;40591.94080591947;40672.59327406718;40779.59220407817;40811.7959410204;3150;3264.1023718477372;3277.4264503711993;3290.68738469845;3671.687906527948;31165.844170779226;31467.84266078655;31648;31750.682493175234;32539.51190732141;3895.7662540247675;3943.921121577552;3999.7800120993334;4010.639042486161;4058.431819545266;273751;274412.627936861;274712;275482;275518;56140.71929640326;58041;58669.70665146647;58930.70534647385;59143.40856591465;67070.66464667645;68138.31861681418;68390.65804670945;68535;68565;14498.492552760603;14578.927105364406;14613.780793287897;14686.779698304534;14711.411543538139;11997.040236781037;12048.578299759467;12060.155789094679;12065.215760975509;12073.396330183632;19230.00039979231;19484.68924807308;19587.314443994394;19627.901860490892;19690;7191.532550384209;7332.706691732377;7378.852422951511;7383.2985866342615;7464.477486575996;837.5267973594899;919.4437365393974;1134.5235001299475;1134.7560274541013;1154.440096553171;28806.135815925136;31484;31830;32130.61321832793;32234;1016.903394177552;1029.161233594618;1036.2435422141878;1079.4926384599225;1183.0890214534932;14511.419543218364;14620.342084606218;14663.453141918828;14756.188409637572;14808.925955370154;315162;316365;318466;318710;319863;51160;51416.74291628518;51473;51524.742376287875;51535.22697159545;1309.796981467874;1368;1374.9450021999007;1381.8203633527778;1383.2046573220439;27076.1877143686;27741.583876241468;27871.86064069748;28195.295117622223;28337.29156771097;41976.58023419727;44990.77504612456;45249.54750452453;45374;45486;208948;313931;320679;322948;323089;28274.85862570674;28934.42131157323;28969.420611588073;28982;28991.275218119717;38443.2311353777;39494.60505394909;39611.80194099011;39846.40230396488;39887.60112398955;34765;36137.45793813042;38220;38670.6132938667;40377.79811100926;36197.63802361942;36277.63722362848;36464;36769;36891.81554092212;35346.64653353434;35710.285794284486;36410.4538431929;36431.635683643886;36490.45264320984;31162.22094447657;31656.208594785316;33526;33587.83206083954;33700.15749606279;24366.51266974686;24713.876430617733;24758;24822;25142.24573262805 06:01:06 INFO - 2015-11-24 06:01:06,738 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.9227969846633;350.95262139611145;353.9840707168179;355.13170298619866;357.13929430073495;14067.08563943343;14374.281285935715;16264.674706505863;16441.671166576678;17129.999999999985;16547.751783723255;16585.91707041463;16628.66742665146;16951.57621059474;16970.40603578875;5258.316418865542;5389.703566303851;5391.973040134794;5394.703291318976;5397.379301380332;3974.6820254379727;4095.6313931746135;5326.280952071459;5709.514691251248;5850.151727999438;5752.683602401888;5766.855828604297;5775.104858746901;5848.853778655546;5851.8537036574;5581.302337207849;5766.826995190151;5767.798127065554;5768.221290125821;5771.624844385102;5072.467390923974;5093.567046801027;5095.79616815327;5099.464556221617;5107.87230319245;19804.207831686716;19887.900560497248;20218.595628087503;20998.685019724715;21040.263590774248;2131.5630295789324;2173.9347819565437;2183.879886606236;2511.974880251192;2614.5947378156416;12765.553205637758;13171.473141074346;13265.734685306335;13513.662158446117;13557.728845423135;1812.5287425269526;1825.2727020766895;1827.6943848780895;1881.698928171486;1891.9621607567772;56389;56912.86174276533;57116.71441642807;57220;58410;9432.575534100983;9706.272029597809;9838.26213034011;9844.163246124017;9895.604175832887;13099.279539625411;13133.934330328479;13135.474581016651;13156.60530184096;13173.47306107745;7324.121105467378;7480.588567628833;7627.580483073484;7637.236276372319;7670.539767613961;7268;7282.890756638654;7290.614783191177;7306.671199796022;7342.743003994835;4269.060806622538;4281.850135245314;4298.140371925628;4309.41822853917;4341.305391137403;1685.8482736553524;1729.5935455168026;1740.5648587853036;1778.8221177882367;1786.8927864327923;864.6368525219423;867.6789587852535;869.6043300298476;895.4358753984948;974.2790335151936;15273.847261527242;15925.283362248727;16190.919045404933;16959.406420775213;18069.548261293574;892.4689809563299;906.1889608800087;906.428949761646;939.2063706168277;1002.8796544414571;7904.802379940433;8776.736697899074;9206.861897071549;9319.207867331354;9803.656872009446;516894;520689;521599;524689;532139;77446;78898;79105.20894791094;79823.60088199521;80442;1164.2490593567102;1168.8714241433436;1175.835383046374;1176.200183874956;1183.9940800295772;15430.382784688936;15504.457343992906;15533.611659708145;15670.9216453917;15873.920630396775;33704.325913482084;34023.82988085044;34317.82841085779;35149.47275790814;35344.29311413809;44557.55442445534;45116.54883451123;45696.31455528236;45810;47981.52018479771;9079.455232685796;9166.037566055735;9287;9295.72112836616;9337.019612940543;11434.085273178292;11477.08183345347;11503.597374092202;12872.35638218104;12965.67880081503;11529.711757206136;13462.259575723428;14269.71460570762;14537.055091419024;14714.411423542939;10347.379157250589;13929.23389213603;14317.928410357881;14498;14916.776248356065;14253.50112746049;14498.85501144975;14970.925145374204;15110.39558417651;15258.389664413298;9392.389494682824;9440.055994400505;9510.762230944281;9514.857277140987;9696.272779541421;13813.792793108312;13887;14129.364178611782;14196.503122390666;15033 06:01:06 INFO - 2015-11-24 06:01:06,739 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1553.0526378908871;1646.4155224895162;1672.4731709511502;1700.1669182100766;1702.2850402830813;6509.609423434591;7195.496315257928;7357.190709022017;7365.33711965923;7367.594782286972;7268;7385.187629360766;7389.113306403226;7401.370883474911;7407.666655000525;1944.513871532117;1967.3409407848387;1970.1725275384374;2211.413975296544;2232.7767223277624;2218.4786575154826;2265.818734501236;2267.1498188179435;2270.0579259607325;2277.7380601230907;2177.2162021672184;2185.8142057925097;2284.9543009139807;2286.4969706664506;2288.6452599846966;1930.237556165314;1971.684530475117;2166.1118941234176;2191.5726433345503;2205.4817117977263;2181.334692918659;2192.3642143778284;2192.440927563461;2202.6365649667787;2202.8458007939453;7426.368758655521;7525;7528.322450979384;7546.396288296923;7551.924480755232;4417.4919884213405;4499.865004049851;4528.796204170821;4534.1158474097565;4537.841175558872;2943.9558406623705;2952.7490163336142;2992.62592175978;2994.5358469437274;3087.6140482439696;979.5249304087512;989.1295659819385;1000.024975648744;1007.7128018514761;1045.2265323660436;9778.217742580577;9784.90215097847;9795.167410770022;9813.165880900133;9892.505374731234;4033.5361433435532;4119.279126152971;4147.543770185277;4154.1068670236045;4201.432806571135;8618.612162452704;8626.18051285127;8640.956795215983;8649.1350864913;8651.48091114535;4593.540645935446;4597.4712908015335;4599.08018396322;4601.079784043205;4608.663487588562;4217.219814334358;4220.240356735756;4220.599043090901;4226.049138943713;4228.238916994909;3594.1913069559664;3621.5654121505586;3627.093226693327;3640.2537479816574;3640.3629364861044;1192.6004788395985;1200.783858905388;1203.6629743671785;1205.4997176171967;1213.872543382932;1104.939228342433;1130.813415786386;1140.0936255676756;1148.0872706198593;1156.4738044189874;6670.899936500957;6848.1097457331225;7079.858402831915;7320.487565870444;7331.926680733124;572.9512991395778;585.2625691628493;591.1221835574169;608.3004544773546;613.1446631948496;5354.518093371537;5362.088444964287;5363.490468405495;5379.193121031798;5386.245925570423;8251.669933202606;8749.08134645853;8775.736727898173;8778.517181555077;8782.956085219661;8560.1867822558;8625.568721563897;8627.180417860292;8647.87577614906;8654.22112009922;6772.8984065239065;6887.139107611549;7015.684294206773;7028.297170282931;7030.543014704028;6553.639549824615;6562;6570.901436478553;6571.112899758471;6581.80254592363;7594.050743657043;7966.16355282687;7972.322352600094;7977.361811055218;7986.321162701003;7959.363250940027;7973.601319934096;8132.308753755997;8137.593120344078;8180.7954801130445;6486.286508483969;6522.15212022434;6522.315156908457;6531.183602049744;6575.967120164369;7106.076210092655;7145.714171433085;7157.57054576727;7174.390176835028;7175.928240717526;6551.574147680385;6762.087118238975;6787.524873258824;6804.149481314836;6845.965770171118;6721.563098398588;6734.595924244365;6735.124433823572;6796.694148763218;6806.115205023315;5754.395788442153;5884.764609415746;6726.630035347907;6745.4266387355665;6790.966045169743;6017.308009578955;6126.540509461897;6170.167027451416;6174.043023331391;6175.413335733098;5961.761529538943;5992.13114098462;5993.820185394445;6004.1294012368835;6004.729787159501 06:01:06 INFO - 2015-11-24 06:01:06,740 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.95478632991376;326.0641957581741;326.1276086468696;331.1505987142978;332.43486073674757;5904.645721256722;5927.970360148199;5960.64236145831;5994.160817485545;6051.455369016788;5865.090910908805;5872.442117998783;5923.259592550931;5923.3188183358925;5927.496162826165;4559.133764584718;4575.428071491072;4582.152301824157;4588.380568623244;4594.425696787902;4515.967814483479;4546.318052292166;4586.564276393738;4586.610138138246;4588.7246765194195;4520.141173177102;4529.886752831189;4531.6601254905845;4536.841210557631;4543.954560454403;4329.935050974206;4508.549145085465;4510.188166130095;4524.615407690334;4529.388532548097;3880.301545721769;3925.489686340786;3964.980175099135;3977.5226972763166;4013.137175507251;5571.4428557144365;5587;5587.189857470685;5596.2165296858475;5611.438856114397;5040.571551418134;5145.794168233266;5168.2764412982215;5261.789528418897;5301.045811753883;6260.937390626081;6273.843153921189;6286.622802631857;6286.779962701329;6288.151099601587;4424.690271680984;4429.512753597101;4432.53458386868;4433.445819272591;4433.933490997638;6322.272938612026;6418.614883106982;6485.513586481033;6507.6420796856155;6508.64202468864;4417.094495628388;4439.356293337512;4440.4005459263235;4440.977795111004;4443.133588950123;4480.574345437179;4481.932771008437;4484.34079390621;4484.618807401343;4497.662675299365;5215.191645294985;5218.478152184751;5227.320448341691;5231.372235331784;5232.372115346183;6150.323464418911;6321.905171422432;6329.303776584572;6337.795818794414;6347.777827776005;1612.7500237463212;1628.9674206515804;1630.9021458712516;1631.4697723239995;1631.5350125214256;1098.1050443888205;1116.146148196614;1120.6999880138999;1137.5165554639411;1143.0284258380311;6177.783777567854;6186.19579454677;6187.690615469299;6188.504919606421;6188.535859810442;6524;6533.509986751013;6536.575122617015;6538.640374779433;6539.08452816606;6032.668203248776;6167.537434692416;6168.1056246843955;6172.537059720539;6183.3816618337805;3497.6883668624264;3530.2409981854025;3530.329237444929;3532.682058614737;3533.840977156034;6763.425108865703;6767.492438067165;6773.559718618274;6774.288699686462;6784.93215067843;6436.452901503331;6656.633885136364;6666.733330666816;6670.633115178712;6672.666366681647;6348.936510634834;6569.37590928861;6735.494837887178;6838.829029274308;6849.349311815369;6554.082428459924;6566.868662626816;6574.243961944438;6578.901316480161;6579.078928950046;6452.193475815523;6463.353664633499;6490.448311893542;6492.935070649422;6501.2198536175965;6586.637734924625;6800.795976120724;6810.6594670265295;6820.965895170492;6825.590464572141;4357.215701173693;4372.060007098489;4395.230834603995;4403.295472724349;4403.493598236244;6511.576747511396;6513.348665133449;6521.217453905372;6529.640869752209;6540.803775886731;6284.354421361397;6307.180066591497;6371.904421433589;6375.394337537927;6382.170317858649;6308.779192728232;6312.147860038836;6343;6357.745690172526;6366.490680745436;6247;6247.156633854372;6259.1550140730415;6261.812145635638;6263.342349053466;6279.686015699288;6358.841028974312;6393;6395.296517383177;6401.711922963571;6247.187865577446;6248.687565621792;6250.3749625037135;6251.187345645037;6253.6560489173535 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: |5;yui.html;754.3851760814936;757.0725860820496;787.5353541410568;798.4091772088656;851.9062903080662;13404.061715679894;13703.725925481496;13709.177449353047;13731.038827282095;13734.107283026597;12819.551315703951;12870.356482175901;12885.677858053554;12888.033397495179;12893.806592901114;678.8879834827272;809.4050872608643;819.5574389829485;820.3314298846451;820.3970081989733;672.1900110366996;803.895493585836;811.7808191788214;813.9715109971153;814.979625509364;845.7420486751538;851.9318454523655;854.9871751923695;855.4354126276659;857.5197889182078;697.7662483068203;705.4955706669705;848.3594885861166;850.3664769746516;851.2253848997414;634.926983396906;635.1837888313541;636.9554131210817;639.1946147853691;639.9888176680834;12464;12567.120301578892;12619.558315458915;12637.43131559073;12699.746005079938;11611.187216894821;12416.503339866395;12758.553450629184;12804.80792788109;13389.598312050653;10437.843432348522;10507.527161277761;10551.73620659482;10673.733156671067;10678.839817402744;3578;3619.438986957026;3627.8730244441317;3640.7087433005295;3753.474513568103;46549.06901861944;46620.3006954896;46626.76686616579;46718;46833.765831170625;10022.74943126413;10145.9492702536;10191.133753630877;10275.383476991405;10511.054005139575;18675.906620466812;18729;18730.34443794461;18744.25022999065;18749;7617.428692848059;7661.846763064707;7896.802579935547;7926.128125906146;8183;4163.604457576525;4244.342126970325;4247.723897946624;4256.36154576816;4314.71954322968;3074.308280636839;3111.2999575095423;3118.6725393833776;3119.4696901526795;3124.765642576816;536.7933345661949;560.2212924035593;560.4927540575785;571.0777094991558;582.0222026994605;577.8699792546728;600.9248843894513;623.2697306619876;705.4814711187273;706.2584286499156;8880.289576833968;8891.73324800257;9004.36969412135;9007.909920900838;9031.412958157698;526.5234962359071;608.0119805316361;636.59576169132;656.8686262747469;679.58205703492;4090.754554726726;4201.474815648044;4455.465344158722;4461.353103799931;4476.149531588988;56401.71799140978;57188;57249.71375143098;57284.71357643185;57340.426595734345;51282;51675;52136;52213.21680174801;52569.47430525646;47081.76459117683;47323.5267647326;47707.761461193164;48232.76508523749;48600.7569962155;8305.626246818787;8395.790105247417;8477.830443390974;8525.44584601999;8601.95699021526;34063;34351.65648343485;34443.82778086194;34862.47706284357;35817;43430;43924.341134882365;44033.11933761371;44612.55387446214;44781;11509.53961841517;11599.246049006788;11652.30086194831;11855.229410088661;11872.584459543874;12344.4474924561;12490.06324525646;12501.374931253582;12689.682757931125;13120.868791311965;11686.357250351311;11962.222455540363;12160.878391216329;12218.816717749063;12516.499340026297;10889.455527223765;11218.943905280748;11442.599509017144;11483.196176267582;11724.120690948042;11138.3873886937;11485.368304743319;11611.477483513094;11780;11853.407329633312;9808.950955245464;10003.849942250727;10072.344180805596;10108.545115469675;10521.158307335549;9048.638054477748;9392.577334019848;9497.76255593588;10016.64941727036;10093.19254459656 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,851 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373666732__endTimestamp 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:01:06 INFO - 2015-11-24 06:01:06,742 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,743 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5488.38 Median:5692.86 stddev:615.09 (10.8%) stddev-sans-first:590.14 06:01:06 INFO - 2015-11-24 06:01:06,743 DEBUG : BROWSER_OUTPUT: Values: 3197.2 3245.3 3286.3 3288.5 3323.1 5341.8 5441.2 5457.0 5510.8 5533.2 5348.5 5388.8 5438.6 5447.9 5451.1 4944.9 4981.5 5046.7 5070.8 5134.4 4911.7 5117.6 5130.3 5131.2 5200.1 4900.6 4968.5 4976.6 4980.9 5003.0 5027.8 5029.7 5033.2 5041.1 5080.0 4857.6 4981.3 4985.1 4993.2 5059.2 5240.4 5286.4 5324.6 5343.6 5369.9 5995.3 5997.3 5998.0 5999.7 6002.8 5814.5 5945.5 5990.0 6007.7 6015.5 5418.0 5511.9 5512.4 5534.8 5537.3 6059.9 6105.8 6111.4 6122.2 6134.6 5856.4 5896.3 5906.4 5907.8 5908.6 5815.4 5873.2 5936.9 5968.8 6051.4 5862.9 5867.4 5870.2 5877.0 5879.6 5806.7 5875.7 5901.0 5902.4 5923.1 4508.5 4541.6 4555.6 4557.1 4559.8 3990.1 4059.7 4082.5 4097.1 4107.0 5583.9 5585.6 5591.9 5596.1 5621.1 5864.2 5895.4 5898.4 5906.0 5911.5 5494.4 5544.2 5563.4 5625.7 5627.9 5125.3 5137.8 5147.3 5152.4 5158.2 6059.8 6073.3 6079.5 6087.1 6089.8 5791.4 5795.9 5868.6 5899.4 5915.3 6073.6 6101.0 6125.3 6126.5 6131.5 5802.1 5802.8 5806.1 5818.7 5867.6 5813.3 5871.3 5877.7 5892.4 5950.9 5731.9 5829.2 5836.3 5839.6 5897.7 5818.1 5839.2 5847.6 5856.5 5861.2 5630.4 5669.5 5711.3 5734.2 5763.2 5692.9 5787.4 5830.9 5832.9 5835.2 5631.5 5681.1 5682.8 5688.3 5690.1 06:01:06 INFO - 2015-11-24 06:01:06,743 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,743 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46716.08 Median:17901.81 stddev:78055.46 (436.0%) stddev-sans-first:78197.59 06:01:06 INFO - 2015-11-24 06:01:06,743 DEBUG : BROWSER_OUTPUT: Values: 589.4 591.0 598.4 600.2 600.6 32080.5 32799.5 32938.5 32940.3 33011.5 40770.0 41335.6 41402.8 41447.6 41503.8 8826.5 8957.5 8963.5 8972.0 8973.7 7811.9 7990.7 8004.7 8812.2 10352.3 10307.1 10384.7 10401.4 10417.3 10418.9 10257.4 10285.2 10351.1 10357.2 10369.9 7777.5 7988.7 10689.7 10906.6 10960.9 40160.2 40591.9 40672.6 40779.6 40811.8 3150.0 3264.1 3277.4 3290.7 3671.7 31165.8 31467.8 31648.0 31750.7 32539.5 3895.8 3943.9 3999.8 4010.6 4058.4 273751.0 274412.6 274712.0 275482.0 275518.0 56140.7 58041.0 58669.7 58930.7 59143.4 67070.7 68138.3 68390.7 68535.0 68565.0 14498.5 14578.9 14613.8 14686.8 14711.4 11997.0 12048.6 12060.2 12065.2 12073.4 19230.0 19484.7 19587.3 19627.9 19690.0 7191.5 7332.7 7378.9 7383.3 7464.5 837.5 919.4 1134.5 1134.8 1154.4 28806.1 31484.0 31830.0 32130.6 32234.0 1016.9 1029.2 1036.2 1079.5 1183.1 14511.4 14620.3 14663.5 14756.2 14808.9 315162.0 316365.0 318466.0 318710.0 319863.0 51160.0 51416.7 51473.0 51524.7 51535.2 1309.8 1368.0 1374.9 1381.8 1383.2 27076.2 27741.6 27871.9 28195.3 28337.3 41976.6 44990.8 45249.5 45374.0 45486.0 208948.0 313931.0 320679.0 322948.0 323089.0 28274.9 28934.4 28969.4 28982.0 28991.3 38443.2 39494.6 39611.8 39846.4 39887.6 34765.0 36137.5 38220.0 38670.6 40377.8 36197.6 36277.6 36464.0 36769.0 36891.8 35346.6 35710.3 36410.5 36431.6 36490.5 31162.2 31656.2 33526.0 33587.8 33700.2 24366.5 24713.9 24758.0 24822.0 25142.2 06:01:06 INFO - 2015-11-24 06:01:06,744 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,744 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28122.99 Median:2165.91 stddev:85469.40 (3946.1%) stddev-sans-first:85683.73 06:01:06 INFO - 2015-11-24 06:01:06,744 DEBUG : BROWSER_OUTPUT: Values: 350.9 351.0 354.0 355.1 357.1 14067.1 14374.3 16264.7 16441.7 17130.0 16547.8 16585.9 16628.7 16951.6 16970.4 5258.3 5389.7 5392.0 5394.7 5397.4 3974.7 4095.6 5326.3 5709.5 5850.2 5752.7 5766.9 5775.1 5848.9 5851.9 5581.3 5766.8 5767.8 5768.2 5771.6 5072.5 5093.6 5095.8 5099.5 5107.9 19804.2 19887.9 20218.6 20998.7 21040.3 2131.6 2173.9 2183.9 2512.0 2614.6 12765.6 13171.5 13265.7 13513.7 13557.7 1812.5 1825.3 1827.7 1881.7 1892.0 56389.0 56912.9 57116.7 57220.0 58410.0 9432.6 9706.3 9838.3 9844.2 9895.6 13099.3 13133.9 13135.5 13156.6 13173.5 7324.1 7480.6 7627.6 7637.2 7670.5 7268.0 7282.9 7290.6 7306.7 7342.7 4269.1 4281.9 4298.1 4309.4 4341.3 1685.8 1729.6 1740.6 1778.8 1786.9 864.6 867.7 869.6 895.4 974.3 15273.8 15925.3 16190.9 16959.4 18069.5 892.5 906.2 906.4 939.2 1002.9 7904.8 8776.7 9206.9 9319.2 9803.7 516894.0 520689.0 521599.0 524689.0 532139.0 77446.0 78898.0 79105.2 79823.6 80442.0 1164.2 1168.9 1175.8 1176.2 1184.0 15430.4 15504.5 15533.6 15670.9 15873.9 33704.3 34023.8 34317.8 35149.5 35344.3 44557.6 45116.5 45696.3 45810.0 47981.5 9079.5 9166.0 9287.0 9295.7 9337.0 11434.1 11477.1 11503.6 12872.4 12965.7 11529.7 13462.3 14269.7 14537.1 14714.4 10347.4 13929.2 14317.9 14498.0 14916.8 14253.5 14498.9 14970.9 15110.4 15258.4 9392.4 9440.1 9510.8 9514.9 9696.3 13813.8 13887.0 14129.4 14196.5 15033.0 06:01:06 INFO - 2015-11-24 06:01:06,744 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,744 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5164.30 Median:3369.84 stddev:2634.81 (78.2%) stddev-sans-first:2628.23 06:01:06 INFO - 2015-11-24 06:01:06,745 DEBUG : BROWSER_OUTPUT: Values: 1553.1 1646.4 1672.5 1700.2 1702.3 6509.6 7195.5 7357.2 7365.3 7367.6 7268.0 7385.2 7389.1 7401.4 7407.7 1944.5 1967.3 1970.2 2211.4 2232.8 2218.5 2265.8 2267.1 2270.1 2277.7 2177.2 2185.8 2285.0 2286.5 2288.6 1930.2 1971.7 2166.1 2191.6 2205.5 2181.3 2192.4 2192.4 2202.6 2202.8 7426.4 7525.0 7528.3 7546.4 7551.9 4417.5 4499.9 4528.8 4534.1 4537.8 2944.0 2952.7 2992.6 2994.5 3087.6 979.5 989.1 1000.0 1007.7 1045.2 9778.2 9784.9 9795.2 9813.2 9892.5 4033.5 4119.3 4147.5 4154.1 4201.4 8618.6 8626.2 8641.0 8649.1 8651.5 4593.5 4597.5 4599.1 4601.1 4608.7 4217.2 4220.2 4220.6 4226.0 4228.2 3594.2 3621.6 3627.1 3640.3 3640.4 1192.6 1200.8 1203.7 1205.5 1213.9 1104.9 1130.8 1140.1 1148.1 1156.5 6670.9 6848.1 7079.9 7320.5 7331.9 573.0 585.3 591.1 608.3 613.1 5354.5 5362.1 5363.5 5379.2 5386.2 8251.7 8749.1 8775.7 8778.5 8783.0 8560.2 8625.6 8627.2 8647.9 8654.2 6772.9 6887.1 7015.7 7028.3 7030.5 6553.6 6562.0 6570.9 6571.1 6581.8 7594.1 7966.2 7972.3 7977.4 7986.3 7959.4 7973.6 8132.3 8137.6 8180.8 6486.3 6522.2 6522.3 6531.2 6576.0 7106.1 7145.7 7157.6 7174.4 7175.9 6551.6 6762.1 6787.5 6804.1 6846.0 6721.6 6734.6 6735.1 6796.7 6806.1 5754.4 5884.8 6726.6 6745.4 6791.0 6017.3 6126.5 6170.2 6174.0 6175.4 5961.8 5992.1 5993.8 6004.1 6004.7 06:01:06 INFO - 2015-11-24 06:01:06,745 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5282.49 Median:6100.89 stddev:1592.59 (26.1%) stddev-sans-first:1552.95 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: Values: 323.0 326.1 326.1 331.2 332.4 5904.6 5928.0 5960.6 5994.2 6051.5 5865.1 5872.4 5923.3 5923.3 5927.5 4559.1 4575.4 4582.2 4588.4 4594.4 4516.0 4546.3 4586.6 4586.6 4588.7 4520.1 4529.9 4531.7 4536.8 4544.0 4329.9 4508.5 4510.2 4524.6 4529.4 3880.3 3925.5 3965.0 3977.5 4013.1 5571.4 5587.0 5587.2 5596.2 5611.4 5040.6 5145.8 5168.3 5261.8 5301.0 6260.9 6273.8 6286.6 6286.8 6288.2 4424.7 4429.5 4432.5 4433.4 4433.9 6322.3 6418.6 6485.5 6507.6 6508.6 4417.1 4439.4 4440.4 4441.0 4443.1 4480.6 4481.9 4484.3 4484.6 4497.7 5215.2 5218.5 5227.3 5231.4 5232.4 6150.3 6321.9 6329.3 6337.8 6347.8 1612.8 1629.0 1630.9 1631.5 1631.5 1098.1 1116.1 1120.7 1137.5 1143.0 6177.8 6186.2 6187.7 6188.5 6188.5 6524.0 6533.5 6536.6 6538.6 6539.1 6032.7 6167.5 6168.1 6172.5 6183.4 3497.7 3530.2 3530.3 3532.7 3533.8 6763.4 6767.5 6773.6 6774.3 6784.9 6436.5 6656.6 6666.7 6670.6 6672.7 6348.9 6569.4 6735.5 6838.8 6849.3 6554.1 6566.9 6574.2 6578.9 6579.1 6452.2 6463.4 6490.4 6492.9 6501.2 6586.6 6800.8 6810.7 6821.0 6825.6 4357.2 4372.1 4395.2 4403.3 4403.5 6511.6 6513.3 6521.2 6529.6 6540.8 6284.4 6307.2 6371.9 6375.4 6382.2 6308.8 6312.1 6343.0 6357.7 6366.5 6247.0 6247.2 6259.2 6261.8 6263.3 6279.7 6358.8 6393.0 6395.3 6401.7 6247.2 6248.7 6250.4 6251.2 6253.7 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13883.31 Median:24244.29 stddev:15904.40 (65.6%) stddev-sans-first:15918.46 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: Values: 754.4 757.1 787.5 798.4 851.9 13404.1 13703.7 13709.2 13731.0 13734.1 12819.6 12870.4 12885.7 12888.0 12893.8 678.9 809.4 819.6 820.3 820.4 672.2 803.9 811.8 814.0 815.0 845.7 851.9 855.0 855.4 857.5 697.8 705.5 848.4 850.4 851.2 634.9 635.2 637.0 639.2 640.0 12464.0 12567.1 12619.6 12637.4 12699.7 11611.2 12416.5 12758.6 12804.8 13389.6 10437.8 10507.5 10551.7 10673.7 10678.8 3578.0 3619.4 3627.9 3640.7 3753.5 46549.1 46620.3 46626.8 46718.0 46833.8 10022.7 10145.9 10191.1 10275.4 10511.1 18675.9 18729.0 18730.3 18744.3 18749.0 7617.4 7661.8 7896.8 7926.1 8183.0 4163.6 4244.3 4247.7 4256.4 4314.7 3074.3 3111.3 3118.7 3119.5 3124.8 536.8 560.2 560.5 571.1 582.0 577.9 600.9 623.3 705.5 706.3 8880.3 8891.7 9004.4 9007.9 9031.4 526.5 608.0 636.6 656.9 679.6 4090.8 4201.5 4455.5 4461.4 4476.1 56401.7 57188.0 57249.7 57284.7 57340.4 51282.0 51675.0 52136.0 52213.2 52569.5 47081.8 47323.5 47707.8 48232.8 48600.8 8305.6 8395.8 8477.8 8525.4 8602.0 34063.0 34351.7 34443.8 34862.5 35817.0 43430.0 43924.3 44033.1 44612.6 44781.0 11509.5 11599.2 11652.3 11855.2 11872.6 12344.4 12490.1 12501.4 12689.7 13120.9 11686.4 11962.2 12160.9 12218.8 12516.5 10889.5 11218.9 11442.6 11483.2 11724.1 11138.4 11485.4 11611.5 11780.0 11853.4 9809.0 10003.8 10072.3 10108.5 10521.2 9048.6 9392.6 9497.8 10016.6 10093.2 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:01:06 INFO - 2015-11-24 06:01:06,746 DEBUG : BROWSER_OUTPUT: 06:01:07 INFO - 2015-11-24 06:01:07,409 INFO : Browser exited with error code: 0 06:01:07 INFO - 2015-11-24 06:01:07,430 INFO : Completed test dromaeo_css (00:18:34) 06:01:07 INFO - 2015-11-24 06:01:07,430 INFO : Starting test kraken 06:01:07 INFO - 2015-11-24 06:01:07,430 DEBUG : operating with platform_type : linux_ 06:01:07 INFO - 2015-11-24 06:01:07,431 INFO : Initialising browser for kraken test... 06:01:07 INFO - 2015-11-24 06:01:07,437 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2BH7So/profile http://localhost:34860/getInfo.html 06:01:10 INFO - 2015-11-24 06:01:10,856 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:01:10 INFO - 2015-11-24 06:01:10,856 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:01:10 INFO - 2015-11-24 06:01:10,856 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:01:10 INFO - 2015-11-24 06:01:10,856 DEBUG : BROWSER_OUTPUT: __metrics 06:01:11 INFO - 2015-11-24 06:01:11,013 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:12 INFO - 2015-11-24 06:01:12,207 INFO : Browser initialized. 06:01:12 INFO - 2015-11-24 06:01:12,208 INFO : Running cycle 1/1 for kraken test... 06:01:12 INFO - 2015-11-24 06:01:12,208 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2BH7So/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:01:23 INFO - 2015-11-24 06:01:23,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 143187968 06:01:23 INFO - 2015-11-24 06:01:23,995 DEBUG : BROWSER_OUTPUT: 06:01:26 INFO - 2015-11-24 06:01:26,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34860/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:27 INFO - 2015-11-24 06:01:27,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 180318208 06:01:27 INFO - 2015-11-24 06:01:27,072 DEBUG : BROWSER_OUTPUT: 06:01:29 INFO - 2015-11-24 06:01:29,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34860/tests/kraken/driver.html?testName=audio-dft) 06:01:30 INFO - 2015-11-24 06:01:30,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 168742912 06:01:30 INFO - 2015-11-24 06:01:30,253 DEBUG : BROWSER_OUTPUT: 06:01:33 INFO - 2015-11-24 06:01:33,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34860/tests/kraken/driver.html?testName=audio-fft) 06:01:33 INFO - 2015-11-24 06:01:33,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 152432640 06:01:33 INFO - 2015-11-24 06:01:33,717 DEBUG : BROWSER_OUTPUT: 06:01:35 INFO - 2015-11-24 06:01:35,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34860/tests/kraken/driver.html?testName=audio-oscillator) 06:01:36 INFO - 2015-11-24 06:01:36,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 155041792 06:01:36 INFO - 2015-11-24 06:01:36,220 DEBUG : BROWSER_OUTPUT: 06:01:38 INFO - 2015-11-24 06:01:38,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:38 INFO - 2015-11-24 06:01:38,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 155918336 06:01:38 INFO - 2015-11-24 06:01:38,975 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-24 06:01:41,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34860/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:42 INFO - 2015-11-24 06:01:42,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 156536832 06:01:42 INFO - 2015-11-24 06:01:42,422 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2015-11-24 06:01:45,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34860/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:46 INFO - 2015-11-24 06:01:46,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 156758016 06:01:46 INFO - 2015-11-24 06:01:46,377 DEBUG : BROWSER_OUTPUT: 06:01:49 INFO - 2015-11-24 06:01:49,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34860/tests/kraken/driver.html?testName=json-parse-financial) 06:01:49 INFO - 2015-11-24 06:01:49,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 157618176 06:01:49 INFO - 2015-11-24 06:01:49,683 DEBUG : BROWSER_OUTPUT: 06:01:51 INFO - 2015-11-24 06:01:51,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:51 INFO - 2015-11-24 06:01:51,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 167972864 06:01:52 INFO - 2015-11-24 06:01:51,823 DEBUG : BROWSER_OUTPUT: 06:01:53 INFO - 2015-11-24 06:01:53,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:54 INFO - 2015-11-24 06:01:54,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 166449152 06:01:54 INFO - 2015-11-24 06:01:54,213 DEBUG : BROWSER_OUTPUT: 06:01:56 INFO - 2015-11-24 06:01:56,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:56 INFO - 2015-11-24 06:01:56,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 173498368 06:01:56 INFO - 2015-11-24 06:01:56,847 DEBUG : BROWSER_OUTPUT: 06:01:59 INFO - 2015-11-24 06:01:59,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:59 INFO - 2015-11-24 06:01:59,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 180793344 06:01:59 INFO - 2015-11-24 06:01:59,850 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:03 INFO - 2015-11-24 06:02:03,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 179400704 06:02:03 INFO - 2015-11-24 06:02:03,022 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34860/tests/kraken/driver.html?testName=ai-astar) 06:02:04 INFO - 2015-11-24 06:02:04,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 239104000 06:02:04 INFO - 2015-11-24 06:02:04,946 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;107;111;112;111;100;110;112;106 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;122;148;169;123;155;154;123;161;125 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;160;160;159;158;162;161;163 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;86;92;72;71;71;92;91;71 06:02:04 INFO - 2015-11-24 06:02:04,949 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;137;93;94;93;141;92;93;133 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;110;109;109;109 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;145;146;145;145;145;146 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;97;96;96;95;96;96 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;57;57;57;58;69;58;56;56 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;70;70;69;70;69 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;84;85;84;84;93;84;83;84;85 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;130;124;119;117;133;117;119;120;128 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;155;151;155;157;147;164;148;154;139 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;66;66;67;67;67;67;66;66 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373724947__endTimestamp 06:02:04 INFO - 2015-11-24 06:02:04,950 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.80 (3.4%) stddev-sans-first:4.03 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 107.0 111.0 112.0 111.0 100.0 110.0 112.0 106.0 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.70 Median:154.50 stddev:18.40 (11.9%) stddev-sans-first:18.87 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: Values: 157.0 122.0 148.0 169.0 123.0 155.0 154.0 123.0 161.0 125.0 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 160.0 160.0 159.0 158.0 162.0 161.0 163.0 06:02:04 INFO - 2015-11-24 06:02:04,952 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:79.00 stddev:9.83 (12.4%) stddev-sans-first:10.10 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 86.0 92.0 72.0 71.0 71.0 92.0 91.0 71.0 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:21.34 (22.9%) stddev-sans-first:22.10 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 137.0 93.0 94.0 93.0 141.0 92.0 93.0 133.0 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:02:04 INFO - 2015-11-24 06:02:04,953 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:3.85 (6.8%) stddev-sans-first:4.06 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 57.0 57.0 57.0 58.0 69.0 58.0 56.0 56.0 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 70.0 70.0 69.0 70.0 69.0 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,954 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:3.40 (4.0%) stddev-sans-first:3.02 06:02:04 INFO - 2015-11-24 06:02:04,955 DEBUG : BROWSER_OUTPUT: Values: 91.0 84.0 85.0 84.0 84.0 93.0 84.0 83.0 84.0 85.0 06:02:04 INFO - 2015-11-24 06:02:04,955 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,955 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.00 stddev:5.67 (4.6%) stddev-sans-first:6.00 06:02:04 INFO - 2015-11-24 06:02:04,955 DEBUG : BROWSER_OUTPUT: Values: 122.0 130.0 124.0 119.0 117.0 133.0 117.0 119.0 120.0 128.0 06:02:04 INFO - 2015-11-24 06:02:04,955 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,956 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:154.50 stddev:6.81 (4.4%) stddev-sans-first:7.08 06:02:04 INFO - 2015-11-24 06:02:04,956 DEBUG : BROWSER_OUTPUT: Values: 148.0 155.0 151.0 155.0 157.0 147.0 164.0 148.0 154.0 139.0 06:02:04 INFO - 2015-11-24 06:02:04,957 DEBUG : BROWSER_OUTPUT: 06:02:04 INFO - 2015-11-24 06:02:04,957 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:02:04 INFO - 2015-11-24 06:02:04,957 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 66.0 06:02:04 INFO - 2015-11-24 06:02:04,957 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:02:04 INFO - 2015-11-24 06:02:04,957 DEBUG : BROWSER_OUTPUT: 06:02:05 INFO - 2015-11-24 06:02:05,793 INFO : Browser exited with error code: 0 06:02:05 INFO - 2015-11-24 06:02:05,839 INFO : Completed test kraken (00:00:58) 06:02:05 INFO - 2015-11-24 06:02:05,839 INFO : Starting test v8_7 06:02:05 INFO - 2015-11-24 06:02:05,839 DEBUG : operating with platform_type : linux_ 06:02:05 INFO - 2015-11-24 06:02:05,839 INFO : Initialising browser for v8_7 test... 06:02:05 INFO - 2015-11-24 06:02:05,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpweC3kR/profile http://localhost:34860/getInfo.html 06:02:09 INFO - 2015-11-24 06:02:09,177 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:02:09 INFO - 2015-11-24 06:02:09,178 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:02:09 INFO - 2015-11-24 06:02:09,178 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:02:09 INFO - 2015-11-24 06:02:09,178 DEBUG : BROWSER_OUTPUT: __metrics 06:02:09 INFO - 2015-11-24 06:02:09,294 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:10 INFO - 2015-11-24 06:02:10,516 INFO : Browser initialized. 06:02:10 INFO - 2015-11-24 06:02:10,516 INFO : Running cycle 1/1 for v8_7 test... 06:02:10 INFO - 2015-11-24 06:02:10,516 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpweC3kR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:02:22 INFO - 2015-11-24 06:02:22,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 139886592 06:02:22 INFO - 2015-11-24 06:02:22,333 DEBUG : BROWSER_OUTPUT: 06:02:43 INFO - 2015-11-24 06:02:43,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34860/tests/v8_7/run.html (next: http://localhost:34860/tests/v8_7/run.html) 06:02:44 INFO - 2015-11-24 06:02:44,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 608157696 06:02:44 INFO - 2015-11-24 06:02:44,040 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,041 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:02:44 INFO - 2015-11-24 06:02:44,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:02:44 INFO - 2015-11-24 06:02:44,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:02:44 INFO - 2015-11-24 06:02:44,041 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |0;Richards;189.17896329928112 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.4012441679627 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.7684449489217 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4975.124378109453 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1943.6893203883494 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |7;RegExp;25219.51219512195 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |8;Splay;640.7147415443523 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373764040__endTimestamp 06:02:44 INFO - 2015-11-24 06:02:44,042 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.18 Median:189.18 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: Values: 189.2 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.40 Median:194.40 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: Values: 194.4 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.77 Median:283.77 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: Values: 283.8 06:02:44 INFO - 2015-11-24 06:02:44,043 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4975.12 Median:4975.12 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: Values: 4975.1 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1943.69 Median:1943.69 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: Values: 1943.7 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: Values: 796.8 06:02:44 INFO - 2015-11-24 06:02:44,045 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: Values: 12096.4 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25219.51 Median:25219.51 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: Values: 25219.5 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,046 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:640.71 Median:640.71 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,047 DEBUG : BROWSER_OUTPUT: Values: 640.7 06:02:44 INFO - 2015-11-24 06:02:44,047 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,047 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:02:44 INFO - 2015-11-24 06:02:44,047 DEBUG : BROWSER_OUTPUT: Values: 4845.4 06:02:44 INFO - 2015-11-24 06:02:44,047 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:02:44 INFO - 2015-11-24 06:02:44,047 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2015-11-24 06:02:44,933 INFO : Browser exited with error code: 0 06:02:44 INFO - 2015-11-24 06:02:44,948 INFO : Completed test v8_7 (00:00:39) 06:02:45 INFO - 2015-11-24 06:02:45,007 INFO : Completed test suite (00:20:12) 06:02:45 INFO - 2015-11-24 06:02:45,007 DEBUG : Working with test: dromaeo_css 06:02:45 INFO - 2015-11-24 06:02:45,007 DEBUG : Generating results file: dromaeo_css 06:02:45 INFO - 2015-11-24 06:02:45,008 DEBUG : Working with test: kraken 06:02:45 INFO - 2015-11-24 06:02:45,008 DEBUG : Generating results file: kraken 06:02:45 INFO - 2015-11-24 06:02:45,008 INFO : javascript benchmark 06:02:45 INFO - 2015-11-24 06:02:45,009 DEBUG : Working with test: v8_7 06:02:45 INFO - 2015-11-24 06:02:45,009 DEBUG : Generating results file: v8_7 06:02:45 INFO - 2015-11-24 06:02:45,009 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:02:45 INFO - 2015-11-24 06:02:45,058 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:02:45 INFO - 2015-11-24 06:02:45,058 DEBUG : process_Request line: dromaeo_css 6965.92 graph.html#tests=[[72,1,35]] 06:02:45 INFO - 2015-11-24 06:02:45,058 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:02:45 INFO - 2015-11-24 06:02:45,089 DEBUG : process_Request line: kraken 1503.60 graph.html#tests=[[232,1,35]] 06:02:45 INFO - 2015-11-24 06:02:45,089 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:02:45 INFO - 2015-11-24 06:02:45,122 DEBUG : process_Request line: v8_7 19550.98 graph.html#tests=[[230,1,35]] 06:02:45 INFO - 2015-11-24 06:02:45,124 INFO : javascript benchmark 06:02:45 INFO - 2015-11-24 06:02:45,127 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3197.2326641606014, 3245.318483118545, 3286.2605913669413, 3288.4738441849295, 3323.08615130839, 5341.813036543722, 5441.238226648267, 5457.045017121997, 5510.752016159272, 5533.225348451215, 5348.518633323, 5388.811391601294, 5438.619296649236, 5447.863803404917, 5451.127819548873, 4944.851654450364, 4981.452040275585, 5046.7224302663335, 5070.847874563769, 5134.4095429025765, 4911.68074075184, 5117.590592752571, 5130.333056702623, 5131.230315452674, 5200.063988482072, 4900.583450406738, 4968.527989840959, 4976.576990955773, 4980.850574482772, 5002.974985125051, 5027.84916452507, 5029.723365214912, 5033.194688849767, 5041.143005689041, 5080.0, 4857.562819346241, 4981.27771473138, 4985.052839960432, 4993.176125939216, 5059.241113832918, 5240.4497527759795, 5286.365636123652, 5324.600654950894, 5343.572514198855, 5369.892602147936, 5995.250593675791, 5997.280326360821, 5998.0, 5999.73001214942, 6002.789902353396, 5814.5057670098095, 5945.524358051345, 5990.041593345088, 6007.669578173199, 6015.458608725192, 5418.0, 5511.889762204773, 5512.421195774426, 5534.833954981357, 5537.335519737658, 6059.878802423927, 6105.755769769248, 6111.388861113853, 6122.245686735527, 6134.631922084689, 5856.355800861902, 5896.3219229788265, 5906.350301466835, 5907.793227237026, 5908.645481271137, 5815.447532484407, 5873.236479257755, 5936.8812623748145, 5968.791092311835, 6051.394860513913, 5862.941370586324, 5867.3839246879315, 5870.207521984477, 5876.970615146983, 5879.617824841372, 5806.680632565165, 5875.706214689249, 5901.02633065548, 5902.3507414184405, 5923.08192230205, 4508.481524624644, 4541.568550987651, 4555.612772914339, 4557.111363284194, 4559.794809233593, 3990.1221731219084, 4059.715819892638, 4082.4896887889013, 4097.057676734368, 4107.034846810997, 5583.916241256385, 5585.553155747531, 5591.944080559224, 5596.104623260258, 5621.072523033736, 5864.2083318752275, 5895.35151133375, 5898.380670029585, 5906.0255057914965, 5911.497522710618, 5494.36814766307, 5544.22380866679, 5563.36021357541, 5625.6905870176715, 5627.915581266284, 5125.282460455539, 5137.768800403991, 5147.279380886679, 5152.433232344439, 5158.226266060121, 6059.787907423307, 6073.301570319381, 6079.513638908788, 6087.147799308101, 6089.756409743649, 5791.449812267828, 5795.94204057954, 5868.559858010752, 5899.439553242435, 5915.290165180206, 6073.589209560717, 6100.951132821025, 6125.307137552789, 6126.468382904274, 6131.491756816045, 5802.071668533014, 5802.767889284381, 5806.071028635567, 5818.650880947157, 5867.647941123546, 5813.302403711582, 5871.295444546682, 5877.682275641614, 5892.410758924073, 5950.910736338872, 5731.914021289601, 5829.15477255804, 5836.328822185503, 5839.5912286141265, 5897.734601943009, 5818.069108942549, 5839.211706419749, 5847.649141051551, 5856.531477481876, 5861.179434879035, 5630.408807075362, 5669.489745922887, 5711.314642242957, 5734.22587950638, 5763.193152958505, 5692.857678558069, 5787.39232380594, 5830.912536312044, 5832.854178645568, 5835.153902684172, 5631.465010823965, 5681.147827825859, 5682.77268909239, 5688.260526131577, 5690.118031705092], "unit": "ms", "name": "dojo.html", "value": 5447.885650134907}, {"lowerIsBetter": false, "replicates": [589.4105894105894, 590.9556783241256, 598.3537779198466, 600.1867469578724, 600.6216083867163, 32080.518792218107, 32799.508007379845, 32938.50592241118, 32940.34119317612, 33011.504827427605, 40770.0, 41335.586644133626, 41402.7929860351, 41447.58552414475, 41503.79248103763, 8826.514541700204, 8957.462552246854, 8963.507007114606, 8972.0, 8973.730788076367, 7811.882821757678, 7990.720324788634, 8004.719834805783, 8812.206901378875, 10352.327098738595, 10307.12389446898, 10384.688459346231, 10401.375917444977, 10417.27079104463, 10418.9479052605, 10257.410101434252, 10285.177185825116, 10351.120154786851, 10357.171426285917, 10369.948150259239, 7777.494462859952, 7988.680452781882, 10689.732756681067, 10906.61826836065, 10960.890391096147, 40160.196796063916, 40591.94080591947, 40672.59327406718, 40779.59220407817, 40811.7959410204, 3150.0, 3264.1023718477372, 3277.4264503711993, 3290.68738469845, 3671.687906527948, 31165.844170779226, 31467.84266078655, 31648.0, 31750.682493175234, 32539.51190732141, 3895.7662540247675, 3943.921121577552, 3999.7800120993334, 4010.639042486161, 4058.431819545266, 273751.0, 274412.627936861, 274712.0, 275482.0, 275518.0, 56140.71929640326, 58041.0, 58669.70665146647, 58930.70534647385, 59143.40856591465, 67070.66464667645, 68138.31861681418, 68390.65804670945, 68535.0, 68565.0, 14498.492552760603, 14578.927105364406, 14613.780793287897, 14686.779698304534, 14711.411543538139, 11997.040236781037, 12048.578299759467, 12060.155789094679, 12065.215760975509, 12073.396330183632, 19230.00039979231, 19484.68924807308, 19587.314443994394, 19627.901860490892, 19690.0, 7191.532550384209, 7332.706691732377, 7378.852422951511, 7383.2985866342615, 7464.477486575996, 837.5267973594899, 919.4437365393974, 1134.5235001299475, 1134.7560274541013, 1154.440096553171, 28806.135815925136, 31484.0, 31830.0, 32130.61321832793, 32234.0, 1016.903394177552, 1029.161233594618, 1036.2435422141878, 1079.4926384599225, 1183.0890214534932, 14511.419543218364, 14620.342084606218, 14663.453141918828, 14756.188409637572, 14808.925955370154, 315162.0, 316365.0, 318466.0, 318710.0, 319863.0, 51160.0, 51416.74291628518, 51473.0, 51524.742376287875, 51535.22697159545, 1309.796981467874, 1368.0, 1374.9450021999007, 1381.8203633527778, 1383.2046573220439, 27076.1877143686, 27741.583876241468, 27871.86064069748, 28195.295117622223, 28337.29156771097, 41976.58023419727, 44990.77504612456, 45249.54750452453, 45374.0, 45486.0, 208948.0, 313931.0, 320679.0, 322948.0, 323089.0, 28274.85862570674, 28934.42131157323, 28969.420611588073, 28982.0, 28991.275218119717, 38443.2311353777, 39494.60505394909, 39611.80194099011, 39846.40230396488, 39887.60112398955, 34765.0, 36137.45793813042, 38220.0, 38670.6132938667, 40377.79811100926, 36197.63802361942, 36277.63722362848, 36464.0, 36769.0, 36891.81554092212, 35346.64653353434, 35710.285794284486, 36410.4538431929, 36431.635683643886, 36490.45264320984, 31162.22094447657, 31656.208594785316, 33526.0, 33587.83206083954, 33700.15749606279, 24366.51266974686, 24713.876430617733, 24758.0, 24822.0, 25142.24573262805], "unit": "ms", "name": "ext.html", "value": 18673.381610099055}, {"lowerIsBetter": false, "replicates": [350.9227969846633, 350.95262139611145, 353.9840707168179, 355.13170298619866, 357.13929430073495, 14067.08563943343, 14374.281285935715, 16264.674706505863, 16441.671166576678, 17129.999999999985, 16547.751783723255, 16585.91707041463, 16628.66742665146, 16951.57621059474, 16970.40603578875, 5258.316418865542, 5389.703566303851, 5391.973040134794, 5394.703291318976, 5397.379301380332, 3974.6820254379727, 4095.6313931746135, 5326.280952071459, 5709.514691251248, 5850.151727999438, 5752.683602401888, 5766.855828604297, 5775.104858746901, 5848.853778655546, 5851.8537036574, 5581.302337207849, 5766.826995190151, 5767.798127065554, 5768.221290125821, 5771.624844385102, 5072.467390923974, 5093.567046801027, 5095.79616815327, 5099.464556221617, 5107.87230319245, 19804.207831686716, 19887.900560497248, 20218.595628087503, 20998.685019724715, 21040.263590774248, 2131.5630295789324, 2173.9347819565437, 2183.879886606236, 2511.974880251192, 2614.5947378156416, 12765.553205637758, 13171.473141074346, 13265.734685306335, 13513.662158446117, 13557.728845423135, 1812.5287425269526, 1825.2727020766895, 1827.6943848780895, 1881.698928171486, 1891.9621607567772, 56389.0, 56912.86174276533, 57116.71441642807, 57220.0, 58410.0, 9432.575534100983, 9706.272029597809, 9838.26213034011, 9844.163246124017, 9895.604175832887, 13099.279539625411, 13133.934330328479, 13135.474581016651, 13156.60530184096, 13173.47306107745, 7324.121105467378, 7480.588567628833, 7627.580483073484, 7637.236276372319, 7670.539767613961, 7268.0, 7282.890756638654, 7290.614783191177, 7306.671199796022, 7342.743003994835, 4269.060806622538, 4281.850135245314, 4298.140371925628, 4309.41822853917, 4341.305391137403, 1685.8482736553524, 1729.5935455168026, 1740.5648587853036, 1778.8221177882367, 1786.8927864327923, 864.6368525219423, 867.6789587852535, 869.6043300298476, 895.4358753984948, 974.2790335151936, 15273.847261527242, 15925.283362248727, 16190.919045404933, 16959.406420775213, 18069.548261293574, 892.4689809563299, 906.1889608800087, 906.428949761646, 939.2063706168277, 1002.8796544414571, 7904.802379940433, 8776.736697899074, 9206.861897071549, 9319.207867331354, 9803.656872009446, 516894.0, 520689.0, 521599.0, 524689.0, 532139.0, 77446.0, 78898.0, 79105.20894791094, 79823.60088199521, 80442.0, 1164.2490593567102, 1168.8714241433436, 1175.835383046374, 1176.200183874956, 1183.9940800295772, 15430.382784688936, 15504.457343992906, 15533.611659708145, 15670.9216453917, 15873.920630396775, 33704.325913482084, 34023.82988085044, 34317.82841085779, 35149.47275790814, 35344.29311413809, 44557.55442445534, 45116.54883451123, 45696.31455528236, 45810.0, 47981.52018479771, 9079.455232685796, 9166.037566055735, 9287.0, 9295.72112836616, 9337.019612940543, 11434.085273178292, 11477.08183345347, 11503.597374092202, 12872.35638218104, 12965.67880081503, 11529.711757206136, 13462.259575723428, 14269.71460570762, 14537.055091419024, 14714.411423542939, 10347.379157250589, 13929.23389213603, 14317.928410357881, 14498.0, 14916.776248356065, 14253.50112746049, 14498.85501144975, 14970.925145374204, 15110.39558417651, 15258.389664413298, 9392.389494682824, 9440.055994400505, 9510.762230944281, 9514.857277140987, 9696.272779541421, 13813.792793108312, 13887.0, 14129.364178611782, 14196.503122390666, 15033.0], "unit": "ms", "name": "jquery.html", "value": 8776.763833931911}, {"lowerIsBetter": false, "replicates": [1553.0526378908871, 1646.4155224895162, 1672.4731709511502, 1700.1669182100766, 1702.2850402830813, 6509.609423434591, 7195.496315257928, 7357.190709022017, 7365.33711965923, 7367.594782286972, 7268.0, 7385.187629360766, 7389.113306403226, 7401.370883474911, 7407.666655000525, 1944.513871532117, 1967.3409407848387, 1970.1725275384374, 2211.413975296544, 2232.7767223277624, 2218.4786575154826, 2265.818734501236, 2267.1498188179435, 2270.0579259607325, 2277.7380601230907, 2177.2162021672184, 2185.8142057925097, 2284.9543009139807, 2286.4969706664506, 2288.6452599846966, 1930.237556165314, 1971.684530475117, 2166.1118941234176, 2191.5726433345503, 2205.4817117977263, 2181.334692918659, 2192.3642143778284, 2192.440927563461, 2202.6365649667787, 2202.8458007939453, 7426.368758655521, 7525.0, 7528.322450979384, 7546.396288296923, 7551.924480755232, 4417.4919884213405, 4499.865004049851, 4528.796204170821, 4534.1158474097565, 4537.841175558872, 2943.9558406623705, 2952.7490163336142, 2992.62592175978, 2994.5358469437274, 3087.6140482439696, 979.5249304087512, 989.1295659819385, 1000.024975648744, 1007.7128018514761, 1045.2265323660436, 9778.217742580577, 9784.90215097847, 9795.167410770022, 9813.165880900133, 9892.505374731234, 4033.5361433435532, 4119.279126152971, 4147.543770185277, 4154.1068670236045, 4201.432806571135, 8618.612162452704, 8626.18051285127, 8640.956795215983, 8649.1350864913, 8651.48091114535, 4593.540645935446, 4597.4712908015335, 4599.08018396322, 4601.079784043205, 4608.663487588562, 4217.219814334358, 4220.240356735756, 4220.599043090901, 4226.049138943713, 4228.238916994909, 3594.1913069559664, 3621.5654121505586, 3627.093226693327, 3640.2537479816574, 3640.3629364861044, 1192.6004788395985, 1200.783858905388, 1203.6629743671785, 1205.4997176171967, 1213.872543382932, 1104.939228342433, 1130.813415786386, 1140.0936255676756, 1148.0872706198593, 1156.4738044189874, 6670.899936500957, 6848.1097457331225, 7079.858402831915, 7320.487565870444, 7331.926680733124, 572.9512991395778, 585.2625691628493, 591.1221835574169, 608.3004544773546, 613.1446631948496, 5354.518093371537, 5362.088444964287, 5363.490468405495, 5379.193121031798, 5386.245925570423, 8251.669933202606, 8749.08134645853, 8775.736727898173, 8778.517181555077, 8782.956085219661, 8560.1867822558, 8625.568721563897, 8627.180417860292, 8647.87577614906, 8654.22112009922, 6772.8984065239065, 6887.139107611549, 7015.684294206773, 7028.297170282931, 7030.543014704028, 6553.639549824615, 6562.0, 6570.901436478553, 6571.112899758471, 6581.80254592363, 7594.050743657043, 7966.16355282687, 7972.322352600094, 7977.361811055218, 7986.321162701003, 7959.363250940027, 7973.601319934096, 8132.308753755997, 8137.593120344078, 8180.7954801130445, 6486.286508483969, 6522.15212022434, 6522.315156908457, 6531.183602049744, 6575.967120164369, 7106.076210092655, 7145.714171433085, 7157.57054576727, 7174.390176835028, 7175.928240717526, 6551.574147680385, 6762.087118238975, 6787.524873258824, 6804.149481314836, 6845.965770171118, 6721.563098398588, 6734.595924244365, 6735.124433823572, 6796.694148763218, 6806.115205023315, 5754.395788442153, 5884.764609415746, 6726.630035347907, 6745.4266387355665, 6790.966045169743, 6017.308009578955, 6126.540509461897, 6170.167027451416, 6174.043023331391, 6175.413335733098, 5961.761529538943, 5992.13114098462, 5993.820185394445, 6004.1294012368835, 6004.729787159501], "unit": "ms", "name": "mootools.html", "value": 4229.939993772871}, {"lowerIsBetter": false, "replicates": [322.95478632991376, 326.0641957581741, 326.1276086468696, 331.1505987142978, 332.43486073674757, 5904.645721256722, 5927.970360148199, 5960.64236145831, 5994.160817485545, 6051.455369016788, 5865.090910908805, 5872.442117998783, 5923.259592550931, 5923.3188183358925, 5927.496162826165, 4559.133764584718, 4575.428071491072, 4582.152301824157, 4588.380568623244, 4594.425696787902, 4515.967814483479, 4546.318052292166, 4586.564276393738, 4586.610138138246, 4588.7246765194195, 4520.141173177102, 4529.886752831189, 4531.6601254905845, 4536.841210557631, 4543.954560454403, 4329.935050974206, 4508.549145085465, 4510.188166130095, 4524.615407690334, 4529.388532548097, 3880.301545721769, 3925.489686340786, 3964.980175099135, 3977.5226972763166, 4013.137175507251, 5571.4428557144365, 5587.0, 5587.189857470685, 5596.2165296858475, 5611.438856114397, 5040.571551418134, 5145.794168233266, 5168.2764412982215, 5261.789528418897, 5301.045811753883, 6260.937390626081, 6273.843153921189, 6286.622802631857, 6286.779962701329, 6288.151099601587, 4424.690271680984, 4429.512753597101, 4432.53458386868, 4433.445819272591, 4433.933490997638, 6322.272938612026, 6418.614883106982, 6485.513586481033, 6507.6420796856155, 6508.64202468864, 4417.094495628388, 4439.356293337512, 4440.4005459263235, 4440.977795111004, 4443.133588950123, 4480.574345437179, 4481.932771008437, 4484.34079390621, 4484.618807401343, 4497.662675299365, 5215.191645294985, 5218.478152184751, 5227.320448341691, 5231.372235331784, 5232.372115346183, 6150.323464418911, 6321.905171422432, 6329.303776584572, 6337.795818794414, 6347.777827776005, 1612.7500237463212, 1628.9674206515804, 1630.9021458712516, 1631.4697723239995, 1631.5350125214256, 1098.1050443888205, 1116.146148196614, 1120.6999880138999, 1137.5165554639411, 1143.0284258380311, 6177.783777567854, 6186.19579454677, 6187.690615469299, 6188.504919606421, 6188.535859810442, 6524.0, 6533.509986751013, 6536.575122617015, 6538.640374779433, 6539.08452816606, 6032.668203248776, 6167.537434692416, 6168.1056246843955, 6172.537059720539, 6183.3816618337805, 3497.6883668624264, 3530.2409981854025, 3530.329237444929, 3532.682058614737, 3533.840977156034, 6763.425108865703, 6767.492438067165, 6773.559718618274, 6774.288699686462, 6784.93215067843, 6436.452901503331, 6656.633885136364, 6666.733330666816, 6670.633115178712, 6672.666366681647, 6348.936510634834, 6569.37590928861, 6735.494837887178, 6838.829029274308, 6849.349311815369, 6554.082428459924, 6566.868662626816, 6574.243961944438, 6578.901316480161, 6579.078928950046, 6452.193475815523, 6463.353664633499, 6490.448311893542, 6492.935070649422, 6501.2198536175965, 6586.637734924625, 6800.795976120724, 6810.6594670265295, 6820.965895170492, 6825.590464572141, 4357.215701173693, 4372.060007098489, 4395.230834603995, 4403.295472724349, 4403.493598236244, 6511.576747511396, 6513.348665133449, 6521.217453905372, 6529.640869752209, 6540.803775886731, 6284.354421361397, 6307.180066591497, 6371.904421433589, 6375.394337537927, 6382.170317858649, 6308.779192728232, 6312.147860038836, 6343.0, 6357.745690172526, 6366.490680745436, 6247.0, 6247.156633854372, 6259.1550140730415, 6261.812145635638, 6263.342349053466, 6279.686015699288, 6358.841028974312, 6393.0, 6395.296517383177, 6401.711922963571, 6247.187865577446, 6248.687565621792, 6250.3749625037135, 6251.187345645037, 6253.6560489173535], "unit": "ms", "name": "prototype.html", "value": 4767.020047303345}, {"lowerIsBetter": false, "replicates": [754.3851760814936, 757.0725860820496, 787.5353541410568, 798.4091772088656, 851.9062903080662, 13404.061715679894, 13703.725925481496, 13709.177449353047, 13731.038827282095, 13734.107283026597, 12819.551315703951, 12870.356482175901, 12885.677858053554, 12888.033397495179, 12893.806592901114, 678.8879834827272, 809.4050872608643, 819.5574389829485, 820.3314298846451, 820.3970081989733, 672.1900110366996, 803.895493585836, 811.7808191788214, 813.9715109971153, 814.979625509364, 845.7420486751538, 851.9318454523655, 854.9871751923695, 855.4354126276659, 857.5197889182078, 697.7662483068203, 705.4955706669705, 848.3594885861166, 850.3664769746516, 851.2253848997414, 634.926983396906, 635.1837888313541, 636.9554131210817, 639.1946147853691, 639.9888176680834, 12464.0, 12567.120301578892, 12619.558315458915, 12637.43131559073, 12699.746005079938, 11611.187216894821, 12416.503339866395, 12758.553450629184, 12804.80792788109, 13389.598312050653, 10437.843432348522, 10507.527161277761, 10551.73620659482, 10673.733156671067, 10678.839817402744, 3578.0, 3619.438986957026, 3627.8730244441317, 3640.7087433005295, 3753.474513568103, 46549.06901861944, 46620.3006954896, 46626.76686616579, 46718.0, 46833.765831170625, 10022.74943126413, 10145.9492702536, 10191.133753630877, 10275.383476991405, 10511.054005139575, 18675.906620466812, 18729.0, 18730.34443794461, 18744.25022999065, 18749.0, 7617.428692848059, 7661.846763064707, 7896.802579935547, 7926.128125906146, 8183.0, 4163.604457576525, 4244.342126970325, 4247.723897946624, 4256.36154576816, 4314.71954322968, 3074.308280636839, 3111.2999575095423, 3118.6725393833776, 3119.4696901526795, 3124.765642576816, 536.7933345661949, 560.2212924035593, 560.4927540575785, 571.0777094991558, 582.0222026994605, 577.8699792546728, 600.9248843894513, 623.2697306619876, 705.4814711187273, 706.2584286499156, 8880.289576833968, 8891.73324800257, 9004.36969412135, 9007.909920900838, 9031.412958157698, 526.5234962359071, 608.0119805316361, 636.59576169132, 656.8686262747469, 679.58205703492, 4090.754554726726, 4201.474815648044, 4455.465344158722, 4461.353103799931, 4476.149531588988, 56401.71799140978, 57188.0, 57249.71375143098, 57284.71357643185, 57340.426595734345, 51282.0, 51675.0, 52136.0, 52213.21680174801, 52569.47430525646, 47081.76459117683, 47323.5267647326, 47707.761461193164, 48232.76508523749, 48600.7569962155, 8305.626246818787, 8395.790105247417, 8477.830443390974, 8525.44584601999, 8601.95699021526, 34063.0, 34351.65648343485, 34443.82778086194, 34862.47706284357, 35817.0, 43430.0, 43924.341134882365, 44033.11933761371, 44612.55387446214, 44781.0, 11509.53961841517, 11599.246049006788, 11652.30086194831, 11855.229410088661, 11872.584459543874, 12344.4474924561, 12490.06324525646, 12501.374931253582, 12689.682757931125, 13120.868791311965, 11686.357250351311, 11962.222455540363, 12160.878391216329, 12218.816717749063, 12516.499340026297, 10889.455527223765, 11218.943905280748, 11442.599509017144, 11483.196176267582, 11724.120690948042, 11138.3873886937, 11485.368304743319, 11611.477483513094, 11780.0, 11853.407329633312, 9808.950955245464, 10003.849942250727, 10072.344180805596, 10108.545115469675, 10521.158307335549, 9048.638054477748, 9392.577334019848, 9497.76255593588, 10016.64941727036, 10093.19254459656], "unit": "ms", "name": "yui.html", "value": 6345.477251103791}], "name": "dromaeo_css", "value": 6965.921443124473}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 111.0, 112.0, 111.0, 100.0, 110.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 148.0, 169.0, 123.0, 155.0, 154.0, 123.0, 161.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 159.0, 158.0, 162.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 92.0, 72.0, 71.0, 71.0, 92.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 93.0, 94.0, 93.0, 141.0, 92.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 69.0, 58.0, 56.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 85.0, 84.0, 84.0, 93.0, 84.0, 83.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [122.0, 130.0, 124.0, 119.0, 117.0, 133.0, 117.0, 119.0, 120.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [148.0, 155.0, 151.0, 155.0, 157.0, 147.0, 164.0, 148.0, 154.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1503.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.17896329928112], "unit": "score", "name": "Richards", "value": 186.60637199999996}, {"lowerIsBetter": false, "replicates": [194.4012441679627], "unit": "score", "name": "DeltaBlue", "value": 340.110992}, {"lowerIsBetter": false, "replicates": [283.7684449489217], "unit": "score", "name": "Encrypt", "value": 938.0218440000002}, {"lowerIsBetter": false, "replicates": [4975.124378109453], "unit": "score", "name": "Decrypt", "value": 53.502381}, {"lowerIsBetter": false, "replicates": [1943.6893203883494], "unit": "score", "name": "RayTrace", "value": 380.7136213786215}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25219.51219512195], "unit": "score", "name": "RegExp", "value": 36.12222920696325}, {"lowerIsBetter": false, "replicates": [640.7147415443523], "unit": "score", "name": "Splay", "value": 127.18764641434261}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19550.98076272938}]} 06:02:45 INFO - RETURN: dromaeo_css: 6965.92 06:02:45 INFO - RETURN: kraken: 1503.60 06:02:45 INFO - RETURN: v8_7: 19550.98 06:02:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19550.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1503.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6965.92"}}} 06:02:45 INFO - Return code: 0 06:02:45 INFO - # TBPL SUCCESS # 06:02:45 INFO - Running post-action listener: _resource_record_post_action 06:02:45 INFO - Running post-run listener: _resource_record_post_run 06:02:46 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 10526720; Write bytes: 395771904; Read time: 3772; Write time: 295756 06:02:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 466944; Read time: 0; Write time: 32 06:02:46 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 9637888; Write bytes: 316153856; Read time: 3548; Write time: 222184 06:02:46 INFO - Running post-run listener: _upload_blobber_files 06:02:46 INFO - Blob upload gear active. 06:02:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:02:46 INFO - Copying logs to upload dir... 06:02:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.527716 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-24 06:02:46.242399) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:02:46.245793) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009796 build_url: 'https://queue.taskcluster.net/v1/task/-qyb6ntSSOewlrmsN8mq1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:02:46.297962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:02:46.298369) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448368847.44286-633615542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:02:46.348890) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 06:02:46.349410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 06:02:46.349805) ========= ========= Total master_lag: 0.22 =========