builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1453485364.87 results: success (0) buildid: 20160122073132 builduid: a98ce736a1b546b88dd3ebf3f7df36d3 revision: 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.867210) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.867612) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.867911) ========= 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006317 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.890850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.891153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.904950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.905249) ========= 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.954447) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.954751) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.955094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:04.955365) ========= 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 09:56:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-22 09:56:05 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.065528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.065837) ========= 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.116727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.117036) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a --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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 09:56:05,484 truncating revision to first 12 chars 2016-01-22 09:56:05,484 Setting DEBUG logging. 2016-01-22 09:56:05,484 attempt 1/10 2016-01-22 09:56:05,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0cd0ae95d865?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 09:56:05,785 unpacking tar archive at: mozilla-aurora-0cd0ae95d865/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570866 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.700570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.700957) ========= echo 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a'] 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a program finished with exit code 0 elapsedTime=0.004512 script_repo_revision: '0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.750208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.750526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:05.760999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-22 09:56:05.761370) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:06 INFO - MultiFileLogger online at 20160122 09:56:06 in /builds/slave/test-pgo 09:56:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:56:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:56:06 INFO - {'append_to_log': False, 09:56:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:56:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:56:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:56:06 INFO - 'branch': 'Mozilla-Aurora', 09:56:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:06 INFO - 'config_files': ('talos/linux_config.py',), 09:56:06 INFO - 'default_actions': ('clobber', 09:56:06 INFO - 'read-buildbot-config', 09:56:06 INFO - 'download-and-extract', 09:56:06 INFO - 'populate-webroot', 09:56:06 INFO - 'create-virtualenv', 09:56:06 INFO - 'install', 09:56:06 INFO - 'run-tests'), 09:56:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:06 INFO - 'download_minidump_stackwalk': True, 09:56:06 INFO - 'download_symbols': 'ondemand', 09:56:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:06 INFO - 'installer_path': 'installer.exe', 09:56:06 INFO - 'log_level': 'info', 09:56:06 INFO - 'log_name': 'talos', 09:56:06 INFO - 'log_to_console': True, 09:56:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:06 INFO - 'opt_config_files': (), 09:56:06 INFO - 'pip_index': False, 09:56:06 INFO - 'sps_profile': False, 09:56:06 INFO - 'sps_profile_interval': 0, 09:56:06 INFO - 'suite': 'dromaeojs', 09:56:06 INFO - 'system_bits': '32', 09:56:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:06 INFO - 'title': 'talos-linux64-ix-048', 09:56:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:06 INFO - 'use_talos_json': True, 09:56:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:56:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:06 INFO - 'work_dir': 'build'} 09:56:06 INFO - ##### 09:56:06 INFO - ##### Running clobber step. 09:56:06 INFO - ##### 09:56:06 INFO - Running pre-action listener: _resource_record_pre_action 09:56:06 INFO - Running main action method: clobber 09:56:06 INFO - rmtree: /builds/slave/test-pgo/build 09:56:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:56:06 INFO - Running post-action listener: _resource_record_post_action 09:56:06 INFO - ##### 09:56:06 INFO - ##### Running read-buildbot-config step. 09:56:06 INFO - ##### 09:56:06 INFO - Running pre-action listener: _resource_record_pre_action 09:56:06 INFO - Running main action method: read_buildbot_config 09:56:06 INFO - Using buildbot properties: 09:56:06 INFO - { 09:56:06 INFO - "properties": { 09:56:06 INFO - "buildnumber": 212, 09:56:06 INFO - "product": "firefox", 09:56:06 INFO - "script_repo_revision": "production", 09:56:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:56:06 INFO - "repository": "", 09:56:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:56:06 INFO - "buildid": "20160122073132", 09:56:06 INFO - "slavename": "talos-linux64-ix-048", 09:56:06 INFO - "pgo_build": "True", 09:56:06 INFO - "basedir": "/builds/slave/test-pgo", 09:56:06 INFO - "project": "", 09:56:06 INFO - "platform": "ubuntu64_hw", 09:56:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:56:06 INFO - "slavebuilddir": "test", 09:56:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:56:06 INFO - "branch": "mozilla-aurora", 09:56:06 INFO - "repo_path": "releases/mozilla-aurora", 09:56:06 INFO - "stage_platform": "linux64-pgo", 09:56:06 INFO - "builduid": "a98ce736a1b546b88dd3ebf3f7df36d3", 09:56:06 INFO - "revision": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a" 09:56:06 INFO - }, 09:56:06 INFO - "sourcestamp": { 09:56:06 INFO - "repository": "", 09:56:06 INFO - "hasPatch": false, 09:56:06 INFO - "project": "", 09:56:06 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:56:06 INFO - "changes": [ 09:56:06 INFO - { 09:56:06 INFO - "category": null, 09:56:06 INFO - "files": [ 09:56:06 INFO - { 09:56:06 INFO - "url": null, 09:56:06 INFO - "name": "https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:56:06 INFO - } 09:56:06 INFO - ], 09:56:06 INFO - "repository": "", 09:56:06 INFO - "rev": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a", 09:56:06 INFO - "who": "cbook@mozilla.com", 09:56:06 INFO - "when": 1453485357, 09:56:06 INFO - "number": 7501772, 09:56:06 INFO - "comments": "Bug 1240868 - Use a mock addon provider to feed broken data in Telemetry. r=gfritzsche, a=sylvestre", 09:56:06 INFO - "project": "", 09:56:06 INFO - "at": "Fri 22 Jan 2016 09:55:57", 09:56:06 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:56:06 INFO - "revlink": "", 09:56:06 INFO - "properties": [ 09:56:06 INFO - [ 09:56:06 INFO - "buildid", 09:56:06 INFO - "20160122073132", 09:56:06 INFO - "Change" 09:56:06 INFO - ], 09:56:06 INFO - [ 09:56:06 INFO - "builduid", 09:56:06 INFO - "a98ce736a1b546b88dd3ebf3f7df36d3", 09:56:06 INFO - "Change" 09:56:06 INFO - ], 09:56:06 INFO - [ 09:56:06 INFO - "pgo_build", 09:56:06 INFO - "True", 09:56:06 INFO - "Change" 09:56:06 INFO - ] 09:56:06 INFO - ], 09:56:06 INFO - "revision": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a" 09:56:06 INFO - } 09:56:06 INFO - ], 09:56:06 INFO - "revision": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a" 09:56:06 INFO - } 09:56:06 INFO - } 09:56:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:56:06 INFO - Running post-action listener: _resource_record_post_action 09:56:06 INFO - ##### 09:56:06 INFO - ##### Running download-and-extract step. 09:56:06 INFO - ##### 09:56:06 INFO - Running pre-action listener: _resource_record_pre_action 09:56:06 INFO - Running main action method: download_and_extract 09:56:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:56: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')]} 09:56:06 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json 09:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json 09:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:56:07 INFO - Downloaded 1302 bytes. 09:56:07 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:56:07 INFO - Using the following test package requirements: 09:56:07 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:56:07 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:07 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'jsshell-linux-x86_64.zip'], 09:56:07 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:07 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:56:07 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:56:07 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:56:07 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:07 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:56:07 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:07 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:07 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:07 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:56:09 INFO - Downloaded 23159720 bytes. 09:56:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:56:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:56:10 INFO - Return code: 0 09:56:10 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:56: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')]} 09:56:10 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:56:11 INFO - Downloaded 23159720 bytes. 09:56:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:56:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:56:12 INFO - Return code: 0 09:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:12 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:56:14 INFO - Downloaded 11132038 bytes. 09:56:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:56:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:56:14 INFO - Return code: 0 09:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:14 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:56:17 INFO - Downloaded 58017146 bytes. 09:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:17 INFO - mkdir: /builds/slave/test-pgo/properties 09:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:56:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:56:17 INFO - Contents: 09:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:17 INFO - Running post-action listener: _resource_record_post_action 09:56:17 INFO - Running post-action listener: set_extra_try_arguments 09:56:17 INFO - ##### 09:56:17 INFO - ##### Running populate-webroot step. 09:56:17 INFO - ##### 09:56:17 INFO - Running pre-action listener: _resource_record_pre_action 09:56:17 INFO - Running main action method: populate_webroot 09:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:17 INFO - '--tppagecycles', 09:56:17 INFO - '7'], 09:56:17 INFO - 'tests': ['tsvgm']}}, 09:56:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:56:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'tests': ['damp', 'tps']}, 09:56:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['damp', 'tps']}, 09:56:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:17 INFO - 'other': {'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore']}, 09:56:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore']}, 09:56:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore']}, 09:56:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore']}, 09:56:17 INFO - 'other_l64': {'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore']}, 09:56:17 INFO - 'other_nol64': {'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore']}, 09:56:17 INFO - 'svgr': {'tests': ['tsvgx', 09:56:17 INFO - 'tsvgr_opacity', 09:56:17 INFO - 'tart', 09:56:17 INFO - 'tscrollx', 09:56:17 INFO - 'cart']}, 09:56:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['tsvgx', 09:56:17 INFO - 'tsvgr_opacity', 09:56:17 INFO - 'tart', 09:56:17 INFO - 'tscrollx', 09:56:17 INFO - 'cart']}, 09:56:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'tests': ['tp5o']}, 09:56:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'talos_options': ['--e10s'], 09:56:17 INFO - 'tests': ['tp5o']}, 09:56:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'talos_options': ['--xperf_path', 09:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:17 INFO - 'tests': ['tp5n']}, 09:56:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:17 INFO - 'talos_options': ['--e10s', 09:56:17 INFO - '--xperf_path', 09:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:17 INFO - 'tests': ['tp5n']}}, 09:56:17 INFO - 'talos.zip': {'path': '', 09:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:17 INFO - Running post-action listener: _resource_record_post_action 09:56:17 INFO - ##### 09:56:17 INFO - ##### Running create-virtualenv step. 09:56:17 INFO - ##### 09:56:17 INFO - Running pre-action listener: _resource_record_pre_action 09:56:17 INFO - Running main action method: create_virtualenv 09:56:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:56:17 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 09:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:17 INFO - Using real prefix '/usr' 09:56:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:20 INFO - Installing pip.................done. 09:56:20 INFO - Return code: 0 09:56:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:56:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:56:20 INFO - Using env: {'DISPLAY': ':0', 09:56:20 INFO - 'HOME': '/home/cltbld', 09:56:20 INFO - 'LANG': 'en_US.UTF-8', 09:56:20 INFO - 'LANGUAGE': 'en_US:en', 09:56:20 INFO - 'LOGNAME': 'cltbld', 09:56:20 INFO - 'MAIL': '/var/mail/cltbld', 09:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:20 INFO - 'MOZ_NO_REMOTE': '1', 09:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:20 INFO - 'NO_EM_RESTART': '1', 09:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:20 INFO - 'SHELL': '/bin/bash', 09:56:20 INFO - 'SHLVL': '1', 09:56:20 INFO - 'TERM': 'linux', 09:56:20 INFO - 'TMOUT': '86400', 09:56:20 INFO - 'USER': 'cltbld', 09:56:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:20 INFO - '_': '/tools/buildbot/bin/python'} 09:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:20 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 09:56:20 INFO - Cleaning up... 09:56:20 INFO - Return code: 0 09:56:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:56:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:56:20 INFO - Using env: {'DISPLAY': ':0', 09:56:20 INFO - 'HOME': '/home/cltbld', 09:56:20 INFO - 'LANG': 'en_US.UTF-8', 09:56:20 INFO - 'LANGUAGE': 'en_US:en', 09:56:20 INFO - 'LOGNAME': 'cltbld', 09:56:20 INFO - 'MAIL': '/var/mail/cltbld', 09:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:20 INFO - 'MOZ_NO_REMOTE': '1', 09:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:20 INFO - 'NO_EM_RESTART': '1', 09:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:20 INFO - 'SHELL': '/bin/bash', 09:56:20 INFO - 'SHLVL': '1', 09:56:20 INFO - 'TERM': 'linux', 09:56:20 INFO - 'TMOUT': '86400', 09:56:20 INFO - 'USER': 'cltbld', 09:56:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:20 INFO - '_': '/tools/buildbot/bin/python'} 09:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:20 INFO - Downloading/unpacking psutil>=0.7.1 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:22 INFO - Installing collected packages: psutil 09:56:22 INFO - Running setup.py install for psutil 09:56:22 INFO - building 'psutil._psutil_linux' extension 09:56:22 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 09:56:22 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 09:56:22 INFO - building 'psutil._psutil_posix' extension 09:56:22 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 09:56:23 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 09:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:23 INFO - Successfully installed psutil 09:56:23 INFO - Cleaning up... 09:56:23 INFO - Return code: 0 09:56:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:56:23 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')]} 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:23 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')]} 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:56:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:56:23 INFO - Using env: {'DISPLAY': ':0', 09:56:23 INFO - 'HOME': '/home/cltbld', 09:56:23 INFO - 'LANG': 'en_US.UTF-8', 09:56:23 INFO - 'LANGUAGE': 'en_US:en', 09:56:23 INFO - 'LOGNAME': 'cltbld', 09:56:23 INFO - 'MAIL': '/var/mail/cltbld', 09:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:23 INFO - 'MOZ_NO_REMOTE': '1', 09:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:23 INFO - 'NO_EM_RESTART': '1', 09:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:23 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:23 INFO - 'SHELL': '/bin/bash', 09:56:23 INFO - 'SHLVL': '1', 09:56:23 INFO - 'TERM': 'linux', 09:56:23 INFO - 'TMOUT': '86400', 09:56:23 INFO - 'USER': 'cltbld', 09:56:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:23 INFO - '_': '/tools/buildbot/bin/python'} 09:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:56:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:56:25 INFO - Installing collected packages: mozsystemmonitor 09:56:25 INFO - Running setup.py install for mozsystemmonitor 09:56:25 INFO - Successfully installed mozsystemmonitor 09:56:25 INFO - Cleaning up... 09:56:25 INFO - Return code: 0 09:56:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:56:25 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')]} 09:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:25 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')]} 09:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:56:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:56:25 INFO - Using env: {'DISPLAY': ':0', 09:56:25 INFO - 'HOME': '/home/cltbld', 09:56:25 INFO - 'LANG': 'en_US.UTF-8', 09:56:25 INFO - 'LANGUAGE': 'en_US:en', 09:56:25 INFO - 'LOGNAME': 'cltbld', 09:56:25 INFO - 'MAIL': '/var/mail/cltbld', 09:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:25 INFO - 'MOZ_NO_REMOTE': '1', 09:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:25 INFO - 'NO_EM_RESTART': '1', 09:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:25 INFO - 'SHELL': '/bin/bash', 09:56:25 INFO - 'SHLVL': '1', 09:56:25 INFO - 'TERM': 'linux', 09:56:25 INFO - 'TMOUT': '86400', 09:56:25 INFO - 'USER': 'cltbld', 09:56:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:25 INFO - '_': '/tools/buildbot/bin/python'} 09:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:25 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 09:56:25 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 09:56:25 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 09:56:25 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 09:56:25 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 09:56:25 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 09:56:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:56:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 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 09:56:27 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 09:56:28 INFO - Downloading docopt-0.6.1.tar.gz 09:56:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:28 INFO - Running setup.py install for blobuploader 09:56:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:56:28 INFO - Running setup.py install for requests 09:56:28 INFO - Running setup.py install for docopt 09:56:28 INFO - Successfully installed blobuploader requests docopt 09:56:28 INFO - Cleaning up... 09:56:28 INFO - Return code: 0 09:56:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:56:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:28 INFO - Using env: {'DISPLAY': ':0', 09:56:28 INFO - 'HOME': '/home/cltbld', 09:56:28 INFO - 'LANG': 'en_US.UTF-8', 09:56:28 INFO - 'LANGUAGE': 'en_US:en', 09:56:28 INFO - 'LOGNAME': 'cltbld', 09:56:28 INFO - 'MAIL': '/var/mail/cltbld', 09:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:28 INFO - 'MOZ_NO_REMOTE': '1', 09:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:28 INFO - 'NO_EM_RESTART': '1', 09:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:28 INFO - 'SHELL': '/bin/bash', 09:56:28 INFO - 'SHLVL': '1', 09:56:28 INFO - 'TERM': 'linux', 09:56:28 INFO - 'TMOUT': '86400', 09:56:28 INFO - 'USER': 'cltbld', 09:56:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:28 INFO - '_': '/tools/buildbot/bin/python'} 09:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:28 INFO - Running setup.py (path:/tmp/pip-O3f7EP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:28 INFO - Running setup.py (path:/tmp/pip-pqLGhr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:29 INFO - Running setup.py (path:/tmp/pip-MiMYyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:29 INFO - Running setup.py (path:/tmp/pip-mPSjBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:29 INFO - Running setup.py (path:/tmp/pip-aXpBmr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:29 INFO - Running setup.py (path:/tmp/pip-ES4trh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:29 INFO - Running setup.py (path:/tmp/pip-RceZOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:29 INFO - Running setup.py (path:/tmp/pip-p3aZcG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:29 INFO - Running setup.py (path:/tmp/pip-ZeXvEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:29 INFO - Running setup.py (path:/tmp/pip-1JSQCr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:29 INFO - Running setup.py (path:/tmp/pip-329YR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:29 INFO - Running setup.py (path:/tmp/pip-3kz_zR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:29 INFO - Running setup.py (path:/tmp/pip-KWFNM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:29 INFO - Running setup.py (path:/tmp/pip-jDGCon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:29 INFO - Running setup.py (path:/tmp/pip-1vYfuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:29 INFO - Running setup.py (path:/tmp/pip-n_XgN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:30 INFO - Running setup.py (path:/tmp/pip-aNR0zp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:30 INFO - Running setup.py install for manifestparser 09:56:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Running setup.py install for mozcrash 09:56:30 INFO - Running setup.py install for mozdebug 09:56:30 INFO - Running setup.py install for mozdevice 09:56:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Running setup.py install for mozfile 09:56:30 INFO - Running setup.py install for mozhttpd 09:56:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Running setup.py install for mozinfo 09:56:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Running setup.py install for mozInstall 09:56:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:56:30 INFO - Running setup.py install for mozleak 09:56:30 INFO - Running setup.py install for mozlog 09:56:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Running setup.py install for moznetwork 09:56:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Running setup.py install for mozprocess 09:56:31 INFO - Running setup.py install for mozprofile 09:56:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Running setup.py install for mozrunner 09:56:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Running setup.py install for mozscreenshot 09:56:31 INFO - Running setup.py install for moztest 09:56:31 INFO - Running setup.py install for mozversion 09:56:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:56:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:31 INFO - Cleaning up... 09:56:31 INFO - Return code: 0 09:56:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56: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')]} 09:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:56:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:31 INFO - Using env: {'DISPLAY': ':0', 09:56:31 INFO - 'HOME': '/home/cltbld', 09:56:31 INFO - 'LANG': 'en_US.UTF-8', 09:56:31 INFO - 'LANGUAGE': 'en_US:en', 09:56:31 INFO - 'LOGNAME': 'cltbld', 09:56:31 INFO - 'MAIL': '/var/mail/cltbld', 09:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:31 INFO - 'MOZ_NO_REMOTE': '1', 09:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:31 INFO - 'NO_EM_RESTART': '1', 09:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:31 INFO - 'SHELL': '/bin/bash', 09:56:31 INFO - 'SHLVL': '1', 09:56:31 INFO - 'TERM': 'linux', 09:56:31 INFO - 'TMOUT': '86400', 09:56:31 INFO - 'USER': 'cltbld', 09:56:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:31 INFO - '_': '/tools/buildbot/bin/python'} 09:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:32 INFO - Running setup.py (path:/tmp/pip-BUvGxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:32 INFO - Running setup.py (path:/tmp/pip-2Bpl0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:32 INFO - Running setup.py (path:/tmp/pip-cWND08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:32 INFO - Running setup.py (path:/tmp/pip-Ede_0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:32 INFO - Running setup.py (path:/tmp/pip-opPttH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:32 INFO - Running setup.py (path:/tmp/pip-J1PxaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:32 INFO - Running setup.py (path:/tmp/pip-SI5ZuX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:32 INFO - Running setup.py (path:/tmp/pip-_IlJfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:32 INFO - Running setup.py (path:/tmp/pip-qMhU9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:32 INFO - Running setup.py (path:/tmp/pip-QpS8Hy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:32 INFO - Running setup.py (path:/tmp/pip-aqrPcb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:32 INFO - Running setup.py (path:/tmp/pip-fNtOw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:32 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)) 09:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:32 INFO - Running setup.py (path:/tmp/pip-QXLnRQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:33 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)) 09:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:33 INFO - Running setup.py (path:/tmp/pip-GKcXkM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:33 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)) 09:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:33 INFO - Running setup.py (path:/tmp/pip-V9NDoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:33 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)) 09:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:33 INFO - Running setup.py (path:/tmp/pip-J5t7jw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:33 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)) 09:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:33 INFO - Running setup.py (path:/tmp/pip-69udcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:33 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)) 09:56:33 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)) 09:56:33 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)) 09:56:33 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)) 09:56:33 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)) 09:56:33 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)) 09:56:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:33 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 09:56:33 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 09:56:33 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 09:56:33 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 09:56:33 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 09:56:33 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 09:56:35 INFO - Downloading blessings-1.6.tar.gz 09:56:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:35 INFO - Installing collected packages: blessings 09:56:35 INFO - Running setup.py install for blessings 09:56:35 INFO - Successfully installed blessings 09:56:35 INFO - Cleaning up... 09:56:35 INFO - Return code: 0 09:56:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:56:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:56:35 INFO - Reading from file tmpfile_stdout 09:56:35 INFO - Current package versions: 09:56:35 INFO - argparse == 1.2.1 09:56:35 INFO - blessings == 1.6 09:56:35 INFO - blobuploader == 1.2.4 09:56:35 INFO - docopt == 0.6.1 09:56:35 INFO - manifestparser == 1.1 09:56:35 INFO - mozInstall == 1.12 09:56:35 INFO - mozcrash == 0.16 09:56:35 INFO - mozdebug == 0.1 09:56:35 INFO - mozdevice == 0.47 09:56:35 INFO - mozfile == 1.2 09:56:35 INFO - mozhttpd == 0.7 09:56:35 INFO - mozinfo == 0.9 09:56:35 INFO - mozleak == 0.1 09:56:35 INFO - mozlog == 3.1 09:56:35 INFO - moznetwork == 0.27 09:56:35 INFO - mozprocess == 0.22 09:56:35 INFO - mozprofile == 0.27 09:56:35 INFO - mozrunner == 6.11 09:56:35 INFO - mozscreenshot == 0.1 09:56:35 INFO - mozsystemmonitor == 0.0 09:56:35 INFO - moztest == 0.7 09:56:35 INFO - mozversion == 1.4 09:56:35 INFO - psutil == 3.1.1 09:56:35 INFO - requests == 1.2.3 09:56:35 INFO - wsgiref == 0.1.2 09:56:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:35 INFO - Using env: {'DISPLAY': ':0', 09:56:35 INFO - 'HOME': '/home/cltbld', 09:56:35 INFO - 'LANG': 'en_US.UTF-8', 09:56:35 INFO - 'LANGUAGE': 'en_US:en', 09:56:35 INFO - 'LOGNAME': 'cltbld', 09:56:35 INFO - 'MAIL': '/var/mail/cltbld', 09:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:35 INFO - 'MOZ_NO_REMOTE': '1', 09:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:35 INFO - 'NO_EM_RESTART': '1', 09:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:35 INFO - 'SHELL': '/bin/bash', 09:56:35 INFO - 'SHLVL': '1', 09:56:35 INFO - 'TERM': 'linux', 09:56:35 INFO - 'TMOUT': '86400', 09:56:35 INFO - 'USER': 'cltbld', 09:56:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:35 INFO - '_': '/tools/buildbot/bin/python'} 09:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 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)) 09:56:35 INFO - Cleaning up... 09:56:35 INFO - Return code: 0 09:56:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:35 INFO - Using env: {'DISPLAY': ':0', 09:56:35 INFO - 'HOME': '/home/cltbld', 09:56:35 INFO - 'LANG': 'en_US.UTF-8', 09:56:35 INFO - 'LANGUAGE': 'en_US:en', 09:56:35 INFO - 'LOGNAME': 'cltbld', 09:56:35 INFO - 'MAIL': '/var/mail/cltbld', 09:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:35 INFO - 'MOZ_NO_REMOTE': '1', 09:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:35 INFO - 'NO_EM_RESTART': '1', 09:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:35 INFO - 'SHELL': '/bin/bash', 09:56:35 INFO - 'SHLVL': '1', 09:56:35 INFO - 'TERM': 'linux', 09:56:35 INFO - 'TMOUT': '86400', 09:56:35 INFO - 'USER': 'cltbld', 09:56:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:35 INFO - '_': '/tools/buildbot/bin/python'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Downloading/unpacking jsonschema 09:56:36 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 09:56:36 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 09:56:36 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 09:56:36 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 09:56:36 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 09:56:36 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 09:56:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:37 INFO - Downloading/unpacking functools32 (from jsonschema) 09:56:37 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 09:56:37 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 09:56:37 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 09:56:37 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 09:56:37 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 09:56:37 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 09:56:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:38 INFO - warning: no files found matching '*.txt' 09:56:38 INFO - no previously-included directories found matching 'build' 09:56:38 INFO - no previously-included directories found matching 'dist' 09:56:38 INFO - no previously-included directories found matching '.git*' 09:56:38 INFO - Installing collected packages: jsonschema, functools32 09:56:38 INFO - Running setup.py install for functools32 09:56:38 INFO - warning: no files found matching '*.txt' 09:56:38 INFO - no previously-included directories found matching 'build' 09:56:38 INFO - no previously-included directories found matching 'dist' 09:56:38 INFO - no previously-included directories found matching '.git*' 09:56:38 INFO - Successfully installed jsonschema functools32 09:56:38 INFO - Cleaning up... 09:56:38 INFO - Return code: 0 09:56:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ccdcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ba600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, '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': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', '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 09:56:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:56:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:56:38 INFO - Using env: {'DISPLAY': ':0', 09:56:38 INFO - 'HOME': '/home/cltbld', 09:56:38 INFO - 'LANG': 'en_US.UTF-8', 09:56:38 INFO - 'LANGUAGE': 'en_US:en', 09:56:38 INFO - 'LOGNAME': 'cltbld', 09:56:38 INFO - 'MAIL': '/var/mail/cltbld', 09:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:38 INFO - 'MOZ_NO_REMOTE': '1', 09:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:38 INFO - 'NO_EM_RESTART': '1', 09:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:38 INFO - 'SHELL': '/bin/bash', 09:56:38 INFO - 'SHLVL': '1', 09:56:38 INFO - 'TERM': 'linux', 09:56:38 INFO - 'TMOUT': '86400', 09:56:38 INFO - 'USER': 'cltbld', 09:56:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:38 INFO - '_': '/tools/buildbot/bin/python'} 09:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:38 INFO - Downloading/unpacking flake8 09:56:38 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 09:56:38 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 09:56:38 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 09:56:38 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 09:56:38 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 09:56:38 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 09:56:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:56:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:56:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 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 09:56:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:56:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:40 INFO - no previously-included directories found matching 'docs/_build' 09:56:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:56:40 INFO - Running setup.py install for pep8 09:56:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:41 INFO - no previously-included directories found matching 'docs/_build' 09:56:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:56:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Running post-action listener: _resource_record_post_action 09:56:41 INFO - Running post-action listener: _start_resource_monitoring 09:56:41 INFO - Starting resource monitoring. 09:56:41 INFO - ##### 09:56:41 INFO - ##### Running install step. 09:56:41 INFO - ##### 09:56:41 INFO - Running pre-action listener: _resource_record_pre_action 09:56:41 INFO - Running main action method: install 09:56:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:56:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:56:41 INFO - Reading from file tmpfile_stdout 09:56:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:56:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:56:41 INFO - Reading from file tmpfile_stdout 09:56:41 INFO - Output received: 09:56:41 INFO - Usage: mozinstall [options] installer 09:56:41 INFO - Options: 09:56:41 INFO - -h, --help show this help message and exit 09:56:41 INFO - -d DEST, --destination=DEST 09:56:41 INFO - Directory to install application into. [default: 09:56:41 INFO - "/builds/slave/test-pgo"] 09:56:41 INFO - --app=APP Application being installed. [default: firefox] 09:56:41 INFO - mkdir: /builds/slave/test-pgo/build/application 09:56:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:56:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:56:55 INFO - Reading from file tmpfile_stdout 09:56:55 INFO - Output received: 09:56:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - ##### 09:56:55 INFO - ##### Running run-tests step. 09:56:55 INFO - ##### 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: run_tests 09:56:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:56:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:56:55 INFO - Python 2.7.3 09:56:55 INFO - Return code: 0 09:56:55 INFO - grabbing minidump binary from tooltool 09:56: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')]} 09:56:55 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 0x2849350>, '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 0x284a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:56:55 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 09:56:55 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 09:56:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:56 INFO - Return code: 0 09:56:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:56:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:56:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:56:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:56:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:56:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:56:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:56:57 INFO - Return code: 0 09:56:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 09:56:57 INFO - Using env: {'DISPLAY': ':0', 09:56:57 INFO - 'HOME': '/home/cltbld', 09:56:57 INFO - 'LANG': 'en_US.UTF-8', 09:56:57 INFO - 'LANGUAGE': 'en_US:en', 09:56:57 INFO - 'LOGNAME': 'cltbld', 09:56:57 INFO - 'MAIL': '/var/mail/cltbld', 09:56:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:56:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:57 INFO - 'MOZ_NO_REMOTE': '1', 09:56:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:57 INFO - 'NO_EM_RESTART': '1', 09:56:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:56:57 INFO - 'SHELL': '/bin/bash', 09:56:57 INFO - 'SHLVL': '1', 09:56:57 INFO - 'TERM': 'linux', 09:56:57 INFO - 'TMOUT': '86400', 09:56:57 INFO - 'USER': 'cltbld', 09:56:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791', 09:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:57 INFO - '_': '/tools/buildbot/bin/python'} 09:56:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 09:56:57 INFO - mozversion INFO | application_buildid: 20160122073132 09:56:57 INFO - mozversion INFO | application_changeset: 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a 09:56:57 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:56:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:57 INFO - mozversion INFO | application_name: Firefox 09:56:57 INFO - mozversion INFO | application_remotingname: firefox-dev 09:56:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:56:57 INFO - mozversion INFO | application_vendor: Mozilla 09:56:57 INFO - mozversion INFO | application_version: 45.0a2 09:56:57 INFO - mozversion INFO | platform_buildid: 20160122073132 09:56:57 INFO - mozversion INFO | platform_changeset: 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a 09:56:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:56:57 INFO - mozversion INFO | platform_version: 45.0a2 09:56:57 INFO - 2016-01-22 09:56:57,359 DEBUG : using testdate: 1453485417 09:56:57 INFO - 2016-01-22 09:56:57,359 DEBUG : actual date: 1453485417 09:56:57 INFO - 2016-01-22 09:56:57,406 INFO : starting webserver on 'localhost:36942' 09:56:57 INFO - 2016-01-22 09:56:57,407 INFO : Starting test suite talos-linux64-ix-048 09:56:57 INFO - 2016-01-22 09:56:57,408 INFO : Starting test dromaeo_css 09:56:57 INFO - 2016-01-22 09:56:57,408 DEBUG : operating with platform_type : linux_ 09:56:57 INFO - 2016-01-22 09:56:57,408 INFO : Initialising browser for dromaeo_css test... 09:56:57 INFO - 2016-01-22 09:56:57,424 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmlSY_p/profile http://localhost:36942/getInfo.html 09:57:01 INFO - 2016-01-22 09:57:01,580 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:57:01 INFO - 2016-01-22 09:57:01,580 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:57:01 INFO - 2016-01-22 09:57:01,580 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:57:01 INFO - 2016-01-22 09:57:01,580 DEBUG : BROWSER_OUTPUT: __metrics 09:57:01 INFO - 2016-01-22 09:57:01,709 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:02 INFO - 2016-01-22 09:57:02,692 INFO : Browser initialized. 09:57:02 INFO - 2016-01-22 09:57:02,693 INFO : Running cycle 1/1 for dromaeo_css test... 09:57:02 INFO - 2016-01-22 09:57:02,693 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmlSY_p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:57:14 INFO - 2016-01-22 09:57:14,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 137441280 09:57:14 INFO - 2016-01-22 09:57:14,471 DEBUG : BROWSER_OUTPUT: 09:58:05 INFO - 2016-01-22 09:58:05,280 DEBUG : BROWSER_OUTPUT: 1453485485279 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] 10:00:13 INFO - 2016-01-22 10:00:13,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36942/tests/dromaeo/cssquery-ext.html) 10:00:15 INFO - 2016-01-22 10:00:15,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 229306368 10:00:15 INFO - 2016-01-22 10:00:15,047 DEBUG : BROWSER_OUTPUT: 10:03:17 INFO - 2016-01-22 10:03:17,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/dromaeo/cssquery-ext.html (next: http://localhost:36942/tests/dromaeo/cssquery-jquery.html) 10:03:17 INFO - 2016-01-22 10:03:17,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 225026048 10:03:17 INFO - 2016-01-22 10:03:17,921 DEBUG : BROWSER_OUTPUT: 10:06:19 INFO - 2016-01-22 10:06:19,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36942/tests/dromaeo/cssquery-mootools.html) 10:06:20 INFO - 2016-01-22 10:06:20,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 222994432 10:06:20 INFO - 2016-01-22 10:06:20,374 DEBUG : BROWSER_OUTPUT: 10:09:22 INFO - 2016-01-22 10:09:22,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36942/tests/dromaeo/cssquery-prototype.html) 10:09:22 INFO - 2016-01-22 10:09:22,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 206573568 10:09:22 INFO - 2016-01-22 10:09:22,733 DEBUG : BROWSER_OUTPUT: 10:12:25 INFO - 2016-01-22 10:12:25,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36942/tests/dromaeo/cssquery-yui.html) 10:12:25 INFO - 2016-01-22 10:12:25,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 208908288 10:12:25 INFO - 2016-01-22 10:12:25,705 DEBUG : BROWSER_OUTPUT: 10:15:27 INFO - 2016-01-22 10:15:27,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/dromaeo/cssquery-yui.html (next: http://localhost:36942/tests/dromaeo/cssquery-dojo.html) 10:15:28 INFO - 2016-01-22 10:15:28,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 252162048 10:15:28 INFO - 2016-01-22 10:15:28,069 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,069 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:15:28 INFO - 2016-01-22 10:15:28,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:15:28 INFO - 2016-01-22 10:15:28,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:15:28 INFO - 2016-01-22 10:15:28,070 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:15:28 INFO - 2016-01-22 10:15:28,070 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3292.4402851515247;3351.6815902489284;3375.9156021099484;3386.0180547641185;3405.642407547207;5536.3909969903325;5540.667559946401;5545.140503221997;5560.582956278286;5570.805021824237;5530.5022547970675;5545;5561.4716601922855;5563.527100196478;5568.331800183983;4866.172750632383;5010.348654674887;5018.824341148061;5032.19484882418;5094.337736094321;5004.524570165847;5070.670406423571;5071.290019397287;5076.746162691869;5084.44071152173;4951.133551628469;4975.975120124413;5069.239614057902;5099.643024988252;5114.181730923053;5102.744862756866;5158.303629010074;5159.587233021387;5164.431912489605;5187.636865419422;4823.252395878644;5056.241563765428;5061.139606266906;5110.463401342842;5139.357580302462;5211.478852114758;5267;5272.182811664198;5292.073887069748;5360.865978350534;5992.910106348409;6012.458878700894;6042.425969532887;6044.546659000593;6060.000099983497;5888.175655408247;5979.01346277868;6077.20996270482;6079.756809727605;6088.908666370008;5448.727563621843;5527.640703354309;5537.584681148849;5547.8890422191735;5572.7770889164385;6053.213082299273;6103.572749907464;6106.114613381035;6109.083637454329;6115.449609535163;5735.598508104393;5742.971285143548;5887.911681324784;5908.231929849092;5921.763129474859;5960.4635582797755;6020.879582408327;6038.849028774316;6042.6978651067275;6045.3652366501765;5941.494972927263;5979.521638268928;5981;5986.580939334205;5990.221271234712;5736.5123964462655;5795.623284486495;5858.443447872445;5987.191729116514;5993.400659933972;4583.289590113538;4584.977075114603;4585.060062687141;4589.518100599389;4611.146937816515;4126.958730412657;4139.254934111828;4142.730722503088;4143.1713657268665;4157.355609880473;5502.009638265071;5582.385937546866;5590.8043218487155;5717.056685646905;5754.4533269339345;6001.969990150109;6006.519478441714;6031.577789554777;6036.215292012011;6044.697765111727;5694.686792226385;5705.600607957404;5705.686187259741;5711.8000869969355;5716.828495145152;5029.119904016782;5080.339555857789;5127.589792816566;5203.5576975957465;5210.921836172461;6051;6055.697215139226;6064.181335519736;6075.27096748393;6154.107654390178;5907.3797251288;5955.225820643289;5962.791302304398;5965.433283838029;5973.074173503114;5957.553183511167;5993.9700301498215;6045.425684559959;6079.817605471843;6103.260680208552;5909.084091965752;5925.229720136354;5942.970285148546;5952.553558483044;5960.195373624505;5766.769329226784;6025.035994241076;6029.216201893726;6030.30651475086;6049;5741.3971532988435;5799.797007104731;5891.263592050994;5897.085951677497;5920.555958303231;5812.21535092757;5817.76728930838;5819.359870414166;5833.766649333979;5838.1826544282985;5610.747516361856;5672.631278966854;5728.742206600629;5739.05305624584;5751.597388182954;5755.65466072037;5758.62568933018;5839.912401314069;5867.647941123546;5871.588988770745;5725.456081672234;5754.424557544379;5768.7404066817935;5772.624779389326;5772.682502462405 10:15:28 INFO - 2016-01-22 10:15:28,071 DEBUG : BROWSER_OUTPUT: |1;ext.html;614.8278482025034;626.2735227136523;634.3434545245668;638.7317326722776;640.3532432243436;31195.99999999997;38265.617343826554;38992.41511377325;39008.21983560327;39020.219595608105;45392.77303613477;45958.770206148925;46065.7696711516;46077;46128.308075378896;7936.325412339958;8037.035555733291;9122.817543649124;9314.906850931506;9322.673706420243;10931.726706832353;11126.6105686301;11189.944050279737;11194.440277986108;11194.440277986108;10833.729156771065;10962.397068161248;10969.780604387908;10971.725706857353;10972.561097556088;8182.877256841152;8322.375821813328;10810.513526891269;10843.07833834125;10923.453827308642;10588.841167382496;10725.570977160904;10746.838797418044;10747.355158690425;10755.623553175601;42680;42782;42940.785296073635;43029;43100.784496077635;3597.4603809428795;3630.7276954228537;3738.775673459601;3974.721769476138;4279.422277992493;32627.347453050807;32838;33124.503132453036;33253.66746332554;33744.49383259253;3514.2971405718704;3525.6029464179605;3539.7876127432437;3580.856765729394;3625.474306225609;287972;289211;290437.5478122617;290466;290634;59048.40951590515;59547;66112.66943665346;66675;66686;76619.61690191625;77026.6148669253;77669.61165194251;77787;77841;17037.233324500427;17319.826801732073;17348.30606775715;17351.65296694059;17356.3057477702;12874.935625322001;12921.741565168644;12922.612321630366;12947.417366218542;12955.481780728665;21879.781202188093;21934.122635094416;21941.670874936888;22054.448638784157;22167.556648866932;7564.319211271012;7771.4559980800805;7822.960885195537;7871.212878712083;7983.84032319362;1009.5709323537467;1060.671191930504;1061.368485750977;1134.546181527379;1159.7912375772441;29771.722242141936;30372.392552148835;30603;30718.232044199074;30818.53772193419;1014.624588902111;1051.51104736298;1058.9364638121738;1161.7618388230392;1200.0879331707965;13887.58337249884;15165.620859478602;16645.83354166467;16727.91636041812;16921.153942302837;287169;292363;292996;293134;293447;60623.66569838701;61177.694111529156;61190;61214.69392653008;61330.69334653387;1454.3237394611556;1468.1338010573813;1470.6102882736084;1476.6825132596543;1503.5639664497173;31924.6807531931;32828.67171328256;35043.82478087593;35194.47208291826;35653.82173089222;55627.16559251533;56277.71861140668;56318;56407.71796140993;56463;321769;323743;325314;325453;325655;30575.388492230475;30855.845720771253;31170.376592468478;32762.34475310528;36234.637653623126;42243.7887810559;51843.222351664;53857;55883;57242.14136788035;38404.23191536209;38866.61133388743;38987.80506097451;39203;39740.40389394104;40124.598754012084;40580.797096015514;40721.1855762889;41122.794386029076;43575.56424435715;38905.41641875318;39044;40142.397864032646;40835.38746918858;41106.588934110274;38237.808810955765;39808.80095599504;40025;42504.57495425006;44503;32663.510047348835;32850.1787455306;32924.50613240755;33229;33391.165220869676 10:15:28 INFO - 2016-01-22 10:15:28,073 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.2046962787032;387.4208058951867;388.8683929764386;389.4975481628699;391.2741863842572;15027.398904043825;15680.764788528153;17139.742903856437;18604;18613.4415967521;17484.21321040553;17543.473695789115;17581.7362739559;17780.91109544454;18175.182116804743;6050.152978582991;6178.41305076017;6187.102870083858;6192.721327540249;6193.040078787795;4492.932606010912;4612.400387949562;4623.283391074372;4623.630109591241;6114.144019837204;6709.396154346108;6728.4953628477815;6914.066601008875;6930.688119034656;6931.514793964425;6809.387155156035;6854.554453960502;6855.931440685604;6858.3141685831015;6861.451083913275;6413.230412350548;6541.182352205974;6551.312112228243;6556.114924485229;6559.409653131193;22367.440813979618;22960.19639312616;23060.884695576584;23068.307950761504;23511.76488235113;2225.922092726747;2424.684790977179;2451.3748994006414;2458.6066229403386;2556.693196816394;9808.607655693835;10100.747481312952;10293.228007899437;14823.555293341216;15344.309506072253;1933.835623971964;1943.5918457124021;1953.082051435823;1971.2903354792263;1999.4701404127918;54448.72775636136;56311.71844140753;56960.43039569593;57216;57549.84900302012;10829.24195306321;10852.82943411321;10894.346339219672;10958.890411095947;11034.503447344889;14484.493042743454;14592.708145837023;14623.488177913721;14631.780523292158;14632.853671463363;7858.371330293563;7908.367330613537;7939.28546430824;7953.8409231816195;7983.161768014391;7565.924340756522;7575.810604734816;7596.924030759732;7656.081270247606;7660.923390766021;4824.807007719722;4831.396075490564;4839.249916262985;4857.198562237191;4893.681910675795;1779.9313703251544;1816.5549440386926;1873.2226126157764;1954.3159894036974;1956.790862984706;959.1703176752059;969.3021024862088;1001.2875111419262;1060.2889885401096;1110.7500812317164;17098.125249301906;17271.222794974256;17446.47660570185;17560.38538651141;18038.90980545089;918.8851393575803;951.4291425144996;1008.5108722269694;1038.7195457226658;1066.7173199102244;9374.812503749887;10010.749731256778;10244.078032976919;10268;10315.535800888978;664596;670923;683046;699227;721008;85552;87001;87242;88136.1186388128;89132.5543372292;1247.3513772838073;1258.6224132760135;1258.779713550125;1260.3446207971804;1267.3283159925254;16545.66908661844;16592.42209280418;16605.50183494497;16704;16811;35402;38509.037274068374;38639;38809.61190388173;38889.222215556096;41129.38305925473;43398;43713.34429983489;44120;45897;9968.40189588627;10123.898761012295;10153.441560713936;10238.846417303597;10261.74345641365;15827;17642.73535896937;17747.55631109181;18113.36603218881;18152.90923545374;15041.623959401102;15042.398304067714;15180.696386071995;15729.764053539435;16268.105254211132;15210.239488025776;15507.689846202788;15720.76418853741;15970.361185552449;16199.271032803788;12956.870431295567;13000.154989925624;13078.738425231251;15131.773023404437;15143.469978550698;9634.470104144339;9777.071178238057;9805.656802011896;10311.381317120997;10327.535260913428;14304.070235434663;14470.059446135967;14476.841852651973;15283.46507872219;15341.232938352814 10:15:28 INFO - 2016-01-22 10:15:28,076 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1100.873399559051;1571.6070982254437;1580.968380632388;1800.4958611588754;1814.7912990006153;7157.4989750717405;7802.804929876749;7970.840583188333;7978.720744773941;7984.441089123764;7989.440739148262;7993.800154996114;8053;8057.073436554798;8063.1130575636635;2030.6649402848586;2064.133064113076;2375.7386687464364;2412.8552286862755;2413.6017557103055;2382;2423.442608200115;2431.197704757426;2431.9392015199583;2432.063655492639;2326.604477238865;2332.1604222479978;2383.30884043628;2383.9868056076184;2386.6300723387817;2340.9882950585225;2360.8701521416315;2365.8698771567556;2377.8454400464;2400.903963841453;2375.1449478187837;2378.9643155352683;2393.1863166523467;2424.823960379215;2437.4515733959893;8010.599470026534;8070.031596208434;8072.475289106189;8081.5555144467035;8091.19088091192;4848.2727590861305;5025.798968041274;5027.798888044474;5030.698158110525;5035.697858128524;3122.8126312421327;3136.247300647851;3189.0751682012187;3246.7402607791555;3261.5107733839877;1020.2399212586596;1033.0444338986408;1033.2405681823852;1045.592219034577;1065.6856227412932;10812.297200681931;10859;10863.348199108079;10865.5110520026;10871.782564348669;4534.274516077412;4611.216093264153;4694.694844835075;4737.857864264078;4738.31294462308;9262.351635385594;9267.629294828266;9303.674371396968;9308.581113849757;9309;5088.745562721849;5096.643234973516;5220.556252718561;5221.981713565819;5226.216067589892;4706.458757242893;4746.738929358849;4752.477227504972;4756.381670382828;4758.5241475852135;3459.775114617542;3489.668481494254;3982.3628219484744;4081.428599996003;4092.07928216149;1298.8246586710861;1305.4908585651604;1306.784380577194;1320.570814485296;1337.5118081900036;1105.4638500327335;1108.9611863584735;1114.2812885688686;1315.8289422375221;1415.1721243072711;7740.109887363025;7807.492512986638;7808.882866757003;7830;7901.209879012053;1167.626359564948;1169.2925779903205;1169.368540987874;1177.4936777185721;1179.0920990837008;6093.238345206849;6169.660668663177;6202.069689546604;6203.16257305267;6211.9689401552705;9443.811123777487;9712.465814380277;9757.707268781947;9860.45767482781;9865.852012219822;9649.662261820802;9668.323217374857;9768.51157442125;9777.560009799576;9784.266180036526;7257.2742725727;7341.77974660761;7409.962950185322;7429.145648250413;7433.959245705605;7367.77896663101;7622.2758837910305;7667.11828139771;7669.424793140425;7691.461597688108;8494.193051660082;8647.394682372174;8781.824363512822;8903.465792052497;8922.73231803047;8377.790555235924;8560.272376848037;8723.694670686495;8738.082501337269;9143.497107659143;7339.119305683352;7417.666205020679;7440.921066445227;7441.181470038399;7446.367058800062;7190.245024272376;7306.415486761152;7756.185600512091;7932.04815422153;8015.078265999485;7493.587852667937;7513.2111128330735;7523.398128149625;7546.358559522502;7594.582297973444;7339.229380914927;7391.6304184791625;7414.962925185339;7443.590602516913;7509.436792240713;6974.093367862349;7051.964740176266;7095.893561596684;7112.35988761014;7494.887576686463;6797.864042719019;6842.623655698984;6843.076184715;6845.178578570603;6846.726130954905;6780.355866192704;6932.0988271524375;6955.408790252885;6977.546459480118;6978.057962175041 10:15:28 INFO - 2016-01-22 10:15:28,077 DEBUG : BROWSER_OUTPUT: |4;prototype.html;340.5283682100291;343.4539082858255;344.5400390478712;347.3105884818635;347.66971377191675;6106.572539922202;6111;6153.661548614825;6170.47550958168;6177.598456100351;5813.73838177282;5919.704014799265;5996.730147143378;6081.878362432749;6105.603135796181;4633;4696.953030469703;4699.647526435514;4702.365180700613;4706.62347012239;4686.156491831469;4688.132695451352;4699.577038066574;4706.247000479924;4707.90584188316;4405.581469760367;4478.507364189936;4552.430946131733;4591.311303304497;4593.173228818811;4593.104344652794;4596.839110631146;4623.5838774510285;4644.558766917137;4657.743824089674;4082.265192265391;4091.713580049398;4092.8362865485346;4096.262672718909;4108.5275193352545;5796.8840623187725;5802.62282951611;5811.912821307684;5812.651240925558;5822.592418530705;5240.9475905241225;5377.838664840061;5415.783368665288;5417.756200970965;5421.566274698014;6478.514111441661;6480;6480.222373315232;6485.092087107809;6485.578437401554;4483.30508771141;4483.910321793546;4485.035717320791;4485.932711009337;4488.371627972087;6628.3371662833815;6705.832354191136;6762.560433571802;6764.188297404294;6765.560238584476;4589.885252868638;4589.908201835945;4591.770411479412;4595.37962375075;4597.379353787196;4635.049814787961;4647.721136731807;4648.790804413809;4648.814047438133;4654.069186162781;5385.0037743017665;5387.218853266333;5387.3804512481565;5390;5393.2179833923865;6319.368063193644;6482.12491313676;6506.089147519351;6514.967425162844;6554.967225163844;1648.077076836975;1660;1661.028298445423;1672.406295764986;1677.865770738338;1121.6018313498753;1125.3248051169396;1133.444612140062;1139.5840518210794;1155.572438197872;6333.20834895638;6383.39357761012;6391.42477177047;6399.456046236029;6402.35976402356;6790.864182716318;6791.4906382021545;6791.966040169867;6796.76211332601;6798.966005169942;6193.566450348522;6313.526485513513;6348.587341822767;6427.421532062043;6449.258335291408;3652.8356223969986;3673.7612055216327;3680.4847321375028;3681.5582130144016;3682.116292089879;6839.076724642209;6844.691988860413;6849.315068493211;6855.211650660138;6864.107666003388;6827.863442731117;6987.091678081817;6987.510874238755;6993.860122797516;7011.053507776487;6973.79078627642;6998.405135563534;7000.684969176399;7001.92998070023;7008.22909479967;6706.731730730716;6821.727130914708;6827.93172068273;6829.556078854858;6831.4876384272375;6626.370494802986;6629.403353698191;6631.734730610721;6633.436157926631;6637.70130344126;6945.305469453015;6991.091158149408;6991.615461149686;6994.790156295319;7002.929970700227;4738.384010078667;4738.834140805193;4742.336072949859;4751.691140075884;4770.0936822003705;6638.20341559016;6732.932670673231;6766.323367663194;6776.7628133015105;6797.1843378794865;6588.7364505421165;6602.966985165043;6603.141591593062;6616.172978377703;6617.371349721769;6393.520485963479;6588.275289718223;6591.835204119935;6596.8350791230605;6603.240627327918;6449.6130232186215;6513.8697226056165;6519.771807986698;6522.15212022434;6528.281888992302;6563.442107420923;6569.737210511526;6606.47148228131;6613.503987200883;6638.734450622114;6320.462760665395;6431.163948686641;6469.417752402306;6473.449756770728;6478.190226221723 10:15:28 INFO - 2016-01-22 10:15:28,080 DEBUG : BROWSER_OUTPUT: |5;yui.html;787.6180052674456;829.6100832608673;846.4794151596766;855.1234984141255;856.0626114404724;13602.727945441098;13898.722025559495;13915.582532524015;13916.93041534791;13924.443022279096;12561.057920655965;12568.937155314234;12569;12588.559400420963;12623.558175463837;756.3042001358763;758.0713625808369;886.4769785826361;894.3247847874845;902.1700035966926;898.6225785170211;904.7150147703485;905.2034209895315;908.0737647599444;923.3674932671141;939.9577019034126;940.0223767282018;940.4827344960279;941.7410212191634;953.2945620241042;782.2763943352405;790.2808444315674;948.1608776233014;953.1469334945219;956.7082039977804;702.5819637315789;702.9051078104442;703.6024646074951;710.2861624067831;723.6381809095452;13943.58169254924;14164.29178541079;14172.716545669029;14173.78739318911;14184.503542376071;11833.644990650208;11939.820902686466;12145.02839772816;12526.248425094524;12731.872681273162;10482.895171048269;10774.892251077546;10792.892071079266;10889.891101088966;10951.83572246417;3923.8430462781453;3954.4859168307935;3962.484876965976;3967.4247234151176;3968.5634580196156;49554.00891982176;50216.74891625555;50465;50782.238266425666;51057.74471127658;9697.6605818796;9835.901640983642;10054.095131438205;10070.949645251727;10095.798084038279;17019.48941531756;17031.063291518836;17040.233189506504;17042.914785425994;17065.658686826442;7268;7336.669849856769;7442.776716698508;7487.962560187164;7516.285952834472;4511.278195488706;4557.886052848639;4566.931496027562;4595;4653.069386122789;3049.725524702743;3060.586820779211;3071.2475443516037;3075.138961090898;3090.7681923855803;563.605476166685;567.3532173322416;568.5934556791914;570.5179123640518;585.2596465471182;515.101148495877;517.6945602094783;551.7985935133728;617.7405489694339;647.2718192033961;8072;8523.360747943929;8549.957250213709;8867.157620026088;8912;446.4218836606602;556.3129535024242;569.2201683693366;661.4311691944923;685.6092027544252;3900.804959752001;3903.8243279052513;4116.608922152391;4317.978410107929;4329;57885.710571447715;58482.707586461795;58721;58815;59216.70391648014;51716.48283517192;52705;53186.46813531815;53729.462705373226;53802;48017.27974080392;48041.519584803704;48250.75874620605;48464.7576762114;49421.50578494169;8585.570721463777;8593.570321484025;8701.564921753761;8920.509371984344;8940.418872773249;34868.9539313821;35719.28561428809;36215.637843621225;36841.63158368382;36893.44659830158;45273.094538108395;45406.31890521579;45417.31874021826;45740.54259457496;46378.53621463877;10222.897771022195;10237.436940968319;10415.270931034755;10649.467526623794;10871.402072886067;11001.1749118818;11223;11299.37853418037;11398.658040258806;11546.653600392001;10850.186236032487;10872.347659140476;11043.282186657842;11184.608538701106;11378;10573.577056917944;10736.409497477714;10742.248042637253;10760.46197690128;10917.290376125844;9634.470104144339;10790.784184316426;10958.780824383628;10996.06533444634;11228.719282017688;8176.754697359089;9632.084951929835;9674.177694896012;9867.802643947225;10127.088562029452;9417.387869788441;9676.080772326617;9863.901360986298;9876.851847222153;9885.456299903575 10:15:28 INFO - 2016-01-22 10:15:28,080 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:15:28 INFO - 2016-01-22 10:15:28,080 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:15:28 INFO - 2016-01-22 10:15:28,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,838 10:15:28 INFO - 2016-01-22 10:15:28,081 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:15:28 INFO - 2016-01-22 10:15:28,081 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486528066__endTimestamp 10:15:28 INFO - 2016-01-22 10:15:28,081 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,081 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:15:28 INFO - 2016-01-22 10:15:28,081 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:15:28 INFO - 2016-01-22 10:15:28,081 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5533.31 Median:5742.97 stddev:608.86 (10.6%) stddev-sans-first:584.80 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: Values: 3292.4 3351.7 3375.9 3386.0 3405.6 5536.4 5540.7 5545.1 5560.6 5570.8 5530.5 5545.0 5561.5 5563.5 5568.3 4866.2 5010.3 5018.8 5032.2 5094.3 5004.5 5070.7 5071.3 5076.7 5084.4 4951.1 4976.0 5069.2 5099.6 5114.2 5102.7 5158.3 5159.6 5164.4 5187.6 4823.3 5056.2 5061.1 5110.5 5139.4 5211.5 5267.0 5272.2 5292.1 5360.9 5992.9 6012.5 6042.4 6044.5 6060.0 5888.2 5979.0 6077.2 6079.8 6088.9 5448.7 5527.6 5537.6 5547.9 5572.8 6053.2 6103.6 6106.1 6109.1 6115.4 5735.6 5743.0 5887.9 5908.2 5921.8 5960.5 6020.9 6038.8 6042.7 6045.4 5941.5 5979.5 5981.0 5986.6 5990.2 5736.5 5795.6 5858.4 5987.2 5993.4 4583.3 4585.0 4585.1 4589.5 4611.1 4127.0 4139.3 4142.7 4143.2 4157.4 5502.0 5582.4 5590.8 5717.1 5754.5 6002.0 6006.5 6031.6 6036.2 6044.7 5694.7 5705.6 5705.7 5711.8 5716.8 5029.1 5080.3 5127.6 5203.6 5210.9 6051.0 6055.7 6064.2 6075.3 6154.1 5907.4 5955.2 5962.8 5965.4 5973.1 5957.6 5994.0 6045.4 6079.8 6103.3 5909.1 5925.2 5943.0 5952.6 5960.2 5766.8 6025.0 6029.2 6030.3 6049.0 5741.4 5799.8 5891.3 5897.1 5920.6 5812.2 5817.8 5819.4 5833.8 5838.2 5610.7 5672.6 5728.7 5739.1 5751.6 5755.7 5758.6 5839.9 5867.6 5871.6 5725.5 5754.4 5768.7 5772.6 5772.7 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50162.66 Median:19279.06 stddev:78832.73 (408.9%) stddev-sans-first:78966.09 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: Values: 614.8 626.3 634.3 638.7 640.4 31196.0 38265.6 38992.4 39008.2 39020.2 45392.8 45958.8 46065.8 46077.0 46128.3 7936.3 8037.0 9122.8 9314.9 9322.7 10931.7 11126.6 11189.9 11194.4 11194.4 10833.7 10962.4 10969.8 10971.7 10972.6 8182.9 8322.4 10810.5 10843.1 10923.5 10588.8 10725.6 10746.8 10747.4 10755.6 42680.0 42782.0 42940.8 43029.0 43100.8 3597.5 3630.7 3738.8 3974.7 4279.4 32627.3 32838.0 33124.5 33253.7 33744.5 3514.3 3525.6 3539.8 3580.9 3625.5 287972.0 289211.0 290437.5 290466.0 290634.0 59048.4 59547.0 66112.7 66675.0 66686.0 76619.6 77026.6 77669.6 77787.0 77841.0 17037.2 17319.8 17348.3 17351.7 17356.3 12874.9 12921.7 12922.6 12947.4 12955.5 21879.8 21934.1 21941.7 22054.4 22167.6 7564.3 7771.5 7823.0 7871.2 7983.8 1009.6 1060.7 1061.4 1134.5 1159.8 29771.7 30372.4 30603.0 30718.2 30818.5 1014.6 1051.5 1058.9 1161.8 1200.1 13887.6 15165.6 16645.8 16727.9 16921.2 287169.0 292363.0 292996.0 293134.0 293447.0 60623.7 61177.7 61190.0 61214.7 61330.7 1454.3 1468.1 1470.6 1476.7 1503.6 31924.7 32828.7 35043.8 35194.5 35653.8 55627.2 56277.7 56318.0 56407.7 56463.0 321769.0 323743.0 325314.0 325453.0 325655.0 30575.4 30855.8 31170.4 32762.3 36234.6 42243.8 51843.2 53857.0 55883.0 57242.1 38404.2 38866.6 38987.8 39203.0 39740.4 40124.6 40580.8 40721.2 41122.8 43575.6 38905.4 39044.0 40142.4 40835.4 41106.6 38237.8 39808.8 40025.0 42504.6 44503.0 32663.5 32850.2 32924.5 33229.0 33391.2 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33662.77 Median:12296.68 stddev:112227.03 (912.7%) stddev-sans-first:112514.03 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: Values: 384.2 387.4 388.9 389.5 391.3 15027.4 15680.8 17139.7 18604.0 18613.4 17484.2 17543.5 17581.7 17780.9 18175.2 6050.2 6178.4 6187.1 6192.7 6193.0 4492.9 4612.4 4623.3 4623.6 6114.1 6709.4 6728.5 6914.1 6930.7 6931.5 6809.4 6854.6 6855.9 6858.3 6861.5 6413.2 6541.2 6551.3 6556.1 6559.4 22367.4 22960.2 23060.9 23068.3 23511.8 2225.9 2424.7 2451.4 2458.6 2556.7 9808.6 10100.7 10293.2 14823.6 15344.3 1933.8 1943.6 1953.1 1971.3 1999.5 54448.7 56311.7 56960.4 57216.0 57549.8 10829.2 10852.8 10894.3 10958.9 11034.5 14484.5 14592.7 14623.5 14631.8 14632.9 7858.4 7908.4 7939.3 7953.8 7983.2 7565.9 7575.8 7596.9 7656.1 7660.9 4824.8 4831.4 4839.2 4857.2 4893.7 1779.9 1816.6 1873.2 1954.3 1956.8 959.2 969.3 1001.3 1060.3 1110.8 17098.1 17271.2 17446.5 17560.4 18038.9 918.9 951.4 1008.5 1038.7 1066.7 9374.8 10010.7 10244.1 10268.0 10315.5 664596.0 670923.0 683046.0 699227.0 721008.0 85552.0 87001.0 87242.0 88136.1 89132.6 1247.4 1258.6 1258.8 1260.3 1267.3 16545.7 16592.4 16605.5 16704.0 16811.0 35402.0 38509.0 38639.0 38809.6 38889.2 41129.4 43398.0 43713.3 44120.0 45897.0 9968.4 10123.9 10153.4 10238.8 10261.7 15827.0 17642.7 17747.6 18113.4 18152.9 15041.6 15042.4 15180.7 15729.8 16268.1 15210.2 15507.7 15720.8 15970.4 16199.3 12956.9 13000.2 13078.7 15131.8 15143.5 9634.5 9777.1 9805.7 10311.4 10327.5 14304.1 14470.1 14476.8 15283.5 15341.2 10:15:28 INFO - 2016-01-22 10:15:28,082 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,083 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5709.27 Median:6789.11 stddev:2905.45 (42.8%) stddev-sans-first:2892.94 10:15:28 INFO - 2016-01-22 10:15:28,083 DEBUG : BROWSER_OUTPUT: Values: 1100.9 1571.6 1581.0 1800.5 1814.8 7157.5 7802.8 7970.8 7978.7 7984.4 7989.4 7993.8 8053.0 8057.1 8063.1 2030.7 2064.1 2375.7 2412.9 2413.6 2382.0 2423.4 2431.2 2431.9 2432.1 2326.6 2332.2 2383.3 2384.0 2386.6 2341.0 2360.9 2365.9 2377.8 2400.9 2375.1 2379.0 2393.2 2424.8 2437.5 8010.6 8070.0 8072.5 8081.6 8091.2 4848.3 5025.8 5027.8 5030.7 5035.7 3122.8 3136.2 3189.1 3246.7 3261.5 1020.2 1033.0 1033.2 1045.6 1065.7 10812.3 10859.0 10863.3 10865.5 10871.8 4534.3 4611.2 4694.7 4737.9 4738.3 9262.4 9267.6 9303.7 9308.6 9309.0 5088.7 5096.6 5220.6 5222.0 5226.2 4706.5 4746.7 4752.5 4756.4 4758.5 3459.8 3489.7 3982.4 4081.4 4092.1 1298.8 1305.5 1306.8 1320.6 1337.5 1105.5 1109.0 1114.3 1315.8 1415.2 7740.1 7807.5 7808.9 7830.0 7901.2 1167.6 1169.3 1169.4 1177.5 1179.1 6093.2 6169.7 6202.1 6203.2 6212.0 9443.8 9712.5 9757.7 9860.5 9865.9 9649.7 9668.3 9768.5 9777.6 9784.3 7257.3 7341.8 7410.0 7429.1 7434.0 7367.8 7622.3 7667.1 7669.4 7691.5 8494.2 8647.4 8781.8 8903.5 8922.7 8377.8 8560.3 8723.7 8738.1 9143.5 7339.1 7417.7 7440.9 7441.2 7446.4 7190.2 7306.4 7756.2 7932.0 8015.1 7493.6 7513.2 7523.4 7546.4 7594.6 7339.2 7391.6 7415.0 7443.6 7509.4 6974.1 7052.0 7095.9 7112.4 7494.9 6797.9 6842.6 6843.1 6845.2 6846.7 6780.4 6932.1 6955.4 6977.5 6978.1 10:15:28 INFO - 2016-01-22 10:15:28,083 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,083 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5458.18 Median:6253.55 stddev:1650.65 (26.4%) stddev-sans-first:1609.97 10:15:28 INFO - 2016-01-22 10:15:28,083 DEBUG : BROWSER_OUTPUT: Values: 340.5 343.5 344.5 347.3 347.7 6106.6 6111.0 6153.7 6170.5 6177.6 5813.7 5919.7 5996.7 6081.9 6105.6 4633.0 4697.0 4699.6 4702.4 4706.6 4686.2 4688.1 4699.6 4706.2 4707.9 4405.6 4478.5 4552.4 4591.3 4593.2 4593.1 4596.8 4623.6 4644.6 4657.7 4082.3 4091.7 4092.8 4096.3 4108.5 5796.9 5802.6 5811.9 5812.7 5822.6 5240.9 5377.8 5415.8 5417.8 5421.6 6478.5 6480.0 6480.2 6485.1 6485.6 4483.3 4483.9 4485.0 4485.9 4488.4 6628.3 6705.8 6762.6 6764.2 6765.6 4589.9 4589.9 4591.8 4595.4 4597.4 4635.0 4647.7 4648.8 4648.8 4654.1 5385.0 5387.2 5387.4 5390.0 5393.2 6319.4 6482.1 6506.1 6515.0 6555.0 1648.1 1660.0 1661.0 1672.4 1677.9 1121.6 1125.3 1133.4 1139.6 1155.6 6333.2 6383.4 6391.4 6399.5 6402.4 6790.9 6791.5 6792.0 6796.8 6799.0 6193.6 6313.5 6348.6 6427.4 6449.3 3652.8 3673.8 3680.5 3681.6 3682.1 6839.1 6844.7 6849.3 6855.2 6864.1 6827.9 6987.1 6987.5 6993.9 7011.1 6973.8 6998.4 7000.7 7001.9 7008.2 6706.7 6821.7 6827.9 6829.6 6831.5 6626.4 6629.4 6631.7 6633.4 6637.7 6945.3 6991.1 6991.6 6994.8 7002.9 4738.4 4738.8 4742.3 4751.7 4770.1 6638.2 6732.9 6766.3 6776.8 6797.2 6588.7 6603.0 6603.1 6616.2 6617.4 6393.5 6588.3 6591.8 6596.8 6603.2 6449.6 6513.9 6519.8 6522.2 6528.3 6563.4 6569.7 6606.5 6613.5 6638.7 6320.5 6431.2 6469.4 6473.4 6478.2 10:15:28 INFO - 2016-01-22 10:15:28,084 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,084 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13990.93 Median:48146.14 stddev:16489.59 (34.2%) stddev-sans-first:16506.03 10:15:28 INFO - 2016-01-22 10:15:28,085 DEBUG : BROWSER_OUTPUT: Values: 787.6 829.6 846.5 855.1 856.1 13602.7 13898.7 13915.6 13916.9 13924.4 12561.1 12568.9 12569.0 12588.6 12623.6 756.3 758.1 886.5 894.3 902.2 898.6 904.7 905.2 908.1 923.4 940.0 940.0 940.5 941.7 953.3 782.3 790.3 948.2 953.1 956.7 702.6 702.9 703.6 710.3 723.6 13943.6 14164.3 14172.7 14173.8 14184.5 11833.6 11939.8 12145.0 12526.2 12731.9 10482.9 10774.9 10792.9 10889.9 10951.8 3923.8 3954.5 3962.5 3967.4 3968.6 49554.0 50216.7 50465.0 50782.2 51057.7 9697.7 9835.9 10054.1 10070.9 10095.8 17019.5 17031.1 17040.2 17042.9 17065.7 7268.0 7336.7 7442.8 7488.0 7516.3 4511.3 4557.9 4566.9 4595.0 4653.1 3049.7 3060.6 3071.2 3075.1 3090.8 563.6 567.4 568.6 570.5 585.3 515.1 517.7 551.8 617.7 647.3 8072.0 8523.4 8550.0 8867.2 8912.0 446.4 556.3 569.2 661.4 685.6 3900.8 3903.8 4116.6 4318.0 4329.0 57885.7 58482.7 58721.0 58815.0 59216.7 51716.5 52705.0 53186.5 53729.5 53802.0 48017.3 48041.5 48250.8 48464.8 49421.5 8585.6 8593.6 8701.6 8920.5 8940.4 34869.0 35719.3 36215.6 36841.6 36893.4 45273.1 45406.3 45417.3 45740.5 46378.5 10222.9 10237.4 10415.3 10649.5 10871.4 11001.2 11223.0 11299.4 11398.7 11546.7 10850.2 10872.3 11043.3 11184.6 11378.0 10573.6 10736.4 10742.2 10760.5 10917.3 9634.5 10790.8 10958.8 10996.1 11228.7 8176.8 9632.1 9674.2 9867.8 10127.1 9417.4 9676.1 9863.9 9876.9 9885.5 10:15:28 INFO - 2016-01-22 10:15:28,085 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:15:28 INFO - 2016-01-22 10:15:28,086 DEBUG : BROWSER_OUTPUT: 10:15:28 INFO - 2016-01-22 10:15:28,707 INFO : Browser exited with error code: 0 10:15:28 INFO - 2016-01-22 10:15:28,733 INFO : Completed test dromaeo_css (00:18:31) 10:15:28 INFO - 2016-01-22 10:15:28,733 INFO : Starting test kraken 10:15:28 INFO - 2016-01-22 10:15:28,733 DEBUG : operating with platform_type : linux_ 10:15:28 INFO - 2016-01-22 10:15:28,733 INFO : Initialising browser for kraken test... 10:15:28 INFO - 2016-01-22 10:15:28,739 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphfvKZF/profile http://localhost:36942/getInfo.html 10:15:32 INFO - 2016-01-22 10:15:32,904 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:15:32 INFO - 2016-01-22 10:15:32,904 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:15:32 INFO - 2016-01-22 10:15:32,904 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:15:32 INFO - 2016-01-22 10:15:32,904 DEBUG : BROWSER_OUTPUT: __metrics 10:15:33 INFO - 2016-01-22 10:15:33,142 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:33 INFO - 2016-01-22 10:15:33,958 INFO : Browser initialized. 10:15:33 INFO - 2016-01-22 10:15:33,959 INFO : Running cycle 1/1 for kraken test... 10:15:33 INFO - 2016-01-22 10:15:33,959 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphfvKZF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:15:45 INFO - 2016-01-22 10:15:45,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 137564160 10:15:45 INFO - 2016-01-22 10:15:45,801 DEBUG : BROWSER_OUTPUT: 10:15:48 INFO - 2016-01-22 10:15:48,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36942/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:48 INFO - 2016-01-22 10:15:48,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 168333312 10:15:48 INFO - 2016-01-22 10:15:48,817 DEBUG : BROWSER_OUTPUT: 10:15:51 INFO - 2016-01-22 10:15:51,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36942/tests/kraken/driver.html?testName=audio-dft) 10:15:51 INFO - 2016-01-22 10:15:51,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 167440384 10:15:51 INFO - 2016-01-22 10:15:51,942 DEBUG : BROWSER_OUTPUT: 10:15:54 INFO - 2016-01-22 10:15:54,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36942/tests/kraken/driver.html?testName=audio-fft) 10:15:55 INFO - 2016-01-22 10:15:55,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 164528128 10:15:55 INFO - 2016-01-22 10:15:55,313 DEBUG : BROWSER_OUTPUT: 10:15:57 INFO - 2016-01-22 10:15:57,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36942/tests/kraken/driver.html?testName=audio-oscillator) 10:15:57 INFO - 2016-01-22 10:15:57,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 163803136 10:15:57 INFO - 2016-01-22 10:15:57,879 DEBUG : BROWSER_OUTPUT: 10:16:00 INFO - 2016-01-22 10:16:00,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:00 INFO - 2016-01-22 10:16:00,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 163631104 10:16:00 INFO - 2016-01-22 10:16:00,628 DEBUG : BROWSER_OUTPUT: 10:16:03 INFO - 2016-01-22 10:16:03,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36942/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:04 INFO - 2016-01-22 10:16:04,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 162729984 10:16:04 INFO - 2016-01-22 10:16:04,085 DEBUG : BROWSER_OUTPUT: 10:16:07 INFO - 2016-01-22 10:16:07,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36942/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:07 INFO - 2016-01-22 10:16:07,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 164913152 10:16:07 INFO - 2016-01-22 10:16:07,989 DEBUG : BROWSER_OUTPUT: 10:16:10 INFO - 2016-01-22 10:16:10,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36942/tests/kraken/driver.html?testName=json-parse-financial) 10:16:11 INFO - 2016-01-22 10:16:11,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 163561472 10:16:11 INFO - 2016-01-22 10:16:11,302 DEBUG : BROWSER_OUTPUT: 10:16:12 INFO - 2016-01-22 10:16:12,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:13 INFO - 2016-01-22 10:16:13,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 171110400 10:16:13 INFO - 2016-01-22 10:16:13,385 DEBUG : BROWSER_OUTPUT: 10:16:15 INFO - 2016-01-22 10:16:15,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:15 INFO - 2016-01-22 10:16:15,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 169127936 10:16:15 INFO - 2016-01-22 10:16:15,727 DEBUG : BROWSER_OUTPUT: 10:16:17 INFO - 2016-01-22 10:16:17,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:18 INFO - 2016-01-22 10:16:18,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 175423488 10:16:18 INFO - 2016-01-22 10:16:18,273 DEBUG : BROWSER_OUTPUT: 10:16:20 INFO - 2016-01-22 10:16:20,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:21 INFO - 2016-01-22 10:16:21,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 181882880 10:16:21 INFO - 2016-01-22 10:16:21,188 DEBUG : BROWSER_OUTPUT: 10:16:23 INFO - 2016-01-22 10:16:23,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:24 INFO - 2016-01-22 10:16:24,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 181207040 10:16:24 INFO - 2016-01-22 10:16:24,209 DEBUG : BROWSER_OUTPUT: 10:16:25 INFO - 2016-01-22 10:16:25,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36942/tests/kraken/driver.html?testName=ai-astar) 10:16:26 INFO - 2016-01-22 10:16:26,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 238522368 10:16:26 INFO - 2016-01-22 10:16:26,113 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,114 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:16:26 INFO - 2016-01-22 10:16:26,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:16:26 INFO - 2016-01-22 10:16:26,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:16:26 INFO - 2016-01-22 10:16:26,114 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:16:26 INFO - 2016-01-22 10:16:26,114 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;103;108;110;108;98;109;109;109 10:16:26 INFO - 2016-01-22 10:16:26,115 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;130;153;154;125;148;144;122;161;123 10:16:26 INFO - 2016-01-22 10:16:26,115 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;161;159;159;160;164;160;162 10:16:26 INFO - 2016-01-22 10:16:26,115 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;157;72;71;72;71;150;73 10:16:26 INFO - 2016-01-22 10:16:26,115 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;139;92;93;91;141;91;92;131 10:16:26 INFO - 2016-01-22 10:16:26,116 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;112;109;109;109;110;109 10:16:26 INFO - 2016-01-22 10:16:26,116 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;145;146;147;146;145;146;144 10:16:26 INFO - 2016-01-22 10:16:26,116 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 10:16:26 INFO - 2016-01-22 10:16:26,116 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;58;57;56;55;55;56;56;54;55 10:16:26 INFO - 2016-01-22 10:16:26,116 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;65;65;65;64;64;64;65;65 10:16:26 INFO - 2016-01-22 10:16:26,117 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;80;80;79;79;80;79;81;80;80 10:16:26 INFO - 2016-01-22 10:16:26,117 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;110;117;115;107;117;117;110;116;116 10:16:26 INFO - 2016-01-22 10:16:26,117 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;154;143;136;139;131;141;141;138;139 10:16:26 INFO - 2016-01-22 10:16:26,117 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;65;64;64;63;65;63;66;64 10:16:26 INFO - 2016-01-22 10:16:26,118 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:16:26 INFO - 2016-01-22 10:16:26,118 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:16:26 INFO - 2016-01-22 10:16:26,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,918 10:16:26 INFO - 2016-01-22 10:16:26,118 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:16:26 INFO - 2016-01-22 10:16:26,118 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486586110__endTimestamp 10:16:26 INFO - 2016-01-22 10:16:26,119 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,120 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:16:26 INFO - 2016-01-22 10:16:26,120 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:16:26 INFO - 2016-01-22 10:16:26,121 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,121 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:3.73 (3.4%) stddev-sans-first:3.94 10:16:26 INFO - 2016-01-22 10:16:26,121 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 103.0 108.0 110.0 108.0 98.0 109.0 109.0 109.0 10:16:26 INFO - 2016-01-22 10:16:26,121 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,122 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:146.50 stddev:14.32 (9.8%) stddev-sans-first:15.10 10:16:26 INFO - 2016-01-22 10:16:26,122 DEBUG : BROWSER_OUTPUT: Values: 145.0 130.0 153.0 154.0 125.0 148.0 144.0 122.0 161.0 123.0 10:16:26 INFO - 2016-01-22 10:16:26,122 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,123 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 10:16:26 INFO - 2016-01-22 10:16:26,123 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 161.0 159.0 159.0 160.0 164.0 160.0 162.0 10:16:26 INFO - 2016-01-22 10:16:26,123 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,123 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.50 Median:72.50 stddev:34.31 (47.3%) stddev-sans-first:35.93 10:16:26 INFO - 2016-01-22 10:16:26,123 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 157.0 72.0 71.0 72.0 71.0 150.0 73.0 10:16:26 INFO - 2016-01-22 10:16:26,123 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:92.00 stddev:21.96 (23.9%) stddev-sans-first:22.75 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 139.0 92.0 93.0 91.0 141.0 91.0 92.0 131.0 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 112.0 109.0 109.0 109.0 110.0 109.0 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 10:16:26 INFO - 2016-01-22 10:16:26,124 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 145.0 146.0 147.0 146.0 145.0 146.0 144.0 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.20 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: Values: 54.0 58.0 57.0 56.0 55.0 55.0 56.0 56.0 54.0 55.0 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,125 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 65.0 65.0 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: Values: 79.0 80.0 80.0 79.0 79.0 80.0 79.0 81.0 80.0 80.0 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:116.50 stddev:4.42 (3.8%) stddev-sans-first:3.82 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: Values: 122.0 110.0 117.0 115.0 107.0 117.0 117.0 110.0 116.0 116.0 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.40 Median:141.00 stddev:5.89 (4.2%) stddev-sans-first:6.22 10:16:26 INFO - 2016-01-22 10:16:26,126 DEBUG : BROWSER_OUTPUT: Values: 142.0 154.0 143.0 136.0 139.0 131.0 141.0 141.0 138.0 139.0 10:16:26 INFO - 2016-01-22 10:16:26,127 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,127 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 10:16:26 INFO - 2016-01-22 10:16:26,127 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 65.0 64.0 64.0 63.0 65.0 63.0 66.0 64.0 10:16:26 INFO - 2016-01-22 10:16:26,127 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:16:26 INFO - 2016-01-22 10:16:26,127 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,915 INFO : Browser exited with error code: 0 10:16:26 INFO - 2016-01-22 10:16:26,965 INFO : Completed test kraken (00:00:58) 10:16:26 INFO - 2016-01-22 10:16:26,965 INFO : Starting test v8_7 10:16:26 INFO - 2016-01-22 10:16:26,965 DEBUG : operating with platform_type : linux_ 10:16:26 INFO - 2016-01-22 10:16:26,966 INFO : Initialising browser for v8_7 test... 10:16:26 INFO - 2016-01-22 10:16:26,972 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgBaTg7/profile http://localhost:36942/getInfo.html 10:16:31 INFO - 2016-01-22 10:16:31,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:16:31 INFO - 2016-01-22 10:16:31,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:16:31 INFO - 2016-01-22 10:16:31,139 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:16:31 INFO - 2016-01-22 10:16:31,139 DEBUG : BROWSER_OUTPUT: __metrics 10:16:31 INFO - 2016-01-22 10:16:31,303 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:32 INFO - 2016-01-22 10:16:32,091 INFO : Browser initialized. 10:16:32 INFO - 2016-01-22 10:16:32,092 INFO : Running cycle 1/1 for v8_7 test... 10:16:32 INFO - 2016-01-22 10:16:32,092 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgBaTg7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:16:43 INFO - 2016-01-22 10:16:43,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 136990720 10:16:43 INFO - 2016-01-22 10:16:43,875 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36942/tests/v8_7/run.html (next: http://localhost:36942/tests/v8_7/run.html) 10:17:05 INFO - 2016-01-22 10:17:05,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 420249600 10:17:05 INFO - 2016-01-22 10:17:05,516 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,518 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:05 INFO - 2016-01-22 10:17:05,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:05 INFO - 2016-01-22 10:17:05,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:05 INFO - 2016-01-22 10:17:05,518 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:05 INFO - 2016-01-22 10:17:05,518 DEBUG : BROWSER_OUTPUT: |0;Richards;165.18004625041294 10:17:05 INFO - 2016-01-22 10:17:05,518 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.80110592707794 10:17:05 INFO - 2016-01-22 10:17:05,519 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 10:17:05 INFO - 2016-01-22 10:17:05,519 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:17:05 INFO - 2016-01-22 10:17:05,519 DEBUG : BROWSER_OUTPUT: |4;RayTrace;957.8544061302682 10:17:05 INFO - 2016-01-22 10:17:05,519 DEBUG : BROWSER_OUTPUT: |5;Earley;561.7977528089888 10:17:05 INFO - 2016-01-22 10:17:05,519 DEBUG : BROWSER_OUTPUT: |6;Boyer;10892.47311827957 10:17:05 INFO - 2016-01-22 10:17:05,519 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 10:17:05 INFO - 2016-01-22 10:17:05,520 DEBUG : BROWSER_OUTPUT: |8;Splay;516.2454873646209 10:17:05 INFO - 2016-01-22 10:17:05,520 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 10:17:05 INFO - 2016-01-22 10:17:05,520 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:05 INFO - 2016-01-22 10:17:05,520 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486625516__endTimestamp 10:17:05 INFO - 2016-01-22 10:17:05,520 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,521 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:05 INFO - 2016-01-22 10:17:05,521 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:17:05 INFO - 2016-01-22 10:17:05,521 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,521 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.18 Median:165.18 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,521 DEBUG : BROWSER_OUTPUT: Values: 165.2 10:17:05 INFO - 2016-01-22 10:17:05,521 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,522 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.80 Median:172.80 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,522 DEBUG : BROWSER_OUTPUT: Values: 172.8 10:17:05 INFO - 2016-01-22 10:17:05,522 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,522 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,522 DEBUG : BROWSER_OUTPUT: Values: 279.1 10:17:05 INFO - 2016-01-22 10:17:05,523 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,523 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,523 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:17:05 INFO - 2016-01-22 10:17:05,523 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,523 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: Values: 957.9 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:561.80 Median:561.80 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: Values: 561.8 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10892.47 Median:10892.47 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,525 DEBUG : BROWSER_OUTPUT: Values: 10892.5 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: Values: 26153.8 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.25 Median:516.25 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: Values: 516.2 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2016-01-22 10:17:05,526 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:17:05 INFO - 2016-01-22 10:17:05,527 DEBUG : BROWSER_OUTPUT: Values: 4826.9 10:17:05 INFO - 2016-01-22 10:17:05,527 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:05 INFO - 2016-01-22 10:17:05,527 DEBUG : BROWSER_OUTPUT: 10:17:06 INFO - 2016-01-22 10:17:06,355 INFO : Browser exited with error code: 0 10:17:06 INFO - 2016-01-22 10:17:06,372 INFO : Completed test v8_7 (00:00:39) 10:17:06 INFO - 2016-01-22 10:17:06,533 INFO : Completed test suite (00:20:09) 10:17:06 INFO - 2016-01-22 10:17:06,533 DEBUG : Working with test: dromaeo_css 10:17:06 INFO - 2016-01-22 10:17:06,534 DEBUG : Generating results file: dromaeo_css 10:17:06 INFO - 2016-01-22 10:17:06,535 DEBUG : Working with test: kraken 10:17:06 INFO - 2016-01-22 10:17:06,535 DEBUG : Generating results file: kraken 10:17:06 INFO - 2016-01-22 10:17:06,535 INFO : javascript benchmark 10:17:06 INFO - 2016-01-22 10:17:06,535 DEBUG : Working with test: v8_7 10:17:06 INFO - 2016-01-22 10:17:06,535 DEBUG : Generating results file: v8_7 10:17:06 INFO - 2016-01-22 10:17:06,536 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:06 INFO - 2016-01-22 10:17:06,589 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 10:17:06 INFO - 2016-01-22 10:17:06,589 DEBUG : process_Request line: dromaeo_css 7368.17 graph.html#tests=[[72,52,35]] 10:17:06 INFO - 2016-01-22 10:17:06,589 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:06 INFO - 2016-01-22 10:17:06,626 DEBUG : process_Request line: kraken 1471.80 graph.html#tests=[[232,52,35]] 10:17:06 INFO - 2016-01-22 10:17:06,626 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:06 INFO - 2016-01-22 10:17:06,664 DEBUG : process_Request line: v8_7 22890.66 graph.html#tests=[[230,52,35]] 10:17:06 INFO - 2016-01-22 10:17:06,666 INFO : javascript benchmark 10:17:06 INFO - 2016-01-22 10:17:06,669 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3292.4402851515247, 3351.6815902489284, 3375.9156021099484, 3386.0180547641185, 3405.642407547207, 5536.3909969903325, 5540.667559946401, 5545.140503221997, 5560.582956278286, 5570.805021824237, 5530.5022547970675, 5545.0, 5561.4716601922855, 5563.527100196478, 5568.331800183983, 4866.172750632383, 5010.348654674887, 5018.824341148061, 5032.19484882418, 5094.337736094321, 5004.524570165847, 5070.670406423571, 5071.290019397287, 5076.746162691869, 5084.44071152173, 4951.133551628469, 4975.975120124413, 5069.239614057902, 5099.643024988252, 5114.181730923053, 5102.744862756866, 5158.303629010074, 5159.587233021387, 5164.431912489605, 5187.636865419422, 4823.252395878644, 5056.241563765428, 5061.139606266906, 5110.463401342842, 5139.357580302462, 5211.478852114758, 5267.0, 5272.182811664198, 5292.073887069748, 5360.865978350534, 5992.910106348409, 6012.458878700894, 6042.425969532887, 6044.546659000593, 6060.000099983497, 5888.175655408247, 5979.01346277868, 6077.20996270482, 6079.756809727605, 6088.908666370008, 5448.727563621843, 5527.640703354309, 5537.584681148849, 5547.8890422191735, 5572.7770889164385, 6053.213082299273, 6103.572749907464, 6106.114613381035, 6109.083637454329, 6115.449609535163, 5735.598508104393, 5742.971285143548, 5887.911681324784, 5908.231929849092, 5921.763129474859, 5960.4635582797755, 6020.879582408327, 6038.849028774316, 6042.6978651067275, 6045.3652366501765, 5941.494972927263, 5979.521638268928, 5981.0, 5986.580939334205, 5990.221271234712, 5736.5123964462655, 5795.623284486495, 5858.443447872445, 5987.191729116514, 5993.400659933972, 4583.289590113538, 4584.977075114603, 4585.060062687141, 4589.518100599389, 4611.146937816515, 4126.958730412657, 4139.254934111828, 4142.730722503088, 4143.1713657268665, 4157.355609880473, 5502.009638265071, 5582.385937546866, 5590.8043218487155, 5717.056685646905, 5754.4533269339345, 6001.969990150109, 6006.519478441714, 6031.577789554777, 6036.215292012011, 6044.697765111727, 5694.686792226385, 5705.600607957404, 5705.686187259741, 5711.8000869969355, 5716.828495145152, 5029.119904016782, 5080.339555857789, 5127.589792816566, 5203.5576975957465, 5210.921836172461, 6051.0, 6055.697215139226, 6064.181335519736, 6075.27096748393, 6154.107654390178, 5907.3797251288, 5955.225820643289, 5962.791302304398, 5965.433283838029, 5973.074173503114, 5957.553183511167, 5993.9700301498215, 6045.425684559959, 6079.817605471843, 6103.260680208552, 5909.084091965752, 5925.229720136354, 5942.970285148546, 5952.553558483044, 5960.195373624505, 5766.769329226784, 6025.035994241076, 6029.216201893726, 6030.30651475086, 6049.0, 5741.3971532988435, 5799.797007104731, 5891.263592050994, 5897.085951677497, 5920.555958303231, 5812.21535092757, 5817.76728930838, 5819.359870414166, 5833.766649333979, 5838.1826544282985, 5610.747516361856, 5672.631278966854, 5728.742206600629, 5739.05305624584, 5751.597388182954, 5755.65466072037, 5758.62568933018, 5839.912401314069, 5867.647941123546, 5871.588988770745, 5725.456081672234, 5754.424557544379, 5768.7404066817935, 5772.624779389326, 5772.682502462405], "unit": "ms", "name": "dojo.html", "value": 5494.397290538022}, {"lowerIsBetter": false, "replicates": [614.8278482025034, 626.2735227136523, 634.3434545245668, 638.7317326722776, 640.3532432243436, 31195.99999999997, 38265.617343826554, 38992.41511377325, 39008.21983560327, 39020.219595608105, 45392.77303613477, 45958.770206148925, 46065.7696711516, 46077.0, 46128.308075378896, 7936.325412339958, 8037.035555733291, 9122.817543649124, 9314.906850931506, 9322.673706420243, 10931.726706832353, 11126.6105686301, 11189.944050279737, 11194.440277986108, 11194.440277986108, 10833.729156771065, 10962.397068161248, 10969.780604387908, 10971.725706857353, 10972.561097556088, 8182.877256841152, 8322.375821813328, 10810.513526891269, 10843.07833834125, 10923.453827308642, 10588.841167382496, 10725.570977160904, 10746.838797418044, 10747.355158690425, 10755.623553175601, 42680.0, 42782.0, 42940.785296073635, 43029.0, 43100.784496077635, 3597.4603809428795, 3630.7276954228537, 3738.775673459601, 3974.721769476138, 4279.422277992493, 32627.347453050807, 32838.0, 33124.503132453036, 33253.66746332554, 33744.49383259253, 3514.2971405718704, 3525.6029464179605, 3539.7876127432437, 3580.856765729394, 3625.474306225609, 287972.0, 289211.0, 290437.5478122617, 290466.0, 290634.0, 59048.40951590515, 59547.0, 66112.66943665346, 66675.0, 66686.0, 76619.61690191625, 77026.6148669253, 77669.61165194251, 77787.0, 77841.0, 17037.233324500427, 17319.826801732073, 17348.30606775715, 17351.65296694059, 17356.3057477702, 12874.935625322001, 12921.741565168644, 12922.612321630366, 12947.417366218542, 12955.481780728665, 21879.781202188093, 21934.122635094416, 21941.670874936888, 22054.448638784157, 22167.556648866932, 7564.319211271012, 7771.4559980800805, 7822.960885195537, 7871.212878712083, 7983.84032319362, 1009.5709323537467, 1060.671191930504, 1061.368485750977, 1134.546181527379, 1159.7912375772441, 29771.722242141936, 30372.392552148835, 30603.0, 30718.232044199074, 30818.53772193419, 1014.624588902111, 1051.51104736298, 1058.9364638121738, 1161.7618388230392, 1200.0879331707965, 13887.58337249884, 15165.620859478602, 16645.83354166467, 16727.91636041812, 16921.153942302837, 287169.0, 292363.0, 292996.0, 293134.0, 293447.0, 60623.66569838701, 61177.694111529156, 61190.0, 61214.69392653008, 61330.69334653387, 1454.3237394611556, 1468.1338010573813, 1470.6102882736084, 1476.6825132596543, 1503.5639664497173, 31924.6807531931, 32828.67171328256, 35043.82478087593, 35194.47208291826, 35653.82173089222, 55627.16559251533, 56277.71861140668, 56318.0, 56407.71796140993, 56463.0, 321769.0, 323743.0, 325314.0, 325453.0, 325655.0, 30575.388492230475, 30855.845720771253, 31170.376592468478, 32762.34475310528, 36234.637653623126, 42243.7887810559, 51843.222351664, 53857.0, 55883.0, 57242.14136788035, 38404.23191536209, 38866.61133388743, 38987.80506097451, 39203.0, 39740.40389394104, 40124.598754012084, 40580.797096015514, 40721.1855762889, 41122.794386029076, 43575.56424435715, 38905.41641875318, 39044.0, 40142.397864032646, 40835.38746918858, 41106.588934110274, 38237.808810955765, 39808.80095599504, 40025.0, 42504.57495425006, 44503.0, 32663.510047348835, 32850.1787455306, 32924.50613240755, 33229.0, 33391.165220869676], "unit": "ms", "name": "ext.html", "value": 20538.92882372023}, {"lowerIsBetter": false, "replicates": [384.2046962787032, 387.4208058951867, 388.8683929764386, 389.4975481628699, 391.2741863842572, 15027.398904043825, 15680.764788528153, 17139.742903856437, 18604.0, 18613.4415967521, 17484.21321040553, 17543.473695789115, 17581.7362739559, 17780.91109544454, 18175.182116804743, 6050.152978582991, 6178.41305076017, 6187.102870083858, 6192.721327540249, 6193.040078787795, 4492.932606010912, 4612.400387949562, 4623.283391074372, 4623.630109591241, 6114.144019837204, 6709.396154346108, 6728.4953628477815, 6914.066601008875, 6930.688119034656, 6931.514793964425, 6809.387155156035, 6854.554453960502, 6855.931440685604, 6858.3141685831015, 6861.451083913275, 6413.230412350548, 6541.182352205974, 6551.312112228243, 6556.114924485229, 6559.409653131193, 22367.440813979618, 22960.19639312616, 23060.884695576584, 23068.307950761504, 23511.76488235113, 2225.922092726747, 2424.684790977179, 2451.3748994006414, 2458.6066229403386, 2556.693196816394, 9808.607655693835, 10100.747481312952, 10293.228007899437, 14823.555293341216, 15344.309506072253, 1933.835623971964, 1943.5918457124021, 1953.082051435823, 1971.2903354792263, 1999.4701404127918, 54448.72775636136, 56311.71844140753, 56960.43039569593, 57216.0, 57549.84900302012, 10829.24195306321, 10852.82943411321, 10894.346339219672, 10958.890411095947, 11034.503447344889, 14484.493042743454, 14592.708145837023, 14623.488177913721, 14631.780523292158, 14632.853671463363, 7858.371330293563, 7908.367330613537, 7939.28546430824, 7953.8409231816195, 7983.161768014391, 7565.924340756522, 7575.810604734816, 7596.924030759732, 7656.081270247606, 7660.923390766021, 4824.807007719722, 4831.396075490564, 4839.249916262985, 4857.198562237191, 4893.681910675795, 1779.9313703251544, 1816.5549440386926, 1873.2226126157764, 1954.3159894036974, 1956.790862984706, 959.1703176752059, 969.3021024862088, 1001.2875111419262, 1060.2889885401096, 1110.7500812317164, 17098.125249301906, 17271.222794974256, 17446.47660570185, 17560.38538651141, 18038.90980545089, 918.8851393575803, 951.4291425144996, 1008.5108722269694, 1038.7195457226658, 1066.7173199102244, 9374.812503749887, 10010.749731256778, 10244.078032976919, 10268.0, 10315.535800888978, 664596.0, 670923.0, 683046.0, 699227.0, 721008.0, 85552.0, 87001.0, 87242.0, 88136.1186388128, 89132.5543372292, 1247.3513772838073, 1258.6224132760135, 1258.779713550125, 1260.3446207971804, 1267.3283159925254, 16545.66908661844, 16592.42209280418, 16605.50183494497, 16704.0, 16811.0, 35402.0, 38509.037274068374, 38639.0, 38809.61190388173, 38889.222215556096, 41129.38305925473, 43398.0, 43713.34429983489, 44120.0, 45897.0, 9968.40189588627, 10123.898761012295, 10153.441560713936, 10238.846417303597, 10261.74345641365, 15827.0, 17642.73535896937, 17747.55631109181, 18113.36603218881, 18152.90923545374, 15041.623959401102, 15042.398304067714, 15180.696386071995, 15729.764053539435, 16268.105254211132, 15210.239488025776, 15507.689846202788, 15720.76418853741, 15970.361185552449, 16199.271032803788, 12956.870431295567, 13000.154989925624, 13078.738425231251, 15131.773023404437, 15143.469978550698, 9634.470104144339, 9777.071178238057, 9805.656802011896, 10311.381317120997, 10327.535260913428, 14304.070235434663, 14470.059446135967, 14476.841852651973, 15283.46507872219, 15341.232938352814], "unit": "ms", "name": "jquery.html", "value": 9602.92448770138}, {"lowerIsBetter": false, "replicates": [1100.873399559051, 1571.6070982254437, 1580.968380632388, 1800.4958611588754, 1814.7912990006153, 7157.4989750717405, 7802.804929876749, 7970.840583188333, 7978.720744773941, 7984.441089123764, 7989.440739148262, 7993.800154996114, 8053.0, 8057.073436554798, 8063.1130575636635, 2030.6649402848586, 2064.133064113076, 2375.7386687464364, 2412.8552286862755, 2413.6017557103055, 2382.0, 2423.442608200115, 2431.197704757426, 2431.9392015199583, 2432.063655492639, 2326.604477238865, 2332.1604222479978, 2383.30884043628, 2383.9868056076184, 2386.6300723387817, 2340.9882950585225, 2360.8701521416315, 2365.8698771567556, 2377.8454400464, 2400.903963841453, 2375.1449478187837, 2378.9643155352683, 2393.1863166523467, 2424.823960379215, 2437.4515733959893, 8010.599470026534, 8070.031596208434, 8072.475289106189, 8081.5555144467035, 8091.19088091192, 4848.2727590861305, 5025.798968041274, 5027.798888044474, 5030.698158110525, 5035.697858128524, 3122.8126312421327, 3136.247300647851, 3189.0751682012187, 3246.7402607791555, 3261.5107733839877, 1020.2399212586596, 1033.0444338986408, 1033.2405681823852, 1045.592219034577, 1065.6856227412932, 10812.297200681931, 10859.0, 10863.348199108079, 10865.5110520026, 10871.782564348669, 4534.274516077412, 4611.216093264153, 4694.694844835075, 4737.857864264078, 4738.31294462308, 9262.351635385594, 9267.629294828266, 9303.674371396968, 9308.581113849757, 9309.0, 5088.745562721849, 5096.643234973516, 5220.556252718561, 5221.981713565819, 5226.216067589892, 4706.458757242893, 4746.738929358849, 4752.477227504972, 4756.381670382828, 4758.5241475852135, 3459.775114617542, 3489.668481494254, 3982.3628219484744, 4081.428599996003, 4092.07928216149, 1298.8246586710861, 1305.4908585651604, 1306.784380577194, 1320.570814485296, 1337.5118081900036, 1105.4638500327335, 1108.9611863584735, 1114.2812885688686, 1315.8289422375221, 1415.1721243072711, 7740.109887363025, 7807.492512986638, 7808.882866757003, 7830.0, 7901.209879012053, 1167.626359564948, 1169.2925779903205, 1169.368540987874, 1177.4936777185721, 1179.0920990837008, 6093.238345206849, 6169.660668663177, 6202.069689546604, 6203.16257305267, 6211.9689401552705, 9443.811123777487, 9712.465814380277, 9757.707268781947, 9860.45767482781, 9865.852012219822, 9649.662261820802, 9668.323217374857, 9768.51157442125, 9777.560009799576, 9784.266180036526, 7257.2742725727, 7341.77974660761, 7409.962950185322, 7429.145648250413, 7433.959245705605, 7367.77896663101, 7622.2758837910305, 7667.11828139771, 7669.424793140425, 7691.461597688108, 8494.193051660082, 8647.394682372174, 8781.824363512822, 8903.465792052497, 8922.73231803047, 8377.790555235924, 8560.272376848037, 8723.694670686495, 8738.082501337269, 9143.497107659143, 7339.119305683352, 7417.666205020679, 7440.921066445227, 7441.181470038399, 7446.367058800062, 7190.245024272376, 7306.415486761152, 7756.185600512091, 7932.04815422153, 8015.078265999485, 7493.587852667937, 7513.2111128330735, 7523.398128149625, 7546.358559522502, 7594.582297973444, 7339.229380914927, 7391.6304184791625, 7414.962925185339, 7443.590602516913, 7509.436792240713, 6974.093367862349, 7051.964740176266, 7095.893561596684, 7112.35988761014, 7494.887576686463, 6797.864042719019, 6842.623655698984, 6843.076184715, 6845.178578570603, 6846.726130954905, 6780.355866192704, 6932.0988271524375, 6955.408790252885, 6977.546459480118, 6978.057962175041], "unit": "ms", "name": "mootools.html", "value": 4707.927127295229}, {"lowerIsBetter": false, "replicates": [340.5283682100291, 343.4539082858255, 344.5400390478712, 347.3105884818635, 347.66971377191675, 6106.572539922202, 6111.0, 6153.661548614825, 6170.47550958168, 6177.598456100351, 5813.73838177282, 5919.704014799265, 5996.730147143378, 6081.878362432749, 6105.603135796181, 4633.0, 4696.953030469703, 4699.647526435514, 4702.365180700613, 4706.62347012239, 4686.156491831469, 4688.132695451352, 4699.577038066574, 4706.247000479924, 4707.90584188316, 4405.581469760367, 4478.507364189936, 4552.430946131733, 4591.311303304497, 4593.173228818811, 4593.104344652794, 4596.839110631146, 4623.5838774510285, 4644.558766917137, 4657.743824089674, 4082.265192265391, 4091.713580049398, 4092.8362865485346, 4096.262672718909, 4108.5275193352545, 5796.8840623187725, 5802.62282951611, 5811.912821307684, 5812.651240925558, 5822.592418530705, 5240.9475905241225, 5377.838664840061, 5415.783368665288, 5417.756200970965, 5421.566274698014, 6478.514111441661, 6480.0, 6480.222373315232, 6485.092087107809, 6485.578437401554, 4483.30508771141, 4483.910321793546, 4485.035717320791, 4485.932711009337, 4488.371627972087, 6628.3371662833815, 6705.832354191136, 6762.560433571802, 6764.188297404294, 6765.560238584476, 4589.885252868638, 4589.908201835945, 4591.770411479412, 4595.37962375075, 4597.379353787196, 4635.049814787961, 4647.721136731807, 4648.790804413809, 4648.814047438133, 4654.069186162781, 5385.0037743017665, 5387.218853266333, 5387.3804512481565, 5390.0, 5393.2179833923865, 6319.368063193644, 6482.12491313676, 6506.089147519351, 6514.967425162844, 6554.967225163844, 1648.077076836975, 1660.0, 1661.028298445423, 1672.406295764986, 1677.865770738338, 1121.6018313498753, 1125.3248051169396, 1133.444612140062, 1139.5840518210794, 1155.572438197872, 6333.20834895638, 6383.39357761012, 6391.42477177047, 6399.456046236029, 6402.35976402356, 6790.864182716318, 6791.4906382021545, 6791.966040169867, 6796.76211332601, 6798.966005169942, 6193.566450348522, 6313.526485513513, 6348.587341822767, 6427.421532062043, 6449.258335291408, 3652.8356223969986, 3673.7612055216327, 3680.4847321375028, 3681.5582130144016, 3682.116292089879, 6839.076724642209, 6844.691988860413, 6849.315068493211, 6855.211650660138, 6864.107666003388, 6827.863442731117, 6987.091678081817, 6987.510874238755, 6993.860122797516, 7011.053507776487, 6973.79078627642, 6998.405135563534, 7000.684969176399, 7001.92998070023, 7008.22909479967, 6706.731730730716, 6821.727130914708, 6827.93172068273, 6829.556078854858, 6831.4876384272375, 6626.370494802986, 6629.403353698191, 6631.734730610721, 6633.436157926631, 6637.70130344126, 6945.305469453015, 6991.091158149408, 6991.615461149686, 6994.790156295319, 7002.929970700227, 4738.384010078667, 4738.834140805193, 4742.336072949859, 4751.691140075884, 4770.0936822003705, 6638.20341559016, 6732.932670673231, 6766.323367663194, 6776.7628133015105, 6797.1843378794865, 6588.7364505421165, 6602.966985165043, 6603.141591593062, 6616.172978377703, 6617.371349721769, 6393.520485963479, 6588.275289718223, 6591.835204119935, 6596.8350791230605, 6603.240627327918, 6449.6130232186215, 6513.8697226056165, 6519.771807986698, 6522.15212022434, 6528.281888992302, 6563.442107420923, 6569.737210511526, 6606.47148228131, 6613.503987200883, 6638.734450622114, 6320.462760665395, 6431.163948686641, 6469.417752402306, 6473.449756770728, 6478.190226221723], "unit": "ms", "name": "prototype.html", "value": 4923.917130807478}, {"lowerIsBetter": false, "replicates": [787.6180052674456, 829.6100832608673, 846.4794151596766, 855.1234984141255, 856.0626114404724, 13602.727945441098, 13898.722025559495, 13915.582532524015, 13916.93041534791, 13924.443022279096, 12561.057920655965, 12568.937155314234, 12569.0, 12588.559400420963, 12623.558175463837, 756.3042001358763, 758.0713625808369, 886.4769785826361, 894.3247847874845, 902.1700035966926, 898.6225785170211, 904.7150147703485, 905.2034209895315, 908.0737647599444, 923.3674932671141, 939.9577019034126, 940.0223767282018, 940.4827344960279, 941.7410212191634, 953.2945620241042, 782.2763943352405, 790.2808444315674, 948.1608776233014, 953.1469334945219, 956.7082039977804, 702.5819637315789, 702.9051078104442, 703.6024646074951, 710.2861624067831, 723.6381809095452, 13943.58169254924, 14164.29178541079, 14172.716545669029, 14173.78739318911, 14184.503542376071, 11833.644990650208, 11939.820902686466, 12145.02839772816, 12526.248425094524, 12731.872681273162, 10482.895171048269, 10774.892251077546, 10792.892071079266, 10889.891101088966, 10951.83572246417, 3923.8430462781453, 3954.4859168307935, 3962.484876965976, 3967.4247234151176, 3968.5634580196156, 49554.00891982176, 50216.74891625555, 50465.0, 50782.238266425666, 51057.74471127658, 9697.6605818796, 9835.901640983642, 10054.095131438205, 10070.949645251727, 10095.798084038279, 17019.48941531756, 17031.063291518836, 17040.233189506504, 17042.914785425994, 17065.658686826442, 7268.0, 7336.669849856769, 7442.776716698508, 7487.962560187164, 7516.285952834472, 4511.278195488706, 4557.886052848639, 4566.931496027562, 4595.0, 4653.069386122789, 3049.725524702743, 3060.586820779211, 3071.2475443516037, 3075.138961090898, 3090.7681923855803, 563.605476166685, 567.3532173322416, 568.5934556791914, 570.5179123640518, 585.2596465471182, 515.101148495877, 517.6945602094783, 551.7985935133728, 617.7405489694339, 647.2718192033961, 8072.0, 8523.360747943929, 8549.957250213709, 8867.157620026088, 8912.0, 446.4218836606602, 556.3129535024242, 569.2201683693366, 661.4311691944923, 685.6092027544252, 3900.804959752001, 3903.8243279052513, 4116.608922152391, 4317.978410107929, 4329.0, 57885.710571447715, 58482.707586461795, 58721.0, 58815.0, 59216.70391648014, 51716.48283517192, 52705.0, 53186.46813531815, 53729.462705373226, 53802.0, 48017.27974080392, 48041.519584803704, 48250.75874620605, 48464.7576762114, 49421.50578494169, 8585.570721463777, 8593.570321484025, 8701.564921753761, 8920.509371984344, 8940.418872773249, 34868.9539313821, 35719.28561428809, 36215.637843621225, 36841.63158368382, 36893.44659830158, 45273.094538108395, 45406.31890521579, 45417.31874021826, 45740.54259457496, 46378.53621463877, 10222.897771022195, 10237.436940968319, 10415.270931034755, 10649.467526623794, 10871.402072886067, 11001.1749118818, 11223.0, 11299.37853418037, 11398.658040258806, 11546.653600392001, 10850.186236032487, 10872.347659140476, 11043.282186657842, 11184.608538701106, 11378.0, 10573.577056917944, 10736.409497477714, 10742.248042637253, 10760.46197690128, 10917.290376125844, 9634.470104144339, 10790.784184316426, 10958.780824383628, 10996.06533444634, 11228.719282017688, 8176.754697359089, 9632.084951929835, 9674.177694896012, 9867.802643947225, 10127.088562029452, 9417.387869788441, 9676.080772326617, 9863.901360986298, 9876.851847222153, 9885.456299903575], "unit": "ms", "name": "yui.html", "value": 6369.044830219513}], "name": "dromaeo_css", "value": 7368.166321865999}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 103.0, 108.0, 110.0, 108.0, 98.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [145.0, 130.0, 153.0, 154.0, 125.0, 148.0, 144.0, 122.0, 161.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 159.0, 159.0, 160.0, 164.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 157.0, 72.0, 71.0, 72.0, 71.0, 150.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 139.0, 92.0, 93.0, 91.0, 141.0, 91.0, 92.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 112.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 57.0, 56.0, 55.0, 55.0, 56.0, 56.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 80.0, 79.0, 79.0, 80.0, 79.0, 81.0, 80.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [122.0, 110.0, 117.0, 115.0, 107.0, 117.0, 117.0, 110.0, 116.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.7}, {"lowerIsBetter": true, "replicates": [142.0, 154.0, 143.0, 136.0, 139.0, 131.0, 141.0, 141.0, 138.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 65.0, 63.0, 66.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.2}], "name": "kraken", "value": 1471.8000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.18004625041294], "unit": "score", "name": "Richards", "value": 213.71830799999998}, {"lowerIsBetter": false, "replicates": [172.80110592707794], "unit": "score", "name": "DeltaBlue", "value": 382.624866}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [957.8544061302682], "unit": "score", "name": "RayTrace", "value": 772.5485159999996}, {"lowerIsBetter": false, "replicates": [561.7977528089888], "unit": "score", "name": "Earley", "value": 1186.3041400000002}, {"lowerIsBetter": false, "replicates": [10892.47311827957], "unit": "score", "name": "Boyer", "value": 61.185645607107574}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [516.2454873646209], "unit": "score", "name": "Splay", "value": 157.85319580419585}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22890.65677511891}]} 10:17:06 INFO - RETURN: dromaeo_css: 7368.17 10:17:06 INFO - RETURN: kraken: 1471.80 10:17:06 INFO - RETURN: v8_7: 22890.66 10:17:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22890.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1471.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7368.17"}}} 10:17:06 INFO - Return code: 0 10:17:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:17:06 INFO - # TBPL SUCCESS # 10:17:06 INFO - Running post-action listener: _resource_record_post_action 10:17:06 INFO - Running post-run listener: _resource_record_post_run 10:17:07 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508141568; Read time: 16; Write time: 621484 10:17:07 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 248590336; Read time: 0; Write time: 357924 10:17:07 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259260416; Read time: 16; Write time: 263540 10:17:07 INFO - Running post-run listener: _upload_blobber_files 10:17:07 INFO - Blob upload gear active. 10:17:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:17:07 INFO - Copying logs to upload dir... 10:17:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.838120 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-22 10:17:07.604114) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:07.608071) ========= 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010139 build_url: 'https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:07.659981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:07.660292) ========= 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=fa44defc139c4ba8574fe040000001db-1453485141.890016-920515791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:07.710856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:17:07.711168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:17:07.711469) ========= ========= Total master_lag: 0.25 =========