builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1453717392.47 results: success (0) buildid: 20160125001712 builduid: 5d8eb007e2de4c2eae63c4ce4fd78a1e revision: ab89c814f1b8a841168de98ac2679a1d66122a06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.474665) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.475327) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.475647) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.511792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.512099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.600486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.600794) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025723 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.667295) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.667598) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.667986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.668344) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 02:23:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.0M=0s 2016-01-25 02:23:12 (63.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098087 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.779137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.779469) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.098385 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.896683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:12.897057) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab89c814f1b8a841168de98ac2679a1d66122a06 --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 ab89c814f1b8a841168de98ac2679a1d66122a06 --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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 02:23:13,024 truncating revision to first 12 chars 2016-01-25 02:23:13,024 Setting DEBUG logging. 2016-01-25 02:23:13,024 attempt 1/10 2016-01-25 02:23:13,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab89c814f1b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 02:23:13,282 unpacking tar archive at: mozilla-aurora-ab89c814f1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:13.477087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:13.477514) ========= echo ab89c814f1b8a841168de98ac2679a1d66122a06 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab89c814f1b8a841168de98ac2679a1d66122a06'] 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab89c814f1b8a841168de98ac2679a1d66122a06 program finished with exit code 0 elapsedTime=0.004022 script_repo_revision: 'ab89c814f1b8a841168de98ac2679a1d66122a06' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:13.529490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:13.529822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:13.540606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-25 02:23:13.540927) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:23:13 INFO - MultiFileLogger online at 20160125 02:23:13 in /builds/slave/test-pgo 02:23:13 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 02:23:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:23:13 INFO - {'append_to_log': False, 02:23:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:23:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:23:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:23:13 INFO - 'branch': 'Mozilla-Aurora', 02:23:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:23:13 INFO - 'config_files': ('talos/linux_config.py',), 02:23:13 INFO - 'default_actions': ('clobber', 02:23:13 INFO - 'read-buildbot-config', 02:23:13 INFO - 'download-and-extract', 02:23:13 INFO - 'populate-webroot', 02:23:13 INFO - 'create-virtualenv', 02:23:13 INFO - 'install', 02:23:13 INFO - 'run-tests'), 02:23:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:23:13 INFO - 'download_minidump_stackwalk': True, 02:23:13 INFO - 'download_symbols': 'ondemand', 02:23:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:23:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:23:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:23:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:23:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:23:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:23:13 INFO - 'installer_path': 'installer.exe', 02:23:13 INFO - 'log_level': 'info', 02:23:13 INFO - 'log_name': 'talos', 02:23:13 INFO - 'log_to_console': True, 02:23:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:23:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:23:13 INFO - 'opt_config_files': (), 02:23:13 INFO - 'pip_index': False, 02:23:13 INFO - 'sps_profile': False, 02:23:13 INFO - 'sps_profile_interval': 0, 02:23:13 INFO - 'suite': 'dromaeojs', 02:23:13 INFO - 'system_bits': '32', 02:23:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:23:13 INFO - 'title': 'talos-linux64-ix-007', 02:23:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:23:13 INFO - 'use_talos_json': True, 02:23:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:23:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:23:13 INFO - 'work_dir': 'build'} 02:23:13 INFO - ##### 02:23:13 INFO - ##### Running clobber step. 02:23:13 INFO - ##### 02:23:13 INFO - Running pre-action listener: _resource_record_pre_action 02:23:13 INFO - Running main action method: clobber 02:23:13 INFO - rmtree: /builds/slave/test-pgo/build 02:23:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:23:14 INFO - Running post-action listener: _resource_record_post_action 02:23:14 INFO - ##### 02:23:14 INFO - ##### Running read-buildbot-config step. 02:23:14 INFO - ##### 02:23:14 INFO - Running pre-action listener: _resource_record_pre_action 02:23:14 INFO - Running main action method: read_buildbot_config 02:23:14 INFO - Using buildbot properties: 02:23:14 INFO - { 02:23:14 INFO - "properties": { 02:23:14 INFO - "buildnumber": 114, 02:23:14 INFO - "product": "firefox", 02:23:14 INFO - "script_repo_revision": "production", 02:23:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:23:14 INFO - "repository": "", 02:23:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:23:14 INFO - "buildid": "20160125001712", 02:23:14 INFO - "slavename": "talos-linux64-ix-007", 02:23:14 INFO - "pgo_build": "True", 02:23:14 INFO - "basedir": "/builds/slave/test-pgo", 02:23:14 INFO - "project": "", 02:23:14 INFO - "platform": "ubuntu64_hw", 02:23:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:23:14 INFO - "slavebuilddir": "test", 02:23:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:23:14 INFO - "branch": "mozilla-aurora", 02:23:14 INFO - "repo_path": "releases/mozilla-aurora", 02:23:14 INFO - "stage_platform": "linux64-pgo", 02:23:14 INFO - "builduid": "5d8eb007e2de4c2eae63c4ce4fd78a1e", 02:23:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 02:23:14 INFO - }, 02:23:14 INFO - "sourcestamp": { 02:23:14 INFO - "repository": "", 02:23:14 INFO - "hasPatch": false, 02:23:14 INFO - "project": "", 02:23:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 02:23:14 INFO - "changes": [ 02:23:14 INFO - { 02:23:14 INFO - "category": null, 02:23:14 INFO - "files": [ 02:23:14 INFO - { 02:23:14 INFO - "url": null, 02:23:14 INFO - "name": "https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 02:23:14 INFO - } 02:23:14 INFO - ], 02:23:14 INFO - "repository": "", 02:23:14 INFO - "rev": "ab89c814f1b8a841168de98ac2679a1d66122a06", 02:23:14 INFO - "who": "cbook@mozilla.com", 02:23:14 INFO - "when": 1453717351, 02:23:14 INFO - "number": 7510169, 02:23:14 INFO - "comments": "Bug 1241061 - [firefox-ui-tests] Workaround for bug 1237706 to use ZipFile if unzip command is not available. r=maja_zf, a=test-only", 02:23:14 INFO - "project": "", 02:23:14 INFO - "at": "Mon 25 Jan 2016 02:22:31", 02:23:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 02:23:14 INFO - "revlink": "", 02:23:14 INFO - "properties": [ 02:23:14 INFO - [ 02:23:14 INFO - "buildid", 02:23:14 INFO - "20160125001712", 02:23:14 INFO - "Change" 02:23:14 INFO - ], 02:23:14 INFO - [ 02:23:14 INFO - "builduid", 02:23:14 INFO - "5d8eb007e2de4c2eae63c4ce4fd78a1e", 02:23:14 INFO - "Change" 02:23:14 INFO - ], 02:23:14 INFO - [ 02:23:14 INFO - "pgo_build", 02:23:14 INFO - "True", 02:23:14 INFO - "Change" 02:23:14 INFO - ] 02:23:14 INFO - ], 02:23:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 02:23:14 INFO - } 02:23:14 INFO - ], 02:23:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 02:23:14 INFO - } 02:23:14 INFO - } 02:23:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 02:23:14 INFO - Running post-action listener: _resource_record_post_action 02:23:14 INFO - ##### 02:23:14 INFO - ##### Running download-and-extract step. 02:23:14 INFO - ##### 02:23:14 INFO - Running pre-action listener: _resource_record_pre_action 02:23:14 INFO - Running main action method: download_and_extract 02:23:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:23: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')]} 02:23:14 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:23:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 02:23:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 02:23:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:23:19 INFO - Downloaded 1302 bytes. 02:23:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:23:19 INFO - Using the following test package requirements: 02:23:19 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:23:19 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:23:19 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'jsshell-linux-x86_64.zip'], 02:23:19 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:23:19 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:23:19 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:23:19 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:23:19 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:23:19 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:23:19 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:23:19 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:19 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:28 INFO - Downloaded 23159167 bytes. 02:23:28 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 02:23:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:28 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 02:23:29 INFO - Return code: 0 02:23:29 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 02:23:29 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')]} 02:23:29 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:30 INFO - Downloaded 23159167 bytes. 02:23:30 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 02:23:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:30 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 02:23:31 INFO - Return code: 0 02:23: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')]} 02:23:31 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:23:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:32 INFO - Downloaded 11132038 bytes. 02:23:32 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 02:23:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:32 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 02:23:32 INFO - Return code: 0 02:23:32 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')]} 02:23:32 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:23:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/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 02:23:35 INFO - Downloaded 58033452 bytes. 02:23:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:35 INFO - mkdir: /builds/slave/test-pgo/properties 02:23:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:23:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:23:35 INFO - Contents: 02:23:35 INFO - build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:35 INFO - Running post-action listener: _resource_record_post_action 02:23:35 INFO - Running post-action listener: set_extra_try_arguments 02:23:35 INFO - ##### 02:23:35 INFO - ##### Running populate-webroot step. 02:23:35 INFO - ##### 02:23:35 INFO - Running pre-action listener: _resource_record_pre_action 02:23:35 INFO - Running main action method: populate_webroot 02:23:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:23:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:23:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:23:35 INFO - '--tppagecycles', 02:23:35 INFO - '7'], 02:23:35 INFO - 'tests': ['tsvgm']}}, 02:23:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:23:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:23:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:23:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:23:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'tests': ['damp', 'tps']}, 02:23:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['damp', 'tps']}, 02:23:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:23:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:23:35 INFO - 'other': {'tests': ['a11yr', 02:23:35 INFO - 'ts_paint', 02:23:35 INFO - 'tpaint', 02:23:35 INFO - 'sessionrestore', 02:23:35 INFO - 'sessionrestore_no_auto_restore']}, 02:23:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['a11yr', 02:23:35 INFO - 'ts_paint', 02:23:35 INFO - 'tpaint', 02:23:35 INFO - 'sessionrestore', 02:23:35 INFO - 'sessionrestore_no_auto_restore']}, 02:23:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['a11yr', 02:23:35 INFO - 'ts_paint', 02:23:35 INFO - 'tpaint', 02:23:35 INFO - 'sessionrestore', 02:23:35 INFO - 'sessionrestore_no_auto_restore']}, 02:23:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['a11yr', 02:23:35 INFO - 'ts_paint', 02:23:35 INFO - 'tpaint', 02:23:35 INFO - 'sessionrestore', 02:23:35 INFO - 'sessionrestore_no_auto_restore']}, 02:23:35 INFO - 'other_l64': {'tests': ['a11yr', 02:23:35 INFO - 'ts_paint', 02:23:35 INFO - 'tpaint', 02:23:35 INFO - 'sessionrestore', 02:23:35 INFO - 'sessionrestore_no_auto_restore']}, 02:23:35 INFO - 'other_nol64': {'tests': ['a11yr', 02:23:35 INFO - 'ts_paint', 02:23:35 INFO - 'tpaint', 02:23:35 INFO - 'sessionrestore', 02:23:35 INFO - 'sessionrestore_no_auto_restore']}, 02:23:35 INFO - 'svgr': {'tests': ['tsvgx', 02:23:35 INFO - 'tsvgr_opacity', 02:23:35 INFO - 'tart', 02:23:35 INFO - 'tscrollx', 02:23:35 INFO - 'cart']}, 02:23:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['tsvgx', 02:23:35 INFO - 'tsvgr_opacity', 02:23:35 INFO - 'tart', 02:23:35 INFO - 'tscrollx', 02:23:35 INFO - 'cart']}, 02:23:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'tests': ['tp5o']}, 02:23:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'talos_options': ['--e10s'], 02:23:35 INFO - 'tests': ['tp5o']}, 02:23:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'talos_options': ['--xperf_path', 02:23:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:35 INFO - 'tests': ['tp5n']}, 02:23:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:35 INFO - 'talos_options': ['--e10s', 02:23:35 INFO - '--xperf_path', 02:23:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:35 INFO - 'tests': ['tp5n']}}, 02:23:35 INFO - 'talos.zip': {'path': '', 02:23:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:23:35 INFO - Running post-action listener: _resource_record_post_action 02:23:35 INFO - ##### 02:23:35 INFO - ##### Running create-virtualenv step. 02:23:35 INFO - ##### 02:23:35 INFO - Running pre-action listener: _resource_record_pre_action 02:23:35 INFO - Running main action method: create_virtualenv 02:23:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:23:35 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 02:23:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:23:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:23:35 INFO - Using real prefix '/usr' 02:23:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:23:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:23:38 INFO - Installing pip.................done. 02:23:38 INFO - Return code: 0 02:23:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:23: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')]} 02:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:23: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 pip>=1.5 02:23:38 INFO - Using env: {'DISPLAY': ':0', 02:23:38 INFO - 'HOME': '/home/cltbld', 02:23:38 INFO - 'LANG': 'en_US.UTF-8', 02:23:38 INFO - 'LANGUAGE': 'en_US:en', 02:23:38 INFO - 'LOGNAME': 'cltbld', 02:23:38 INFO - 'MAIL': '/var/mail/cltbld', 02:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:38 INFO - 'MOZ_NO_REMOTE': '1', 02:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:38 INFO - 'NO_EM_RESTART': '1', 02:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:38 INFO - 'SHELL': '/bin/bash', 02:23:38 INFO - 'SHLVL': '1', 02:23:38 INFO - 'TERM': 'linux', 02:23:38 INFO - 'TMOUT': '86400', 02:23:38 INFO - 'USER': 'cltbld', 02:23:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:38 INFO - '_': '/tools/buildbot/bin/python'} 02:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:38 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 02:23:38 INFO - Cleaning up... 02:23:38 INFO - Return code: 0 02:23:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:23: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')]} 02:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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', '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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:23: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 psutil>=0.7.1 02:23:38 INFO - Using env: {'DISPLAY': ':0', 02:23:38 INFO - 'HOME': '/home/cltbld', 02:23:38 INFO - 'LANG': 'en_US.UTF-8', 02:23:38 INFO - 'LANGUAGE': 'en_US:en', 02:23:38 INFO - 'LOGNAME': 'cltbld', 02:23:38 INFO - 'MAIL': '/var/mail/cltbld', 02:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:38 INFO - 'MOZ_NO_REMOTE': '1', 02:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:38 INFO - 'NO_EM_RESTART': '1', 02:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:38 INFO - 'SHELL': '/bin/bash', 02:23:38 INFO - 'SHLVL': '1', 02:23:38 INFO - 'TERM': 'linux', 02:23:38 INFO - 'TMOUT': '86400', 02:23:38 INFO - 'USER': 'cltbld', 02:23:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:38 INFO - '_': '/tools/buildbot/bin/python'} 02:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:38 INFO - Downloading/unpacking psutil>=0.7.1 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:23:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:40 INFO - Installing collected packages: psutil 02:23:40 INFO - Running setup.py install for psutil 02:23:40 INFO - building 'psutil._psutil_linux' extension 02:23:40 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 02:23:40 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 02:23:40 INFO - building 'psutil._psutil_posix' extension 02:23:40 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 02:23:40 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 02:23:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:40 INFO - Successfully installed psutil 02:23:40 INFO - Cleaning up... 02:23:41 INFO - Return code: 0 02:23:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:41 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 02:23:41 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 02:23:41 INFO - Using env: {'DISPLAY': ':0', 02:23:41 INFO - 'HOME': '/home/cltbld', 02:23:41 INFO - 'LANG': 'en_US.UTF-8', 02:23:41 INFO - 'LANGUAGE': 'en_US:en', 02:23:41 INFO - 'LOGNAME': 'cltbld', 02:23:41 INFO - 'MAIL': '/var/mail/cltbld', 02:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:41 INFO - 'MOZ_NO_REMOTE': '1', 02:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:41 INFO - 'NO_EM_RESTART': '1', 02:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:41 INFO - 'SHELL': '/bin/bash', 02:23:41 INFO - 'SHLVL': '1', 02:23:41 INFO - 'TERM': 'linux', 02:23:41 INFO - 'TMOUT': '86400', 02:23:41 INFO - 'USER': 'cltbld', 02:23:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:41 INFO - '_': '/tools/buildbot/bin/python'} 02:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:23:41 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 02:23:41 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 02:23:41 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 02:23:41 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 02:23:41 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 02:23:41 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 02:23:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:23:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:23:43 INFO - Installing collected packages: mozsystemmonitor 02:23:43 INFO - Running setup.py install for mozsystemmonitor 02:23:43 INFO - Successfully installed mozsystemmonitor 02:23:43 INFO - Cleaning up... 02:23:43 INFO - Return code: 0 02:23:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:23:43 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')]} 02:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:43 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')]} 02:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:43 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:43 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 02:23:43 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 02:23:43 INFO - Using env: {'DISPLAY': ':0', 02:23:43 INFO - 'HOME': '/home/cltbld', 02:23:43 INFO - 'LANG': 'en_US.UTF-8', 02:23:43 INFO - 'LANGUAGE': 'en_US:en', 02:23:43 INFO - 'LOGNAME': 'cltbld', 02:23:43 INFO - 'MAIL': '/var/mail/cltbld', 02:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:43 INFO - 'MOZ_NO_REMOTE': '1', 02:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:43 INFO - 'NO_EM_RESTART': '1', 02:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:43 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:43 INFO - 'SHELL': '/bin/bash', 02:23:43 INFO - 'SHLVL': '1', 02:23:43 INFO - 'TERM': 'linux', 02:23:43 INFO - 'TMOUT': '86400', 02:23:43 INFO - 'USER': 'cltbld', 02:23:43 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:43 INFO - '_': '/tools/buildbot/bin/python'} 02:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:43 INFO - Downloading/unpacking blobuploader==1.2.4 02:23:43 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 02:23:43 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 02:23:43 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 02:23:43 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 02:23:43 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 02:23:43 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 02:23:45 INFO - Downloading blobuploader-1.2.4.tar.gz 02:23:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:23:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:23:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 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 02:23:45 INFO - Downloading docopt-0.6.1.tar.gz 02:23:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:23:45 INFO - Installing collected packages: blobuploader, requests, docopt 02:23:45 INFO - Running setup.py install for blobuploader 02:23:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:23:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:23:46 INFO - Running setup.py install for requests 02:23:46 INFO - Running setup.py install for docopt 02:23:46 INFO - Successfully installed blobuploader requests docopt 02:23:46 INFO - Cleaning up... 02:23:46 INFO - Return code: 0 02:23:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:46 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:46 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 02:23:46 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 02:23:46 INFO - Using env: {'DISPLAY': ':0', 02:23:46 INFO - 'HOME': '/home/cltbld', 02:23:46 INFO - 'LANG': 'en_US.UTF-8', 02:23:46 INFO - 'LANGUAGE': 'en_US:en', 02:23:46 INFO - 'LOGNAME': 'cltbld', 02:23:46 INFO - 'MAIL': '/var/mail/cltbld', 02:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:46 INFO - 'MOZ_NO_REMOTE': '1', 02:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:46 INFO - 'NO_EM_RESTART': '1', 02:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:46 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:46 INFO - 'SHELL': '/bin/bash', 02:23:46 INFO - 'SHLVL': '1', 02:23:46 INFO - 'TERM': 'linux', 02:23:46 INFO - 'TMOUT': '86400', 02:23:46 INFO - 'USER': 'cltbld', 02:23:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:46 INFO - '_': '/tools/buildbot/bin/python'} 02:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:46 INFO - Running setup.py (path:/tmp/pip-hcfcvf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:46 INFO - Running setup.py (path:/tmp/pip-wVMQzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:46 INFO - Running setup.py (path:/tmp/pip-wiYd4E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:46 INFO - Running setup.py (path:/tmp/pip-IytKFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:47 INFO - Running setup.py (path:/tmp/pip-gWqR4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:47 INFO - Running setup.py (path:/tmp/pip-Bewgap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:47 INFO - Running setup.py (path:/tmp/pip-f8dbQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:47 INFO - Running setup.py (path:/tmp/pip-9DeoIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:47 INFO - Running setup.py (path:/tmp/pip-dT40ni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:47 INFO - Running setup.py (path:/tmp/pip-qcDDMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:47 INFO - Running setup.py (path:/tmp/pip-nirDzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:47 INFO - Running setup.py (path:/tmp/pip-NlvivG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:47 INFO - Running setup.py (path:/tmp/pip-Obg1wo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:47 INFO - Running setup.py (path:/tmp/pip-mmlnU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:47 INFO - Running setup.py (path:/tmp/pip-ASaFkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:47 INFO - Running setup.py (path:/tmp/pip-vT_k5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:47 INFO - Running setup.py (path:/tmp/pip-1RYVR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:47 INFO - Running setup.py install for manifestparser 02:23:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Running setup.py install for mozcrash 02:23:48 INFO - Running setup.py install for mozdebug 02:23:48 INFO - Running setup.py install for mozdevice 02:23:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Running setup.py install for mozfile 02:23:48 INFO - Running setup.py install for mozhttpd 02:23:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Running setup.py install for mozinfo 02:23:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Running setup.py install for mozInstall 02:23:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:23:48 INFO - Running setup.py install for mozleak 02:23:48 INFO - Running setup.py install for mozlog 02:23:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Running setup.py install for moznetwork 02:23:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Running setup.py install for mozprocess 02:23:49 INFO - Running setup.py install for mozprofile 02:23:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Running setup.py install for mozrunner 02:23:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Running setup.py install for mozscreenshot 02:23:49 INFO - Running setup.py install for moztest 02:23:49 INFO - Running setup.py install for mozversion 02:23:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:23:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:49 INFO - Cleaning up... 02:23:49 INFO - Return code: 0 02:23:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:49 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:49 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 02:23:49 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 02:23:49 INFO - Using env: {'DISPLAY': ':0', 02:23:49 INFO - 'HOME': '/home/cltbld', 02:23:49 INFO - 'LANG': 'en_US.UTF-8', 02:23:49 INFO - 'LANGUAGE': 'en_US:en', 02:23:49 INFO - 'LOGNAME': 'cltbld', 02:23:49 INFO - 'MAIL': '/var/mail/cltbld', 02:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:49 INFO - 'MOZ_NO_REMOTE': '1', 02:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:49 INFO - 'NO_EM_RESTART': '1', 02:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:49 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:49 INFO - 'SHELL': '/bin/bash', 02:23:49 INFO - 'SHLVL': '1', 02:23:49 INFO - 'TERM': 'linux', 02:23:49 INFO - 'TMOUT': '86400', 02:23:49 INFO - 'USER': 'cltbld', 02:23:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:49 INFO - '_': '/tools/buildbot/bin/python'} 02:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:49 INFO - Running setup.py (path:/tmp/pip-cxInXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:50 INFO - Running setup.py (path:/tmp/pip-ubFheE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:50 INFO - Running setup.py (path:/tmp/pip-IQNrRD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:50 INFO - Running setup.py (path:/tmp/pip-B6wOL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:50 INFO - Running setup.py (path:/tmp/pip-1TIOxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:50 INFO - Running setup.py (path:/tmp/pip-HOqn01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:50 INFO - Running setup.py (path:/tmp/pip-byB28O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:50 INFO - Running setup.py (path:/tmp/pip-2HBJvN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:50 INFO - Running setup.py (path:/tmp/pip-JFA5zr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:50 INFO - Running setup.py (path:/tmp/pip-jl6tvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:50 INFO - Running setup.py (path:/tmp/pip-Y3__v0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:50 INFO - Running setup.py (path:/tmp/pip-0R44V5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:50 INFO - Running setup.py (path:/tmp/pip-ps7FDA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:50 INFO - Running setup.py (path:/tmp/pip-pOR4WX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:50 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)) 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:50 INFO - Running setup.py (path:/tmp/pip-XxlAnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:51 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)) 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:51 INFO - Running setup.py (path:/tmp/pip-dKoS8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:51 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)) 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:51 INFO - Running setup.py (path:/tmp/pip-JESnSs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:51 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)) 02:23:51 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)) 02:23:51 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)) 02:23:51 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)) 02:23:51 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)) 02:23:51 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)) 02:23:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:52 INFO - Downloading blessings-1.6.tar.gz 02:23:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:53 INFO - Installing collected packages: blessings 02:23:53 INFO - Running setup.py install for blessings 02:23:53 INFO - Successfully installed blessings 02:23:53 INFO - Cleaning up... 02:23:53 INFO - Return code: 0 02:23:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:23:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:23:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:23:53 INFO - Reading from file tmpfile_stdout 02:23:53 INFO - Current package versions: 02:23:53 INFO - argparse == 1.2.1 02:23:53 INFO - blessings == 1.6 02:23:53 INFO - blobuploader == 1.2.4 02:23:53 INFO - docopt == 0.6.1 02:23:53 INFO - manifestparser == 1.1 02:23:53 INFO - mozInstall == 1.12 02:23:53 INFO - mozcrash == 0.16 02:23:53 INFO - mozdebug == 0.1 02:23:53 INFO - mozdevice == 0.47 02:23:53 INFO - mozfile == 1.2 02:23:53 INFO - mozhttpd == 0.7 02:23:53 INFO - mozinfo == 0.9 02:23:53 INFO - mozleak == 0.1 02:23:53 INFO - mozlog == 3.1 02:23:53 INFO - moznetwork == 0.27 02:23:53 INFO - mozprocess == 0.22 02:23:53 INFO - mozprofile == 0.27 02:23:53 INFO - mozrunner == 6.11 02:23:53 INFO - mozscreenshot == 0.1 02:23:53 INFO - mozsystemmonitor == 0.0 02:23:53 INFO - moztest == 0.7 02:23:53 INFO - mozversion == 1.4 02:23:53 INFO - psutil == 3.1.1 02:23:53 INFO - requests == 1.2.3 02:23:53 INFO - wsgiref == 0.1.2 02:23:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:23:53 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')]} 02:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:53 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')]} 02:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:53 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:53 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 02:23:53 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 02:23:53 INFO - Using env: {'DISPLAY': ':0', 02:23:53 INFO - 'HOME': '/home/cltbld', 02:23:53 INFO - 'LANG': 'en_US.UTF-8', 02:23:53 INFO - 'LANGUAGE': 'en_US:en', 02:23:53 INFO - 'LOGNAME': 'cltbld', 02:23:53 INFO - 'MAIL': '/var/mail/cltbld', 02:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:53 INFO - 'MOZ_NO_REMOTE': '1', 02:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:53 INFO - 'NO_EM_RESTART': '1', 02:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:53 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:53 INFO - 'SHELL': '/bin/bash', 02:23:53 INFO - 'SHLVL': '1', 02:23:53 INFO - 'TERM': 'linux', 02:23:53 INFO - 'TMOUT': '86400', 02:23:53 INFO - 'USER': 'cltbld', 02:23:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:53 INFO - '_': '/tools/buildbot/bin/python'} 02:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 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)) 02:23:53 INFO - Cleaning up... 02:23:53 INFO - Return code: 0 02:23:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:23:53 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')]} 02:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:53 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')]} 02:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:53 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:53 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 02:23:53 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 02:23:53 INFO - Using env: {'DISPLAY': ':0', 02:23:53 INFO - 'HOME': '/home/cltbld', 02:23:53 INFO - 'LANG': 'en_US.UTF-8', 02:23:53 INFO - 'LANGUAGE': 'en_US:en', 02:23:53 INFO - 'LOGNAME': 'cltbld', 02:23:53 INFO - 'MAIL': '/var/mail/cltbld', 02:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:53 INFO - 'MOZ_NO_REMOTE': '1', 02:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:53 INFO - 'NO_EM_RESTART': '1', 02:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:53 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:53 INFO - 'SHELL': '/bin/bash', 02:23:53 INFO - 'SHLVL': '1', 02:23:53 INFO - 'TERM': 'linux', 02:23:53 INFO - 'TMOUT': '86400', 02:23:53 INFO - 'USER': 'cltbld', 02:23:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:53 INFO - '_': '/tools/buildbot/bin/python'} 02:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:53 INFO - Downloading/unpacking jsonschema 02:23:53 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 02:23:53 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 02:23:53 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 02:23:53 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 02:23:53 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 02:23:53 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 02:23:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:55 INFO - Downloading/unpacking functools32 (from jsonschema) 02:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:55 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:55 INFO - warning: no files found matching '*.txt' 02:23:55 INFO - no previously-included directories found matching 'build' 02:23:55 INFO - no previously-included directories found matching 'dist' 02:23:55 INFO - no previously-included directories found matching '.git*' 02:23:55 INFO - Installing collected packages: jsonschema, functools32 02:23:55 INFO - Running setup.py install for functools32 02:23:55 INFO - warning: no files found matching '*.txt' 02:23:55 INFO - no previously-included directories found matching 'build' 02:23:55 INFO - no previously-included directories found matching 'dist' 02:23:55 INFO - no previously-included directories found matching '.git*' 02:23:55 INFO - Successfully installed jsonschema functools32 02:23:55 INFO - Cleaning up... 02:23:56 INFO - Return code: 0 02:23:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:23:56 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')]} 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 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')]} 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 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 0x7f0749ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', '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 02:23:56 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 02:23:56 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 02:23:56 INFO - Using env: {'DISPLAY': ':0', 02:23:56 INFO - 'HOME': '/home/cltbld', 02:23:56 INFO - 'LANG': 'en_US.UTF-8', 02:23:56 INFO - 'LANGUAGE': 'en_US:en', 02:23:56 INFO - 'LOGNAME': 'cltbld', 02:23:56 INFO - 'MAIL': '/var/mail/cltbld', 02:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:56 INFO - 'MOZ_NO_REMOTE': '1', 02:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:56 INFO - 'NO_EM_RESTART': '1', 02:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:56 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:56 INFO - 'SHELL': '/bin/bash', 02:23:56 INFO - 'SHLVL': '1', 02:23:56 INFO - 'TERM': 'linux', 02:23:56 INFO - 'TMOUT': '86400', 02:23:56 INFO - 'USER': 'cltbld', 02:23:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:56 INFO - '_': '/tools/buildbot/bin/python'} 02:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:56 INFO - Downloading/unpacking flake8 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:23:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:23:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:23:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:58 INFO - no previously-included directories found matching 'docs/_build' 02:23:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:23:58 INFO - Running setup.py install for pep8 02:23:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:58 INFO - no previously-included directories found matching 'docs/_build' 02:23:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:23:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:23:58 INFO - Cleaning up... 02:23:58 INFO - Return code: 0 02:23:58 INFO - Running post-action listener: _resource_record_post_action 02:23:58 INFO - Running post-action listener: _start_resource_monitoring 02:23:58 INFO - Starting resource monitoring. 02:23:58 INFO - ##### 02:23:58 INFO - ##### Running install step. 02:23:58 INFO - ##### 02:23:58 INFO - Running pre-action listener: _resource_record_pre_action 02:23:58 INFO - Running main action method: install 02:23:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:23:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:23:59 INFO - Reading from file tmpfile_stdout 02:23:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:23:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:23:59 INFO - Reading from file tmpfile_stdout 02:23:59 INFO - Output received: 02:23:59 INFO - Usage: mozinstall [options] installer 02:23:59 INFO - Options: 02:23:59 INFO - -h, --help show this help message and exit 02:23:59 INFO - -d DEST, --destination=DEST 02:23:59 INFO - Directory to install application into. [default: 02:23:59 INFO - "/builds/slave/test-pgo"] 02:23:59 INFO - --app=APP Application being installed. [default: firefox] 02:23:59 INFO - mkdir: /builds/slave/test-pgo/build/application 02:23:59 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'] 02:23:59 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 02:24:13 INFO - Reading from file tmpfile_stdout 02:24:13 INFO - Output received: 02:24:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:24:13 INFO - Running post-action listener: _resource_record_post_action 02:24:13 INFO - ##### 02:24:13 INFO - ##### Running run-tests step. 02:24:13 INFO - ##### 02:24:13 INFO - Running pre-action listener: _resource_record_pre_action 02:24:13 INFO - Running main action method: run_tests 02:24:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:24:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:24:13 INFO - Python 2.7.3 02:24:13 INFO - Return code: 0 02:24:13 INFO - grabbing minidump binary from tooltool 02:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:13 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 0x1201350>, '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 0x1202250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12026e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:24:13 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 02:24:13 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 02:24:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:13 INFO - Return code: 0 02:24:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:24:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:24:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:24:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:24:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:24:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:24:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:24:14 INFO - Return code: 0 02:24:14 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/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:24:14 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/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 02:24:14 INFO - Using env: {'DISPLAY': ':0', 02:24:14 INFO - 'HOME': '/home/cltbld', 02:24:14 INFO - 'LANG': 'en_US.UTF-8', 02:24:14 INFO - 'LANGUAGE': 'en_US:en', 02:24:14 INFO - 'LOGNAME': 'cltbld', 02:24:14 INFO - 'MAIL': '/var/mail/cltbld', 02:24:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:24:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:14 INFO - 'MOZ_NO_REMOTE': '1', 02:24:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:14 INFO - 'NO_EM_RESTART': '1', 02:24:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:14 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:24:14 INFO - 'SHELL': '/bin/bash', 02:24:14 INFO - 'SHLVL': '1', 02:24:14 INFO - 'TERM': 'linux', 02:24:14 INFO - 'TMOUT': '86400', 02:24:14 INFO - 'USER': 'cltbld', 02:24:14 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722', 02:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:14 INFO - '_': '/tools/buildbot/bin/python'} 02:24:14 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/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 02:24:15 INFO - mozversion INFO | application_buildid: 20160125001712 02:24:15 INFO - mozversion INFO | application_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 02:24:15 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:24:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:15 INFO - mozversion INFO | application_name: Firefox 02:24:15 INFO - mozversion INFO | application_remotingname: firefox-dev 02:24:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:24:15 INFO - mozversion INFO | application_vendor: Mozilla 02:24:15 INFO - mozversion INFO | application_version: 45.0a2 02:24:15 INFO - mozversion INFO | platform_buildid: 20160125001712 02:24:15 INFO - mozversion INFO | platform_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 02:24:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:24:15 INFO - mozversion INFO | platform_version: 45.0a2 02:24:15 INFO - 2016-01-25 02:24:15,153 DEBUG : using testdate: 1453717455 02:24:15 INFO - 2016-01-25 02:24:15,153 DEBUG : actual date: 1453717455 02:24:15 INFO - 2016-01-25 02:24:15,163 INFO : starting webserver on 'localhost:32966' 02:24:15 INFO - 2016-01-25 02:24:15,164 INFO : Starting test suite talos-linux64-ix-007 02:24:15 INFO - 2016-01-25 02:24:15,164 INFO : Starting test dromaeo_css 02:24:15 INFO - 2016-01-25 02:24:15,164 DEBUG : operating with platform_type : linux_ 02:24:15 INFO - 2016-01-25 02:24:15,165 INFO : Initialising browser for dromaeo_css test... 02:24:15 INFO - 2016-01-25 02:24:15,177 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIorsqm/profile http://localhost:32966/getInfo.html 02:24:19 INFO - 2016-01-25 02:24:19,340 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:24:19 INFO - 2016-01-25 02:24:19,340 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:24:19 INFO - 2016-01-25 02:24:19,340 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:24:19 INFO - 2016-01-25 02:24:19,341 DEBUG : BROWSER_OUTPUT: __metrics 02:24:19 INFO - 2016-01-25 02:24:19,485 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] 02:24:20 INFO - 2016-01-25 02:24:20,446 INFO : Browser initialized. 02:24:20 INFO - 2016-01-25 02:24:20,446 INFO : Running cycle 1/1 for dromaeo_css test... 02:24:20 INFO - 2016-01-25 02:24:20,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIorsqm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:24:32 INFO - 2016-01-25 02:24:32,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 137531392 02:24:32 INFO - 2016-01-25 02:24:32,183 DEBUG : BROWSER_OUTPUT: 02:25:23 INFO - 2016-01-25 02:25:23,354 DEBUG : BROWSER_OUTPUT: 1453717523353 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] 02:27:31 INFO - 2016-01-25 02:27:31,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32966/tests/dromaeo/cssquery-ext.html) 02:27:32 INFO - 2016-01-25 02:27:32,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 269049856 02:27:32 INFO - 2016-01-25 02:27:32,960 DEBUG : BROWSER_OUTPUT: 02:30:35 INFO - 2016-01-25 02:30:35,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-ext.html (next: http://localhost:32966/tests/dromaeo/cssquery-jquery.html) 02:30:35 INFO - 2016-01-25 02:30:35,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 215187456 02:30:35 INFO - 2016-01-25 02:30:35,857 DEBUG : BROWSER_OUTPUT: 02:33:37 INFO - 2016-01-25 02:33:37,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32966/tests/dromaeo/cssquery-mootools.html) 02:33:38 INFO - 2016-01-25 02:33:38,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 211525632 02:33:38 INFO - 2016-01-25 02:33:38,187 DEBUG : BROWSER_OUTPUT: 02:36:39 INFO - 2016-01-25 02:36:39,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32966/tests/dromaeo/cssquery-prototype.html) 02:36:40 INFO - 2016-01-25 02:36:40,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 200232960 02:36:40 INFO - 2016-01-25 02:36:40,519 DEBUG : BROWSER_OUTPUT: 02:39:42 INFO - 2016-01-25 02:39:42,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32966/tests/dromaeo/cssquery-yui.html) 02:39:43 INFO - 2016-01-25 02:39:43,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 201179136 02:39:43 INFO - 2016-01-25 02:39:43,543 DEBUG : BROWSER_OUTPUT: 02:42:45 INFO - 2016-01-25 02:42:45,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-yui.html (next: http://localhost:32966/tests/dromaeo/cssquery-dojo.html) 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 222498816 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3312.9503057454144;3372.325534893022;3399.8980030599073;3413.590369155702;3428.2457859270967;5546.334439867216;5565.276514053173;5578.736668094048;5584.246126772884;5592.412796656354;5587.636803607773;5591.440855914407;5597.972010139953;5599.7480113394895;5603.523700485463;4762.452317983424;5085.720285384303;5120.334356533664;5175.327207463025;5228.0589493891275;5033.899322013557;5077.974610126944;5079.720615366154;5093.770780314895;5094.261332106842;4970.204767237243;5008.373953255843;5053.772580233898;5054.570361519275;5058.544730974211;4968.1554135797005;5035.84892453227;5059.241113832918;5063.3417655704525;5070.797168113271;5021.322121513585;5057.317262169597;5123.615728820316;5134.435212126663;5169.922451163198;5156.948430515685;5173.715445650488;5252.028374750684;5379.488948549882;5410;5928.199693041427;5944.316403613597;5960.314563825129;5975.940240597582;5980.820575382745;5960.523158147381;5966.552508561832;5970.641761494281;5972.880542389128;6009.6394216346725;5281.656692315026;5383.650062745909;5530.917036244459;5556.861078473071;5584.162375643686;6069.302030266487;6070.423309785651;6087.568717326535;6087.811893003903;6089.939100608937;5908.940910590925;5914.349421563625;5918.526517878559;5921.73352199152;5923.437273459014;5612.747426365823;5717.571182161271;6000.019943559715;6008.819735407945;6021.819345419644;5801.622894511843;5910.202122713465;5918.526517878559;5918.822435326947;5931;5790.36306006339;5928.466438020599;5988.700564971734;5988.760449582055;5991.101334799728;4387.3857659927635;4474.619657329098;4509.413776209072;4521.118381915495;4581.312803079565;4042.3734321180264;4073.1492142291117;4083.9387409188885;4085.428040074392;4105.952981989573;5576.665400076008;5586.217929489874;5586.91619625706;5589.469000444951;5616.747246373923;5660.122680984454;5753.741081651336;5768.913466298009;5874.853128671732;5914.497267732205;5598.524125449301;5603.047481928082;5604.243427137284;5620.156976453564;5622.212890195376;5178.0679477694375;5184.688918664892;5185.092608793446;5190.195519694454;5215.687058776485;5767.077267637158;5904.527637788967;5953.553483488756;6071.3928607139815;6097.237845269341;5950.047992321208;5969.910451343147;5972.223610930551;5975.492083172805;5984.820455386345;5750.7987220447085;6095.451409373178;6120.17377654011;6120.326764056039;6127.172831667668;5652.943470565242;5688.857778555569;5756.740946657326;5765.308163020464;5799.652020878761;5934.376890426615;5960.910586341295;5987.43119403656;6000.8799824004145;6004.1294012368835;5547.944520554743;5658.094704847204;5836.737346819318;5857.7949771757785;5871.089981052944;5713.942860571341;5801.8549536261935;5803.709814509173;5806.82579522615;5835.299764028344;5657.773689052392;5665.12190610456;5669.659820410789;5672.688002159755;5690.886182276414;5565.38780734127;5578.776848925998;5661.348944871393;5771.59598828078;5790.305163380422;5524.475174858382;5541.667499950016;5543.61194716366;5548.445155484419;5549.278593782782 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.5717568884114;595.5563105486411;607.4472230270453;634.4068296143107;636.4081404294011;31945.840270798642;40333.798331008344;40620.796896015476;40725;40793.18413631726;45779.54220457794;46516.302255466195;46570.767146164304;46612;46719.29921051187;7934.642941067637;8057.274845263925;8935.955320223406;9013.729588112334;10401.895981040168;10760.569577216942;10893.346399216032;10904.454777261144;10913.34519928803;10916.672499824977;10745.946270268638;10747.301425407324;10816.405097719622;10845.186611004166;10864.45677716115;8262.339012878956;8380.748577542652;10941.507632156572;11175.329480231212;11190.94404527972;10659.626913058084;10740.301880377829;10789.676309710721;10795.29830561011;10810.891891081146;42965;43423.348649770276;43527.782361088306;43558.12883742339;43564.128717425476;3411.164264755126;3494.8776792812127;3741.6071312512067;3992.8003599819895;4040.8181631826637;31979.680203197902;37106;37264.813675931444;37278.81360593207;37320.25359492822;3944.073142811437;4017.0961533654986;4043.696722745806;4044.3529035354204;4199.202151591218;280544;286835;287426.56286718644;287660;287812;60702.08946865801;61609;67103.66448167728;67318.32681673218;68525;71329.64335178291;71942.64028679927;72401.63799181076;72423.6378818113;72504.63747681334;16164.595885102732;17198.398056067977;17220.569485762957;17226.569335766708;17243;12604.684882877818;12623.431945562472;12707.237565746085;12710.110292279453;12726.17279876805;22563.548729025326;22897;22962.851857407397;23011.539769204523;23031.539369212856;8718.866547348804;9042.367034307536;9068.455892646462;9106.31702622306;9185.678501252558;1012.6911292055994;1118.8713297970676;1133.1727838677646;1133.18410744264;1141.634676903383;33321.16697082592;34102.48846267308;34160.14599635029;34317;34684;1111.0833562311125;1129.7627498225465;1185.4546908422221;1198.7422704118655;1210.7336385995068;14411.711765764627;16943.237554310086;17356.739648905277;17390.391336303423;17423.91288043577;436662;441328;441343;442828;443991;58844;59247.111293330636;59283.40716592865;59320.40679593235;59392.70303648541;1363.4478036395276;1418.1278513713992;1458.358322338168;1460.8393076761547;1490.6646004649085;25024;29980.70019299866;30416.78332866749;30797.8460107698;31133.8443307782;52442.475575243756;53020;53166.46833531615;53194.73402632962;53454.19818702645;294418;315614;317012;403142;407714;47015.76492117518;47088.52911470841;47460.288095677904;48088.519114808405;48901.5109848897;49898.25152622786;50053.24813631505;50374.24438633497;50901;51099.48900510947;41636;41720.79139604283;41761.373579395724;42377.36433953432;42967;42750.78624606857;43133.352999705654;43453.13093738044;43467.56532434635;43990.56009439864;46340;46924.29613555731;47180.52819471761;47510;47821;39213.60786392214;41453.92426686855;43830.34254486249;44012.33981490216;44086.33870491881;31797.841010794797;32028.5195722069;32172.19569510781;32203.58473114479;33101.17247068843 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.27747640744377;385.1795675211798;389.16524055900095;389.91226973930867;395.4167602785891;15235.31441085151;15320.463783767571;16788.328466861327;18076.638467230663;18179.091045447723;18022.909885450554;18135.546611334725;18344.082795860188;18350.265989360443;18485.90757046216;5956.493698035672;6124.540659450537;6127.938720612781;6145.907811382833;6151.169592105076;4562.589366956973;4664.486906440289;5985.551083668721;6648.401643852052;6908.723651053977;5378.112611419111;6825.419839313664;6850.246472887979;6855.931440685604;6890.138732658418;5583.58123140764;5589.608727389084;5611.3266408031095;5613.129964855454;5619.550435965113;5314.441983591744;5410.486003829669;5433.592480563973;5433.918491222635;5465.754041068121;12501.437435315342;12531.872131508208;12545.498180072786;12644.747105057939;21563.46091347713;2190.244365693849;2286.8856557172076;2331.708536432946;2343.402432379732;2406.7833894949363;10275.126614237799;10368.585256589802;10674.62638807638;13774.242416667079;14318.212498312589;1924.769027716669;1957.6867701167744;1970.9211631534722;1994.950126246841;2043.2439997201132;64980.54669044029;67154.32845671578;67745.98381024339;68381.65809170972;68611.65694171547;10953.945230273957;11092.667219983414;11101.1674124441;11101.722456938642;11195.216334856645;13687.931560342135;13868.098573592684;13969.301534923214;14039.438422462987;14545.200013999332;7859.056913170456;8002.199780022068;8084.272415482517;8158.918410815816;8167.224113709188;7674.347680447113;7762.593595985262;7777.533347999138;7811.4922530035365;7819.139894611588;4268.87193384199;4564.84023059198;4615.515370886076;4682.297655351725;4810.797300674832;1726.8602722203286;1779.5462157149843;1788.20424910916;1788.7585176001332;1877.5681593233633;1039.449091981251;1051.921105917044;1055.055725126008;1069.9090577301017;1103.9889601104046;17580.824191757918;17598.736018959728;17627.55931101733;17640;17909.820901790816;865.2991077227466;984.4683870709737;996.850472429127;1000.3197825478744;1022.9641962531275;9555.001922183896;9804.411735295906;9821;9864.358816676893;9996.250281228937;591196;595095;603074;606291;606376;85771;86495.1350486487;88774.55612721895;88853.55573222222;89249;1223.2966044524435;1231.5197073141483;1236.042067397774;1241.74544218435;1251.7621651886113;15120.773188402403;15123.092614443169;15255.618609534851;15394.615134621725;15638.374465021272;35285.47071793977;35775.64224357827;36324.818375907955;36561.81719091388;36951;49907;51635.96728065342;53638.73180634072;53685.46314536805;54584.454155457934;10245.282830202112;10253.231007674305;10319.329243599143;10475;10627.734306642396;18256.9045857249;18319.725204122216;18339.908300458414;18717.6256474867;18777.812221877608;12544.623661290176;13996.720065598834;14328.713425731636;14492.420303187755;14719.190444525653;13550.525731599346;14138.929305353407;14223.64440888986;14318.71362572722;14653.194074326015;14538.90958178162;14685.706285874436;14793.408263669333;15028.924855375653;15094.773578396112;9529.285303602119;9824.312298139348;9905.950470247602;10112.747181320527;10273.9486302568;13737;14463.85536144625;14937;15293.388264469297;15335.079895206323 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1386.4246337769825;1517.2337969325497;1522.9771553426701;1795.3805936951749;1827.250827160864;6671.166104236971;7401;7633.0458692663415;7634.160242373341;7642.5796581188015;7575.166731659513;7726.61366931654;7728.7681369559;7741.690332386712;7745.961270193655;1993.5514509235452;2020.141439888049;2022.9190832366762;2218.8335874809413;2258.480549473614;2250.0662225176534;2295.5064661097863;2299.0114250872202;2304.4699719064624;2306.815454763623;2177.8148857347064;2200.0539767899795;2202.933911982643;2225.5882661707556;2249.955000899981;2138.433315171481;2173.8695678259355;2190.9671354929687;2207.514346843692;2208.050538268552;2245.124401483423;2253.5380247049316;2264.9547009059725;2265.8074063704603;2272.6136556785223;7602.50583712057;7682.308592226726;7698.961505192494;7726.613669316512;7743.457957942946;4431.069475410168;4507.57178068083;4510.075434535912;4523.909521809545;4537.659675524349;2933.9266518337;2960.6003189569346;3002.9699703002907;3014.1711029467074;3030.3030303030205;935.3592788939599;947.4504787223462;965.9130678238993;1011.3982180602529;1021.3361315145141;10393.116585090276;10406.947965260126;10425.791484170275;10434.321769084985;10439.486274490157;4040.2323558524376;4055.8377664893073;4109;4109.321961876317;4122.072533679958;8904.332175086894;8911.2425443838;8921;8923.821523569623;8930.86603700945;4506.549345065468;4513.796879140446;4534.863954081383;4536.500984891659;4537.047220083753;4103.466549348565;4110.301248787713;4119.938200926988;4125.29869922114;4139.730917490354;3276.967230327666;3434.364642541138;3683.650053244937;3686.8156592170285;3731.440283957428;1122.7361570031198;1138.709629044605;1141.1669481278714;1144.730988217768;1149.9310041397375;1073.044989958937;1106.5794997900907;1107.1696227829127;1281.557862537423;1384.9653758656113;6790.5925644461495;6822.829429264308;6874.759383421556;6877;6904.620245886525;1082.199172612277;1095.6439157273917;1143.3940011793595;1152.7521582859727;1157.2188772578477;5518.448155184449;5614.410486898817;5615.157726341082;5623.353314368818;5627.043402621564;8962.103789621116;9047.140521650434;9188.127127922837;9213.81572368549;9310.441373517611;9128.680496182602;9188.40275382098;9203;9211.953940230256;9219.124183202719;7110.146782386147;7312;7353.963230183922;7354.301341372561;7359.484836061424;7121.46589005837;7144.464165187528;7170.2471240519;7182.676779545038;7185.353318201387;8166.224208700164;8227.794305142419;8373.204545568162;8426.536540490331;8452.957735211285;8453.704120355758;8534.914650853412;8656.26421754158;8665.653373864974;8673.913260867563;6642.468602511691;6831.795046148623;6857.588544687334;6863.279355667583;6907.551009184387;6554.672266386757;6776.322367763184;6990.790276291719;7469.887951680837;7531.322181003736;6895.310468953065;6899.827504312231;6941.132358455193;7009.509334346547;7027.332403421667;6849.726010959505;6896.069030680995;6926.58440493572;6943.548669336477;6985.895211571728;6856.314368563303;6894.655267236719;6895.75864844728;6905.033295338757;6910.067140935909;6162.815115546541;6310.6213627182515;6339.397757213057;6345.111684364285;6388.105665206967;6390.392912673288;6419;6427.710753016032;6432.035194720829;6439.291677915332 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.16979315779764;338.9966100338997;350.95963964144113;358.95154154189174;359.6835581770718;6052.182955301033;6142.631442113477;6158.846028849281;6203.131561581376;6208.596441231317;5896.734646940888;6063.545234107438;6063.6058656187315;6082.391760823926;6090.299615544213;4753.619710423158;4756.334113224151;4757.119932812423;4765.30903019062;4772;4567.132244873464;4609.631229501631;4647.88380290492;4703.929441058387;4739.763011849411;4635.698679585833;4646.97676511617;4654.045920586289;4657.5575320344515;4677.74272415017;4638.768061596924;4642.51253618372;4650.325702773096;4660.953390466119;4674.252119660872;4085.836566537335;4087.202995415895;4092.6725861930972;4095.8566450174103;4096.91806163878;5754.769809207627;5843.152742852262;5850.122481627747;5870.823875283749;5879.088741245114;5467.972660136714;5472.835814925558;5480.588955828329;5483.396826349099;5486.231927530149;6133.877322453571;6472.773452929172;6480.02799580062;6485.546011779177;6497.772577959749;4487.977560112178;4502.594766471;4599.67802253839;4619.076184763061;4657.254839225741;6695.196576410814;6702.463802895757;6706.161729783777;6720.83197920051;6723.0923825283935;4711.434627844681;4766.356541866873;4768.451628062748;4769.2130798417875;4781.832635857728;4754.4532378776885;4826.8069277228515;4856.39295088114;4861.513848615181;4875.463698993108;5486.862828429242;5514.228008078872;5524.281843360418;5529.364123125812;5538.030844602178;6519.054737063099;6551.181102362205;6553.885839407312;6554.983977483497;6557.672116394161;1678.9580260493585;1705.60771022663;1705.7867766529184;1706.3686436018752;1714.9399771007954;1130.4008875296106;1172.0916289875245;1194.1103877611063;1200.7538454616783;1201.1891972918245;6354.3645635437015;6356;6360.681965901686;6361.14124593174;6363.7772677956045;6753.729850805913;6761.121054263012;6765.391114799593;6768.424683901923;6771.984202369586;6250.374962503804;6346.619202847844;6348.143000694847;6352.523560732871;6361;3620.0406892173596;3654.232611151635;3655.3785856404475;3659.359612067931;3659.505966694462;6889.242183359826;6910.8617827644175;6915.827104322432;6929.203141638776;6932.306769323028;6757.898631520531;6870.45036397087;6896.517243792987;6907.689153988083;6915.965420172867;6898.620575868275;6898.896516552256;6902.792916212522;6907.067545881242;6918.965405173042;6415.166028416276;6657.800265992028;6710;6737.898931516129;6754.696038678369;6603.240627327918;6620.702068407029;6658.500612454182;6684.364985326386;6686;6943.166819981635;6955.547889387173;6957.095577574883;6958.79123626292;6974.232834388112;4575.3365761965;4665.6034237090225;4683.765811709332;4769.642276829182;4821.035792841516;6730.663466826737;6758.662066896733;6761.22245941723;6773.18721753373;6776.45788336922;6591.802245932629;6593.736250549924;6594.70323835419;6595.043718660863;6596.70314835824;6410.871782564416;6515.934840651533;6560.671966401756;6574.04676321921;6574.605523668595;6454.128692626436;6459.644719540471;6465.61206327603;6468.3855033771715;6472.579282346633;6580.1116849226655;6582.637954912526;6587.110740050032;6591.670416479061;6594.637294948824;6350.460210882126;6435.22777266731;6467.126937863328;6491.415772580491;6498.285188629153 02:42:46 INFO - 2016-01-25 02:42:46,067 DEBUG : BROWSER_OUTPUT: |5;yui.html;854.6282367170279;858.2919091749308;882.3691060891462;895.2837729816146;899.0515006667963;13655.863441365584;13893.722125557482;13933.233672148028;13933.651658708524;13945.860541394595;13792.379342929567;13872.861271387283;13888.236147011936;13908.930455347709;13911.513097041605;756.1946526948782;759.4228386426328;888.9599968001439;899.5097671768868;921.3136213520936;901.8962819275802;902.6885724425096;907.519014922089;907.8592818113203;909.4270609515995;798.6286376834771;950.0831697411996;960.5677445149676;961.6922584772875;962.7593101724569;799.8400319936036;801.182793550578;932.6269492203105;949.5964215208578;951.0204489375953;709.0746575718686;709.6558169287891;710.0662628643317;710.0910834132319;710.8969199466101;13109.278989655566;13186.736265274736;13284.269365185008;13292.933535332359;13317.866821331856;12736.681582960407;13301;13465.596032119052;13506.662333441644;13510.662233444144;10994.395308258043;11152.609658661908;11192.944035279854;11193;11360;3794.2221844521805;3830.885073447801;3839.308924393608;3883.572806991229;3904.726669133162;47602.5239747605;47936;48271.27593086071;48310.758446207896;48598.27102593464;10629.149668026539;10682.092022178047;10683.465826708634;10738.409387483607;11116;19040.238390464227;19051;19075.427737167905;19095.61808763817;19117;8208.220219079178;8228.177182281725;8233.917660823316;8321.833563328699;8327.333813294921;4639.907201855944;4696.107739529547;4736.573708366263;4787.760611969387;4858.441279252931;2983.1498023063323;3015.442143203514;3018.0644000359957;3020.3808219314988;3026.72759451646;555.2365497441018;556.118552094926;566.7364675425947;566.9206311116448;572.985675358111;552.1772558887309;560.3471955172179;579.631933722081;624.4224092714312;648.4617767253169;8802.955985220033;8897.377183597086;9038.728838134866;9169.587368568431;9816.656417025513;593.7832691067729;697.9022936788854;708.7802781137864;724.6521669598623;743.4275607781977;4418.0059486615255;4483.125790470827;4488.528704486047;4591.403117594758;4646.83736069236;59214;59634.70182649059;60067;60654;60748.39251607427;54885.451145488834;54911;55794.442055578926;55795.72102139463;56133.719331403896;48259.517404826205;49273.26090108651;49278.26082608764;50077.74961125171;50157;8758.956205218934;9006.459612423276;9033.77415564616;9057.456552606865;9150.40522366044;37378.43932340963;37473.81263093667;38147.42778858375;38604;38801.223975519766;44208.778956105016;48148.27777583409;48209.75895120502;48235.75882120567;48751.26873096977;11568;11624.476898539417;11727;11727.120465964916;11979.401029948642;12670.936645316715;12688.251508009707;12825.294608796607;13637.795433068313;13763.243021633907;11240.156988225752;11440.313581185155;11550;11792.941035294769;12200.14598978063;11873.228240164362;11919.76160476803;11932.522699091938;12150.878491214975;12422.813657795321;9817.460039697886;10691.5188816505;10707.785844282915;11368.317900925971;11821.349825759666;10681.46592670379;10792.622258220925;11272.267302625303;11320.37737924422;11368.147388945697;9987.300888937705;10112.988701129829;10272.640457583948;10307.226957978331;10365.222608304559 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,955 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: __startTimestamp1453718566062__endTimestamp 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,068 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5488.76 Median:5620.16 stddev:593.53 (10.6%) stddev-sans-first:570.28 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: Values: 3313.0 3372.3 3399.9 3413.6 3428.2 5546.3 5565.3 5578.7 5584.2 5592.4 5587.6 5591.4 5598.0 5599.7 5603.5 4762.5 5085.7 5120.3 5175.3 5228.1 5033.9 5078.0 5079.7 5093.8 5094.3 4970.2 5008.4 5053.8 5054.6 5058.5 4968.2 5035.8 5059.2 5063.3 5070.8 5021.3 5057.3 5123.6 5134.4 5169.9 5156.9 5173.7 5252.0 5379.5 5410.0 5928.2 5944.3 5960.3 5975.9 5980.8 5960.5 5966.6 5970.6 5972.9 6009.6 5281.7 5383.7 5530.9 5556.9 5584.2 6069.3 6070.4 6087.6 6087.8 6089.9 5908.9 5914.3 5918.5 5921.7 5923.4 5612.7 5717.6 6000.0 6008.8 6021.8 5801.6 5910.2 5918.5 5918.8 5931.0 5790.4 5928.5 5988.7 5988.8 5991.1 4387.4 4474.6 4509.4 4521.1 4581.3 4042.4 4073.1 4083.9 4085.4 4106.0 5576.7 5586.2 5586.9 5589.5 5616.7 5660.1 5753.7 5768.9 5874.9 5914.5 5598.5 5603.0 5604.2 5620.2 5622.2 5178.1 5184.7 5185.1 5190.2 5215.7 5767.1 5904.5 5953.6 6071.4 6097.2 5950.0 5969.9 5972.2 5975.5 5984.8 5750.8 6095.5 6120.2 6120.3 6127.2 5652.9 5688.9 5756.7 5765.3 5799.7 5934.4 5960.9 5987.4 6000.9 6004.1 5547.9 5658.1 5836.7 5857.8 5871.1 5713.9 5801.9 5803.7 5806.8 5835.3 5657.8 5665.1 5669.7 5672.7 5690.9 5565.4 5578.8 5661.3 5771.6 5790.3 5524.5 5541.7 5543.6 5548.4 5549.3 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55558.18 Median:221737.90 stddev:95813.44 (43.2%) stddev-sans-first:95993.21 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: Values: 552.6 595.6 607.4 634.4 636.4 31945.8 40333.8 40620.8 40725.0 40793.2 45779.5 46516.3 46570.8 46612.0 46719.3 7934.6 8057.3 8936.0 9013.7 10401.9 10760.6 10893.3 10904.5 10913.3 10916.7 10745.9 10747.3 10816.4 10845.2 10864.5 8262.3 8380.7 10941.5 11175.3 11190.9 10659.6 10740.3 10789.7 10795.3 10810.9 42965.0 43423.3 43527.8 43558.1 43564.1 3411.2 3494.9 3741.6 3992.8 4040.8 31979.7 37106.0 37264.8 37278.8 37320.3 3944.1 4017.1 4043.7 4044.4 4199.2 280544.0 286835.0 287426.6 287660.0 287812.0 60702.1 61609.0 67103.7 67318.3 68525.0 71329.6 71942.6 72401.6 72423.6 72504.6 16164.6 17198.4 17220.6 17226.6 17243.0 12604.7 12623.4 12707.2 12710.1 12726.2 22563.5 22897.0 22962.9 23011.5 23031.5 8718.9 9042.4 9068.5 9106.3 9185.7 1012.7 1118.9 1133.2 1133.2 1141.6 33321.2 34102.5 34160.1 34317.0 34684.0 1111.1 1129.8 1185.5 1198.7 1210.7 14411.7 16943.2 17356.7 17390.4 17423.9 436662.0 441328.0 441343.0 442828.0 443991.0 58844.0 59247.1 59283.4 59320.4 59392.7 1363.4 1418.1 1458.4 1460.8 1490.7 25024.0 29980.7 30416.8 30797.8 31133.8 52442.5 53020.0 53166.5 53194.7 53454.2 294418.0 315614.0 317012.0 403142.0 407714.0 47015.8 47088.5 47460.3 48088.5 48901.5 49898.3 50053.2 50374.2 50901.0 51099.5 41636.0 41720.8 41761.4 42377.4 42967.0 42750.8 43133.4 43453.1 43467.6 43990.6 46340.0 46924.3 47180.5 47510.0 47821.0 39213.6 41453.9 43830.3 44012.3 44086.3 31797.8 32028.5 32172.2 32203.6 33101.2 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31382.28 Median:1982.94 stddev:98178.94 (4951.2%) stddev-sans-first:98426.75 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: Values: 379.3 385.2 389.2 389.9 395.4 15235.3 15320.5 16788.3 18076.6 18179.1 18022.9 18135.5 18344.1 18350.3 18485.9 5956.5 6124.5 6127.9 6145.9 6151.2 4562.6 4664.5 5985.6 6648.4 6908.7 5378.1 6825.4 6850.2 6855.9 6890.1 5583.6 5589.6 5611.3 5613.1 5619.6 5314.4 5410.5 5433.6 5433.9 5465.8 12501.4 12531.9 12545.5 12644.7 21563.5 2190.2 2286.9 2331.7 2343.4 2406.8 10275.1 10368.6 10674.6 13774.2 14318.2 1924.8 1957.7 1970.9 1995.0 2043.2 64980.5 67154.3 67746.0 68381.7 68611.7 10953.9 11092.7 11101.2 11101.7 11195.2 13687.9 13868.1 13969.3 14039.4 14545.2 7859.1 8002.2 8084.3 8158.9 8167.2 7674.3 7762.6 7777.5 7811.5 7819.1 4268.9 4564.8 4615.5 4682.3 4810.8 1726.9 1779.5 1788.2 1788.8 1877.6 1039.4 1051.9 1055.1 1069.9 1104.0 17580.8 17598.7 17627.6 17640.0 17909.8 865.3 984.5 996.9 1000.3 1023.0 9555.0 9804.4 9821.0 9864.4 9996.3 591196.0 595095.0 603074.0 606291.0 606376.0 85771.0 86495.1 88774.6 88853.6 89249.0 1223.3 1231.5 1236.0 1241.7 1251.8 15120.8 15123.1 15255.6 15394.6 15638.4 35285.5 35775.6 36324.8 36561.8 36951.0 49907.0 51636.0 53638.7 53685.5 54584.5 10245.3 10253.2 10319.3 10475.0 10627.7 18256.9 18319.7 18339.9 18717.6 18777.8 12544.6 13996.7 14328.7 14492.4 14719.2 13550.5 14138.9 14223.6 14318.7 14653.2 14538.9 14685.7 14793.4 15028.9 15094.8 9529.3 9824.3 9906.0 10112.7 10273.9 13737.0 14463.9 14937.0 15293.4 15335.1 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,070 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5348.98 Median:6366.61 stddev:2772.79 (43.6%) stddev-sans-first:2764.57 02:42:46 INFO - 2016-01-25 02:42:46,071 DEBUG : BROWSER_OUTPUT: Values: 1386.4 1517.2 1523.0 1795.4 1827.3 6671.2 7401.0 7633.0 7634.2 7642.6 7575.2 7726.6 7728.8 7741.7 7746.0 1993.6 2020.1 2022.9 2218.8 2258.5 2250.1 2295.5 2299.0 2304.5 2306.8 2177.8 2200.1 2202.9 2225.6 2250.0 2138.4 2173.9 2191.0 2207.5 2208.1 2245.1 2253.5 2265.0 2265.8 2272.6 7602.5 7682.3 7699.0 7726.6 7743.5 4431.1 4507.6 4510.1 4523.9 4537.7 2933.9 2960.6 3003.0 3014.2 3030.3 935.4 947.5 965.9 1011.4 1021.3 10393.1 10406.9 10425.8 10434.3 10439.5 4040.2 4055.8 4109.0 4109.3 4122.1 8904.3 8911.2 8921.0 8923.8 8930.9 4506.5 4513.8 4534.9 4536.5 4537.0 4103.5 4110.3 4119.9 4125.3 4139.7 3277.0 3434.4 3683.7 3686.8 3731.4 1122.7 1138.7 1141.2 1144.7 1149.9 1073.0 1106.6 1107.2 1281.6 1385.0 6790.6 6822.8 6874.8 6877.0 6904.6 1082.2 1095.6 1143.4 1152.8 1157.2 5518.4 5614.4 5615.2 5623.4 5627.0 8962.1 9047.1 9188.1 9213.8 9310.4 9128.7 9188.4 9203.0 9212.0 9219.1 7110.1 7312.0 7354.0 7354.3 7359.5 7121.5 7144.5 7170.2 7182.7 7185.4 8166.2 8227.8 8373.2 8426.5 8453.0 8453.7 8534.9 8656.3 8665.7 8673.9 6642.5 6831.8 6857.6 6863.3 6907.6 6554.7 6776.3 6990.8 7469.9 7531.3 6895.3 6899.8 6941.1 7009.5 7027.3 6849.7 6896.1 6926.6 6943.5 6985.9 6856.3 6894.7 6895.8 6905.0 6910.1 6162.8 6310.6 6339.4 6345.1 6388.1 6390.4 6419.0 6427.7 6432.0 6439.3 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5473.78 Median:6229.49 stddev:1629.03 (26.2%) stddev-sans-first:1587.34 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: Values: 338.2 339.0 351.0 359.0 359.7 6052.2 6142.6 6158.8 6203.1 6208.6 5896.7 6063.5 6063.6 6082.4 6090.3 4753.6 4756.3 4757.1 4765.3 4772.0 4567.1 4609.6 4647.9 4703.9 4739.8 4635.7 4647.0 4654.0 4657.6 4677.7 4638.8 4642.5 4650.3 4661.0 4674.3 4085.8 4087.2 4092.7 4095.9 4096.9 5754.8 5843.2 5850.1 5870.8 5879.1 5468.0 5472.8 5480.6 5483.4 5486.2 6133.9 6472.8 6480.0 6485.5 6497.8 4488.0 4502.6 4599.7 4619.1 4657.3 6695.2 6702.5 6706.2 6720.8 6723.1 4711.4 4766.4 4768.5 4769.2 4781.8 4754.5 4826.8 4856.4 4861.5 4875.5 5486.9 5514.2 5524.3 5529.4 5538.0 6519.1 6551.2 6553.9 6555.0 6557.7 1679.0 1705.6 1705.8 1706.4 1714.9 1130.4 1172.1 1194.1 1200.8 1201.2 6354.4 6356.0 6360.7 6361.1 6363.8 6753.7 6761.1 6765.4 6768.4 6772.0 6250.4 6346.6 6348.1 6352.5 6361.0 3620.0 3654.2 3655.4 3659.4 3659.5 6889.2 6910.9 6915.8 6929.2 6932.3 6757.9 6870.5 6896.5 6907.7 6916.0 6898.6 6898.9 6902.8 6907.1 6919.0 6415.2 6657.8 6710.0 6737.9 6754.7 6603.2 6620.7 6658.5 6684.4 6686.0 6943.2 6955.5 6957.1 6958.8 6974.2 4575.3 4665.6 4683.8 4769.6 4821.0 6730.7 6758.7 6761.2 6773.2 6776.5 6591.8 6593.7 6594.7 6595.0 6596.7 6410.9 6515.9 6560.7 6574.0 6574.6 6454.1 6459.6 6465.6 6468.4 6472.6 6580.1 6582.6 6587.1 6591.7 6594.6 6350.5 6435.2 6467.1 6491.4 6498.3 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14563.78 Median:4716.34 stddev:16803.45 (356.3%) stddev-sans-first:16819.05 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: Values: 854.6 858.3 882.4 895.3 899.1 13655.9 13893.7 13933.2 13933.7 13945.9 13792.4 13872.9 13888.2 13908.9 13911.5 756.2 759.4 889.0 899.5 921.3 901.9 902.7 907.5 907.9 909.4 798.6 950.1 960.6 961.7 962.8 799.8 801.2 932.6 949.6 951.0 709.1 709.7 710.1 710.1 710.9 13109.3 13186.7 13284.3 13292.9 13317.9 12736.7 13301.0 13465.6 13506.7 13510.7 10994.4 11152.6 11192.9 11193.0 11360.0 3794.2 3830.9 3839.3 3883.6 3904.7 47602.5 47936.0 48271.3 48310.8 48598.3 10629.1 10682.1 10683.5 10738.4 11116.0 19040.2 19051.0 19075.4 19095.6 19117.0 8208.2 8228.2 8233.9 8321.8 8327.3 4639.9 4696.1 4736.6 4787.8 4858.4 2983.1 3015.4 3018.1 3020.4 3026.7 555.2 556.1 566.7 566.9 573.0 552.2 560.3 579.6 624.4 648.5 8803.0 8897.4 9038.7 9169.6 9816.7 593.8 697.9 708.8 724.7 743.4 4418.0 4483.1 4488.5 4591.4 4646.8 59214.0 59634.7 60067.0 60654.0 60748.4 54885.5 54911.0 55794.4 55795.7 56133.7 48259.5 49273.3 49278.3 50077.7 50157.0 8759.0 9006.5 9033.8 9057.5 9150.4 37378.4 37473.8 38147.4 38604.0 38801.2 44208.8 48148.3 48209.8 48235.8 48751.3 11568.0 11624.5 11727.0 11727.1 11979.4 12670.9 12688.3 12825.3 13637.8 13763.2 11240.2 11440.3 11550.0 11792.9 12200.1 11873.2 11919.8 11932.5 12150.9 12422.8 9817.5 10691.5 10707.8 11368.3 11821.3 10681.5 10792.6 11272.3 11320.4 11368.1 9987.3 10113.0 10272.6 10307.2 10365.2 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:42:46 INFO - 2016-01-25 02:42:46,072 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,746 INFO : Browser exited with error code: 0 02:42:46 INFO - 2016-01-25 02:42:46,764 INFO : Completed test dromaeo_css (00:18:31) 02:42:46 INFO - 2016-01-25 02:42:46,764 INFO : Starting test kraken 02:42:46 INFO - 2016-01-25 02:42:46,764 DEBUG : operating with platform_type : linux_ 02:42:46 INFO - 2016-01-25 02:42:46,764 INFO : Initialising browser for kraken test... 02:42:46 INFO - 2016-01-25 02:42:46,771 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2wcLB8/profile http://localhost:32966/getInfo.html 02:42:50 INFO - 2016-01-25 02:42:50,815 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:42:50 INFO - 2016-01-25 02:42:50,815 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:42:50 INFO - 2016-01-25 02:42:50,815 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:42:50 INFO - 2016-01-25 02:42:50,815 DEBUG : BROWSER_OUTPUT: __metrics 02:42:50 INFO - 2016-01-25 02:42:50,964 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] 02:42:51 INFO - 2016-01-25 02:42:51,741 INFO : Browser initialized. 02:42:51 INFO - 2016-01-25 02:42:51,742 INFO : Running cycle 1/1 for kraken test... 02:42:51 INFO - 2016-01-25 02:42:51,742 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2wcLB8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:43:03 INFO - 2016-01-25 02:43:03,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 137089024 02:43:03 INFO - 2016-01-25 02:43:03,577 DEBUG : BROWSER_OUTPUT: 02:43:06 INFO - 2016-01-25 02:43:06,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:06 INFO - 2016-01-25 02:43:06,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 169598976 02:43:06 INFO - 2016-01-25 02:43:06,615 DEBUG : BROWSER_OUTPUT: 02:43:09 INFO - 2016-01-25 02:43:09,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-dft) 02:43:09 INFO - 2016-01-25 02:43:09,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 167575552 02:43:09 INFO - 2016-01-25 02:43:09,759 DEBUG : BROWSER_OUTPUT: 02:43:12 INFO - 2016-01-25 02:43:12,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-fft) 02:43:13 INFO - 2016-01-25 02:43:13,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 164519936 02:43:13 INFO - 2016-01-25 02:43:13,115 DEBUG : BROWSER_OUTPUT: 02:43:15 INFO - 2016-01-25 02:43:15,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-oscillator) 02:43:15 INFO - 2016-01-25 02:43:15,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 163790848 02:43:15 INFO - 2016-01-25 02:43:15,666 DEBUG : BROWSER_OUTPUT: 02:43:17 INFO - 2016-01-25 02:43:17,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32966/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:18 INFO - 2016-01-25 02:43:18,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 164651008 02:43:18 INFO - 2016-01-25 02:43:18,401 DEBUG : BROWSER_OUTPUT: 02:43:21 INFO - 2016-01-25 02:43:21,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32966/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:21 INFO - 2016-01-25 02:43:21,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 162549760 02:43:21 INFO - 2016-01-25 02:43:21,832 DEBUG : BROWSER_OUTPUT: 02:43:25 INFO - 2016-01-25 02:43:25,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32966/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:25 INFO - 2016-01-25 02:43:25,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 165367808 02:43:25 INFO - 2016-01-25 02:43:25,743 DEBUG : BROWSER_OUTPUT: 02:43:28 INFO - 2016-01-25 02:43:28,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32966/tests/kraken/driver.html?testName=json-parse-financial) 02:43:29 INFO - 2016-01-25 02:43:29,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 165163008 02:43:29 INFO - 2016-01-25 02:43:29,006 DEBUG : BROWSER_OUTPUT: 02:43:30 INFO - 2016-01-25 02:43:30,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32966/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:43:31 INFO - 2016-01-25 02:43:31,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 171761664 02:43:31 INFO - 2016-01-25 02:43:31,087 DEBUG : BROWSER_OUTPUT: 02:43:32 INFO - 2016-01-25 02:43:32,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:43:33 INFO - 2016-01-25 02:43:33,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 168042496 02:43:33 INFO - 2016-01-25 02:43:33,424 DEBUG : BROWSER_OUTPUT: 02:43:35 INFO - 2016-01-25 02:43:35,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:43:35 INFO - 2016-01-25 02:43:35,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 174977024 02:43:35 INFO - 2016-01-25 02:43:35,958 DEBUG : BROWSER_OUTPUT: 02:43:38 INFO - 2016-01-25 02:43:38,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:38 INFO - 2016-01-25 02:43:38,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 180375552 02:43:38 INFO - 2016-01-25 02:43:38,871 DEBUG : BROWSER_OUTPUT: 02:43:41 INFO - 2016-01-25 02:43:41,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:43:41 INFO - 2016-01-25 02:43:41,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 180060160 02:43:41 INFO - 2016-01-25 02:43:41,976 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32966/tests/kraken/driver.html?testName=ai-astar) 02:43:43 INFO - 2016-01-25 02:43:43,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 237572096 02:43:43 INFO - 2016-01-25 02:43:43,887 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,891 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:43:43 INFO - 2016-01-25 02:43:43,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:43:43 INFO - 2016-01-25 02:43:43,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:43:43 INFO - 2016-01-25 02:43:43,892 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:43:43 INFO - 2016-01-25 02:43:43,892 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;109;110;111;101;110;110;112 02:43:43 INFO - 2016-01-25 02:43:43,892 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;120;146;156;130;146;160;128;158;122 02:43:43 INFO - 2016-01-25 02:43:43,892 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;161;161;161;162;162;162;168 02:43:43 INFO - 2016-01-25 02:43:43,893 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;70;145;71;72;72;73;149;71 02:43:43 INFO - 2016-01-25 02:43:43,893 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;139;92;93;92;144;92;91;131 02:43:43 INFO - 2016-01-25 02:43:43,893 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;109;109;109;109 02:43:43 INFO - 2016-01-25 02:43:43,893 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;145;146;145;146;145;147 02:43:43 INFO - 2016-01-25 02:43:43,893 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;95;96;95 02:43:43 INFO - 2016-01-25 02:43:43,894 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;55;55;56;58;56;56;54;54 02:43:43 INFO - 2016-01-25 02:43:43,894 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;64;65;63;63;62;63 02:43:43 INFO - 2016-01-25 02:43:43,894 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;79;81;81;81;79;81;81;82;82 02:43:43 INFO - 2016-01-25 02:43:43,894 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;119;110;115;107;112;115;115;121;112 02:43:43 INFO - 2016-01-25 02:43:43,895 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;143;143;141;141;151;143;150;140;142 02:43:43 INFO - 2016-01-25 02:43:43,895 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;62;66;64;63;67;64;63;63;63 02:43:43 INFO - 2016-01-25 02:43:43,895 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:43:43 INFO - 2016-01-25 02:43:43,895 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:43:43 INFO - 2016-01-25 02:43:43,895 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,914 02:43:43 INFO - 2016-01-25 02:43:43,896 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:43:43 INFO - 2016-01-25 02:43:43,896 DEBUG : BROWSER_OUTPUT: __startTimestamp1453718623889__endTimestamp 02:43:43 INFO - 2016-01-25 02:43:43,896 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,898 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:43:43 INFO - 2016-01-25 02:43:43,898 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:43:43 INFO - 2016-01-25 02:43:43,898 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,899 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.35 (3.0%) stddev-sans-first:3.53 02:43:43 INFO - 2016-01-25 02:43:43,899 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 109.0 110.0 111.0 101.0 110.0 110.0 112.0 02:43:43 INFO - 2016-01-25 02:43:43,899 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,899 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.00 Median:150.00 stddev:15.55 (10.4%) stddev-sans-first:15.87 02:43:43 INFO - 2016-01-25 02:43:43,900 DEBUG : BROWSER_OUTPUT: Values: 154.0 120.0 146.0 156.0 130.0 146.0 160.0 128.0 158.0 122.0 02:43:43 INFO - 2016-01-25 02:43:43,900 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,900 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.11 (1.3%) stddev-sans-first:2.22 02:43:43 INFO - 2016-01-25 02:43:43,900 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 162.0 168.0 02:43:43 INFO - 2016-01-25 02:43:43,901 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,901 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.30 Median:72.00 stddev:31.55 (43.8%) stddev-sans-first:33.29 02:43:43 INFO - 2016-01-25 02:43:43,901 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 70.0 145.0 71.0 72.0 72.0 73.0 149.0 71.0 02:43:43 INFO - 2016-01-25 02:43:43,901 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,901 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:92.00 stddev:22.44 (24.4%) stddev-sans-first:23.24 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 139.0 92.0 93.0 92.0 144.0 92.0 91.0 131.0 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 147.0 02:43:43 INFO - 2016-01-25 02:43:43,902 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,903 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:43:43 INFO - 2016-01-25 02:43:43,903 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 02:43:43 INFO - 2016-01-25 02:43:43,903 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,903 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.24 02:43:43 INFO - 2016-01-25 02:43:43,903 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 55.0 55.0 56.0 58.0 56.0 56.0 54.0 54.0 02:43:43 INFO - 2016-01-25 02:43:43,903 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,904 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 64.0 65.0 63.0 63.0 62.0 63.0 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:1.35 (1.7%) stddev-sans-first:1.09 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: Values: 78.0 79.0 81.0 81.0 81.0 79.0 81.0 81.0 82.0 82.0 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.10 Median:115.00 stddev:4.09 (3.6%) stddev-sans-first:4.33 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: Values: 115.0 119.0 110.0 115.0 107.0 112.0 115.0 115.0 121.0 112.0 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,905 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:143.00 stddev:3.80 (2.7%) stddev-sans-first:3.96 02:43:43 INFO - 2016-01-25 02:43:43,906 DEBUG : BROWSER_OUTPUT: Values: 146.0 143.0 143.0 141.0 141.0 151.0 143.0 150.0 140.0 142.0 02:43:43 INFO - 2016-01-25 02:43:43,906 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,906 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 02:43:43 INFO - 2016-01-25 02:43:43,906 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 66.0 64.0 63.0 67.0 64.0 63.0 63.0 63.0 02:43:43 INFO - 2016-01-25 02:43:43,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:43:43 INFO - 2016-01-25 02:43:43,906 DEBUG : BROWSER_OUTPUT: 02:43:44 INFO - 2016-01-25 02:43:44,730 INFO : Browser exited with error code: 0 02:43:44 INFO - 2016-01-25 02:43:44,780 INFO : Completed test kraken (00:00:58) 02:43:44 INFO - 2016-01-25 02:43:44,780 INFO : Starting test v8_7 02:43:44 INFO - 2016-01-25 02:43:44,780 DEBUG : operating with platform_type : linux_ 02:43:44 INFO - 2016-01-25 02:43:44,780 INFO : Initialising browser for v8_7 test... 02:43:44 INFO - 2016-01-25 02:43:44,786 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpauXg7y/profile http://localhost:32966/getInfo.html 02:43:48 INFO - 2016-01-25 02:43:48,443 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:43:48 INFO - 2016-01-25 02:43:48,443 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:43:48 INFO - 2016-01-25 02:43:48,443 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:43:48 INFO - 2016-01-25 02:43:48,443 DEBUG : BROWSER_OUTPUT: __metrics 02:43:48 INFO - 2016-01-25 02:43:48,600 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] 02:43:49 INFO - 2016-01-25 02:43:49,707 INFO : Browser initialized. 02:43:49 INFO - 2016-01-25 02:43:49,708 INFO : Running cycle 1/1 for v8_7 test... 02:43:49 INFO - 2016-01-25 02:43:49,708 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpauXg7y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:44:01 INFO - 2016-01-25 02:44:01,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 137125888 02:44:01 INFO - 2016-01-25 02:44:01,501 DEBUG : BROWSER_OUTPUT: 02:44:22 INFO - 2016-01-25 02:44:22,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32966/tests/v8_7/run.html (next: http://localhost:32966/tests/v8_7/run.html) 02:44:23 INFO - 2016-01-25 02:44:23,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 427606016 02:44:23 INFO - 2016-01-25 02:44:23,134 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,135 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:44:23 INFO - 2016-01-25 02:44:23,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:44:23 INFO - 2016-01-25 02:44:23,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:44:23 INFO - 2016-01-25 02:44:23,136 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:44:23 INFO - 2016-01-25 02:44:23,136 DEBUG : BROWSER_OUTPUT: |0;Richards;164.63615409944023 02:44:23 INFO - 2016-01-25 02:44:23,136 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.10022503029253 02:44:23 INFO - 2016-01-25 02:44:23,136 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 02:44:23 INFO - 2016-01-25 02:44:23,136 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 02:44:23 INFO - 2016-01-25 02:44:23,137 DEBUG : BROWSER_OUTPUT: |4;RayTrace;959.6928982725528 02:44:23 INFO - 2016-01-25 02:44:23,137 DEBUG : BROWSER_OUTPUT: |5;Earley;558.659217877095 02:44:23 INFO - 2016-01-25 02:44:23,137 DEBUG : BROWSER_OUTPUT: |6;Boyer;11065.934065934065 02:44:23 INFO - 2016-01-25 02:44:23,137 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 02:44:23 INFO - 2016-01-25 02:44:23,138 DEBUG : BROWSER_OUTPUT: |8;Splay;527.9831045406547 02:44:23 INFO - 2016-01-25 02:44:23,138 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 02:44:23 INFO - 2016-01-25 02:44:23,138 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:44:23 INFO - 2016-01-25 02:44:23,138 DEBUG : BROWSER_OUTPUT: __startTimestamp1453718663134__endTimestamp 02:44:23 INFO - 2016-01-25 02:44:23,139 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:44:23 INFO - 2016-01-25 02:44:23,139 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:44:23 INFO - 2016-01-25 02:44:23,139 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,139 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,140 DEBUG : BROWSER_OUTPUT: Values: 164.6 02:44:23 INFO - 2016-01-25 02:44:23,140 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,140 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.10 Median:173.10 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,140 DEBUG : BROWSER_OUTPUT: Values: 173.1 02:44:23 INFO - 2016-01-25 02:44:23,141 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,141 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,142 DEBUG : BROWSER_OUTPUT: Values: 278.9 02:44:23 INFO - 2016-01-25 02:44:23,142 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,142 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,142 DEBUG : BROWSER_OUTPUT: Values: 5186.5 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:959.69 Median:959.69 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: Values: 959.7 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:558.66 Median:558.66 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: Values: 558.7 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11065.93 Median:11065.93 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: Values: 11065.9 02:44:23 INFO - 2016-01-25 02:44:23,143 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: Values: 24238.1 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.98 Median:527.98 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: Values: 528.0 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: Values: 4826.9 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:44:23 INFO - 2016-01-25 02:44:23,144 DEBUG : BROWSER_OUTPUT: 02:44:23 INFO - 2016-01-25 02:44:23,914 INFO : Browser exited with error code: 0 02:44:23 INFO - 2016-01-25 02:44:23,932 INFO : Completed test v8_7 (00:00:39) 02:44:24 INFO - 2016-01-25 02:44:24,177 INFO : Completed test suite (00:20:09) 02:44:24 INFO - 2016-01-25 02:44:24,177 DEBUG : Working with test: dromaeo_css 02:44:24 INFO - 2016-01-25 02:44:24,177 DEBUG : Generating results file: dromaeo_css 02:44:24 INFO - 2016-01-25 02:44:24,178 DEBUG : Working with test: kraken 02:44:24 INFO - 2016-01-25 02:44:24,179 DEBUG : Generating results file: kraken 02:44:24 INFO - 2016-01-25 02:44:24,179 INFO : javascript benchmark 02:44:24 INFO - 2016-01-25 02:44:24,179 DEBUG : Working with test: v8_7 02:44:24 INFO - 2016-01-25 02:44:24,179 DEBUG : Generating results file: v8_7 02:44:24 INFO - 2016-01-25 02:44:24,180 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:44:24 INFO - 2016-01-25 02:44:24,241 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 02:44:24 INFO - 2016-01-25 02:44:24,241 DEBUG : process_Request line: dromaeo_css 7358.39 graph.html#tests=[[72,52,35]] 02:44:24 INFO - 2016-01-25 02:44:24,241 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:44:24 INFO - 2016-01-25 02:44:24,272 DEBUG : process_Request line: kraken 1477.70 graph.html#tests=[[232,52,35]] 02:44:24 INFO - 2016-01-25 02:44:24,272 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:44:24 INFO - 2016-01-25 02:44:24,304 DEBUG : process_Request line: v8_7 22987.28 graph.html#tests=[[230,52,35]] 02:44:24 INFO - 2016-01-25 02:44:24,306 INFO : javascript benchmark 02:44:24 INFO - 2016-01-25 02:44:24,309 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3312.9503057454144, 3372.325534893022, 3399.8980030599073, 3413.590369155702, 3428.2457859270967, 5546.334439867216, 5565.276514053173, 5578.736668094048, 5584.246126772884, 5592.412796656354, 5587.636803607773, 5591.440855914407, 5597.972010139953, 5599.7480113394895, 5603.523700485463, 4762.452317983424, 5085.720285384303, 5120.334356533664, 5175.327207463025, 5228.0589493891275, 5033.899322013557, 5077.974610126944, 5079.720615366154, 5093.770780314895, 5094.261332106842, 4970.204767237243, 5008.373953255843, 5053.772580233898, 5054.570361519275, 5058.544730974211, 4968.1554135797005, 5035.84892453227, 5059.241113832918, 5063.3417655704525, 5070.797168113271, 5021.322121513585, 5057.317262169597, 5123.615728820316, 5134.435212126663, 5169.922451163198, 5156.948430515685, 5173.715445650488, 5252.028374750684, 5379.488948549882, 5410.0, 5928.199693041427, 5944.316403613597, 5960.314563825129, 5975.940240597582, 5980.820575382745, 5960.523158147381, 5966.552508561832, 5970.641761494281, 5972.880542389128, 6009.6394216346725, 5281.656692315026, 5383.650062745909, 5530.917036244459, 5556.861078473071, 5584.162375643686, 6069.302030266487, 6070.423309785651, 6087.568717326535, 6087.811893003903, 6089.939100608937, 5908.940910590925, 5914.349421563625, 5918.526517878559, 5921.73352199152, 5923.437273459014, 5612.747426365823, 5717.571182161271, 6000.019943559715, 6008.819735407945, 6021.819345419644, 5801.622894511843, 5910.202122713465, 5918.526517878559, 5918.822435326947, 5931.0, 5790.36306006339, 5928.466438020599, 5988.700564971734, 5988.760449582055, 5991.101334799728, 4387.3857659927635, 4474.619657329098, 4509.413776209072, 4521.118381915495, 4581.312803079565, 4042.3734321180264, 4073.1492142291117, 4083.9387409188885, 4085.428040074392, 4105.952981989573, 5576.665400076008, 5586.217929489874, 5586.91619625706, 5589.469000444951, 5616.747246373923, 5660.122680984454, 5753.741081651336, 5768.913466298009, 5874.853128671732, 5914.497267732205, 5598.524125449301, 5603.047481928082, 5604.243427137284, 5620.156976453564, 5622.212890195376, 5178.0679477694375, 5184.688918664892, 5185.092608793446, 5190.195519694454, 5215.687058776485, 5767.077267637158, 5904.527637788967, 5953.553483488756, 6071.3928607139815, 6097.237845269341, 5950.047992321208, 5969.910451343147, 5972.223610930551, 5975.492083172805, 5984.820455386345, 5750.7987220447085, 6095.451409373178, 6120.17377654011, 6120.326764056039, 6127.172831667668, 5652.943470565242, 5688.857778555569, 5756.740946657326, 5765.308163020464, 5799.652020878761, 5934.376890426615, 5960.910586341295, 5987.43119403656, 6000.8799824004145, 6004.1294012368835, 5547.944520554743, 5658.094704847204, 5836.737346819318, 5857.7949771757785, 5871.089981052944, 5713.942860571341, 5801.8549536261935, 5803.709814509173, 5806.82579522615, 5835.299764028344, 5657.773689052392, 5665.12190610456, 5669.659820410789, 5672.688002159755, 5690.886182276414, 5565.38780734127, 5578.776848925998, 5661.348944871393, 5771.59598828078, 5790.305163380422, 5524.475174858382, 5541.667499950016, 5543.61194716366, 5548.445155484419, 5549.278593782782], "unit": "ms", "name": "dojo.html", "value": 5451.781757127166}, {"lowerIsBetter": false, "replicates": [552.5717568884114, 595.5563105486411, 607.4472230270453, 634.4068296143107, 636.4081404294011, 31945.840270798642, 40333.798331008344, 40620.796896015476, 40725.0, 40793.18413631726, 45779.54220457794, 46516.302255466195, 46570.767146164304, 46612.0, 46719.29921051187, 7934.642941067637, 8057.274845263925, 8935.955320223406, 9013.729588112334, 10401.895981040168, 10760.569577216942, 10893.346399216032, 10904.454777261144, 10913.34519928803, 10916.672499824977, 10745.946270268638, 10747.301425407324, 10816.405097719622, 10845.186611004166, 10864.45677716115, 8262.339012878956, 8380.748577542652, 10941.507632156572, 11175.329480231212, 11190.94404527972, 10659.626913058084, 10740.301880377829, 10789.676309710721, 10795.29830561011, 10810.891891081146, 42965.0, 43423.348649770276, 43527.782361088306, 43558.12883742339, 43564.128717425476, 3411.164264755126, 3494.8776792812127, 3741.6071312512067, 3992.8003599819895, 4040.8181631826637, 31979.680203197902, 37106.0, 37264.813675931444, 37278.81360593207, 37320.25359492822, 3944.073142811437, 4017.0961533654986, 4043.696722745806, 4044.3529035354204, 4199.202151591218, 280544.0, 286835.0, 287426.56286718644, 287660.0, 287812.0, 60702.08946865801, 61609.0, 67103.66448167728, 67318.32681673218, 68525.0, 71329.64335178291, 71942.64028679927, 72401.63799181076, 72423.6378818113, 72504.63747681334, 16164.595885102732, 17198.398056067977, 17220.569485762957, 17226.569335766708, 17243.0, 12604.684882877818, 12623.431945562472, 12707.237565746085, 12710.110292279453, 12726.17279876805, 22563.548729025326, 22897.0, 22962.851857407397, 23011.539769204523, 23031.539369212856, 8718.866547348804, 9042.367034307536, 9068.455892646462, 9106.31702622306, 9185.678501252558, 1012.6911292055994, 1118.8713297970676, 1133.1727838677646, 1133.18410744264, 1141.634676903383, 33321.16697082592, 34102.48846267308, 34160.14599635029, 34317.0, 34684.0, 1111.0833562311125, 1129.7627498225465, 1185.4546908422221, 1198.7422704118655, 1210.7336385995068, 14411.711765764627, 16943.237554310086, 17356.739648905277, 17390.391336303423, 17423.91288043577, 436662.0, 441328.0, 441343.0, 442828.0, 443991.0, 58844.0, 59247.111293330636, 59283.40716592865, 59320.40679593235, 59392.70303648541, 1363.4478036395276, 1418.1278513713992, 1458.358322338168, 1460.8393076761547, 1490.6646004649085, 25024.0, 29980.70019299866, 30416.78332866749, 30797.8460107698, 31133.8443307782, 52442.475575243756, 53020.0, 53166.46833531615, 53194.73402632962, 53454.19818702645, 294418.0, 315614.0, 317012.0, 403142.0, 407714.0, 47015.76492117518, 47088.52911470841, 47460.288095677904, 48088.519114808405, 48901.5109848897, 49898.25152622786, 50053.24813631505, 50374.24438633497, 50901.0, 51099.48900510947, 41636.0, 41720.79139604283, 41761.373579395724, 42377.36433953432, 42967.0, 42750.78624606857, 43133.352999705654, 43453.13093738044, 43467.56532434635, 43990.56009439864, 46340.0, 46924.29613555731, 47180.52819471761, 47510.0, 47821.0, 39213.60786392214, 41453.92426686855, 43830.34254486249, 44012.33981490216, 44086.33870491881, 31797.841010794797, 32028.5195722069, 32172.19569510781, 32203.58473114479, 33101.17247068843], "unit": "ms", "name": "ext.html", "value": 21370.83512013628}, {"lowerIsBetter": false, "replicates": [379.27747640744377, 385.1795675211798, 389.16524055900095, 389.91226973930867, 395.4167602785891, 15235.31441085151, 15320.463783767571, 16788.328466861327, 18076.638467230663, 18179.091045447723, 18022.909885450554, 18135.546611334725, 18344.082795860188, 18350.265989360443, 18485.90757046216, 5956.493698035672, 6124.540659450537, 6127.938720612781, 6145.907811382833, 6151.169592105076, 4562.589366956973, 4664.486906440289, 5985.551083668721, 6648.401643852052, 6908.723651053977, 5378.112611419111, 6825.419839313664, 6850.246472887979, 6855.931440685604, 6890.138732658418, 5583.58123140764, 5589.608727389084, 5611.3266408031095, 5613.129964855454, 5619.550435965113, 5314.441983591744, 5410.486003829669, 5433.592480563973, 5433.918491222635, 5465.754041068121, 12501.437435315342, 12531.872131508208, 12545.498180072786, 12644.747105057939, 21563.46091347713, 2190.244365693849, 2286.8856557172076, 2331.708536432946, 2343.402432379732, 2406.7833894949363, 10275.126614237799, 10368.585256589802, 10674.62638807638, 13774.242416667079, 14318.212498312589, 1924.769027716669, 1957.6867701167744, 1970.9211631534722, 1994.950126246841, 2043.2439997201132, 64980.54669044029, 67154.32845671578, 67745.98381024339, 68381.65809170972, 68611.65694171547, 10953.945230273957, 11092.667219983414, 11101.1674124441, 11101.722456938642, 11195.216334856645, 13687.931560342135, 13868.098573592684, 13969.301534923214, 14039.438422462987, 14545.200013999332, 7859.056913170456, 8002.199780022068, 8084.272415482517, 8158.918410815816, 8167.224113709188, 7674.347680447113, 7762.593595985262, 7777.533347999138, 7811.4922530035365, 7819.139894611588, 4268.87193384199, 4564.84023059198, 4615.515370886076, 4682.297655351725, 4810.797300674832, 1726.8602722203286, 1779.5462157149843, 1788.20424910916, 1788.7585176001332, 1877.5681593233633, 1039.449091981251, 1051.921105917044, 1055.055725126008, 1069.9090577301017, 1103.9889601104046, 17580.824191757918, 17598.736018959728, 17627.55931101733, 17640.0, 17909.820901790816, 865.2991077227466, 984.4683870709737, 996.850472429127, 1000.3197825478744, 1022.9641962531275, 9555.001922183896, 9804.411735295906, 9821.0, 9864.358816676893, 9996.250281228937, 591196.0, 595095.0, 603074.0, 606291.0, 606376.0, 85771.0, 86495.1350486487, 88774.55612721895, 88853.55573222222, 89249.0, 1223.2966044524435, 1231.5197073141483, 1236.042067397774, 1241.74544218435, 1251.7621651886113, 15120.773188402403, 15123.092614443169, 15255.618609534851, 15394.615134621725, 15638.374465021272, 35285.47071793977, 35775.64224357827, 36324.818375907955, 36561.81719091388, 36951.0, 49907.0, 51635.96728065342, 53638.73180634072, 53685.46314536805, 54584.454155457934, 10245.282830202112, 10253.231007674305, 10319.329243599143, 10475.0, 10627.734306642396, 18256.9045857249, 18319.725204122216, 18339.908300458414, 18717.6256474867, 18777.812221877608, 12544.623661290176, 13996.720065598834, 14328.713425731636, 14492.420303187755, 14719.190444525653, 13550.525731599346, 14138.929305353407, 14223.64440888986, 14318.71362572722, 14653.194074326015, 14538.90958178162, 14685.706285874436, 14793.408263669333, 15028.924855375653, 15094.773578396112, 9529.285303602119, 9824.312298139348, 9905.950470247602, 10112.747181320527, 10273.9486302568, 13737.0, 14463.85536144625, 14937.0, 15293.388264469297, 15335.079895206323], "unit": "ms", "name": "jquery.html", "value": 9378.003534172052}, {"lowerIsBetter": false, "replicates": [1386.4246337769825, 1517.2337969325497, 1522.9771553426701, 1795.3805936951749, 1827.250827160864, 6671.166104236971, 7401.0, 7633.0458692663415, 7634.160242373341, 7642.5796581188015, 7575.166731659513, 7726.61366931654, 7728.7681369559, 7741.690332386712, 7745.961270193655, 1993.5514509235452, 2020.141439888049, 2022.9190832366762, 2218.8335874809413, 2258.480549473614, 2250.0662225176534, 2295.5064661097863, 2299.0114250872202, 2304.4699719064624, 2306.815454763623, 2177.8148857347064, 2200.0539767899795, 2202.933911982643, 2225.5882661707556, 2249.955000899981, 2138.433315171481, 2173.8695678259355, 2190.9671354929687, 2207.514346843692, 2208.050538268552, 2245.124401483423, 2253.5380247049316, 2264.9547009059725, 2265.8074063704603, 2272.6136556785223, 7602.50583712057, 7682.308592226726, 7698.961505192494, 7726.613669316512, 7743.457957942946, 4431.069475410168, 4507.57178068083, 4510.075434535912, 4523.909521809545, 4537.659675524349, 2933.9266518337, 2960.6003189569346, 3002.9699703002907, 3014.1711029467074, 3030.3030303030205, 935.3592788939599, 947.4504787223462, 965.9130678238993, 1011.3982180602529, 1021.3361315145141, 10393.116585090276, 10406.947965260126, 10425.791484170275, 10434.321769084985, 10439.486274490157, 4040.2323558524376, 4055.8377664893073, 4109.0, 4109.321961876317, 4122.072533679958, 8904.332175086894, 8911.2425443838, 8921.0, 8923.821523569623, 8930.86603700945, 4506.549345065468, 4513.796879140446, 4534.863954081383, 4536.500984891659, 4537.047220083753, 4103.466549348565, 4110.301248787713, 4119.938200926988, 4125.29869922114, 4139.730917490354, 3276.967230327666, 3434.364642541138, 3683.650053244937, 3686.8156592170285, 3731.440283957428, 1122.7361570031198, 1138.709629044605, 1141.1669481278714, 1144.730988217768, 1149.9310041397375, 1073.044989958937, 1106.5794997900907, 1107.1696227829127, 1281.557862537423, 1384.9653758656113, 6790.5925644461495, 6822.829429264308, 6874.759383421556, 6877.0, 6904.620245886525, 1082.199172612277, 1095.6439157273917, 1143.3940011793595, 1152.7521582859727, 1157.2188772578477, 5518.448155184449, 5614.410486898817, 5615.157726341082, 5623.353314368818, 5627.043402621564, 8962.103789621116, 9047.140521650434, 9188.127127922837, 9213.81572368549, 9310.441373517611, 9128.680496182602, 9188.40275382098, 9203.0, 9211.953940230256, 9219.124183202719, 7110.146782386147, 7312.0, 7353.963230183922, 7354.301341372561, 7359.484836061424, 7121.46589005837, 7144.464165187528, 7170.2471240519, 7182.676779545038, 7185.353318201387, 8166.224208700164, 8227.794305142419, 8373.204545568162, 8426.536540490331, 8452.957735211285, 8453.704120355758, 8534.914650853412, 8656.26421754158, 8665.653373864974, 8673.913260867563, 6642.468602511691, 6831.795046148623, 6857.588544687334, 6863.279355667583, 6907.551009184387, 6554.672266386757, 6776.322367763184, 6990.790276291719, 7469.887951680837, 7531.322181003736, 6895.310468953065, 6899.827504312231, 6941.132358455193, 7009.509334346547, 7027.332403421667, 6849.726010959505, 6896.069030680995, 6926.58440493572, 6943.548669336477, 6985.895211571728, 6856.314368563303, 6894.655267236719, 6895.75864844728, 6905.033295338757, 6910.067140935909, 6162.815115546541, 6310.6213627182515, 6339.397757213057, 6345.111684364285, 6388.105665206967, 6390.392912673288, 6419.0, 6427.710753016032, 6432.035194720829, 6439.291677915332], "unit": "ms", "name": "mootools.html", "value": 4401.025874500041}, {"lowerIsBetter": false, "replicates": [338.16979315779764, 338.9966100338997, 350.95963964144113, 358.95154154189174, 359.6835581770718, 6052.182955301033, 6142.631442113477, 6158.846028849281, 6203.131561581376, 6208.596441231317, 5896.734646940888, 6063.545234107438, 6063.6058656187315, 6082.391760823926, 6090.299615544213, 4753.619710423158, 4756.334113224151, 4757.119932812423, 4765.30903019062, 4772.0, 4567.132244873464, 4609.631229501631, 4647.88380290492, 4703.929441058387, 4739.763011849411, 4635.698679585833, 4646.97676511617, 4654.045920586289, 4657.5575320344515, 4677.74272415017, 4638.768061596924, 4642.51253618372, 4650.325702773096, 4660.953390466119, 4674.252119660872, 4085.836566537335, 4087.202995415895, 4092.6725861930972, 4095.8566450174103, 4096.91806163878, 5754.769809207627, 5843.152742852262, 5850.122481627747, 5870.823875283749, 5879.088741245114, 5467.972660136714, 5472.835814925558, 5480.588955828329, 5483.396826349099, 5486.231927530149, 6133.877322453571, 6472.773452929172, 6480.02799580062, 6485.546011779177, 6497.772577959749, 4487.977560112178, 4502.594766471, 4599.67802253839, 4619.076184763061, 4657.254839225741, 6695.196576410814, 6702.463802895757, 6706.161729783777, 6720.83197920051, 6723.0923825283935, 4711.434627844681, 4766.356541866873, 4768.451628062748, 4769.2130798417875, 4781.832635857728, 4754.4532378776885, 4826.8069277228515, 4856.39295088114, 4861.513848615181, 4875.463698993108, 5486.862828429242, 5514.228008078872, 5524.281843360418, 5529.364123125812, 5538.030844602178, 6519.054737063099, 6551.181102362205, 6553.885839407312, 6554.983977483497, 6557.672116394161, 1678.9580260493585, 1705.60771022663, 1705.7867766529184, 1706.3686436018752, 1714.9399771007954, 1130.4008875296106, 1172.0916289875245, 1194.1103877611063, 1200.7538454616783, 1201.1891972918245, 6354.3645635437015, 6356.0, 6360.681965901686, 6361.14124593174, 6363.7772677956045, 6753.729850805913, 6761.121054263012, 6765.391114799593, 6768.424683901923, 6771.984202369586, 6250.374962503804, 6346.619202847844, 6348.143000694847, 6352.523560732871, 6361.0, 3620.0406892173596, 3654.232611151635, 3655.3785856404475, 3659.359612067931, 3659.505966694462, 6889.242183359826, 6910.8617827644175, 6915.827104322432, 6929.203141638776, 6932.306769323028, 6757.898631520531, 6870.45036397087, 6896.517243792987, 6907.689153988083, 6915.965420172867, 6898.620575868275, 6898.896516552256, 6902.792916212522, 6907.067545881242, 6918.965405173042, 6415.166028416276, 6657.800265992028, 6710.0, 6737.898931516129, 6754.696038678369, 6603.240627327918, 6620.702068407029, 6658.500612454182, 6684.364985326386, 6686.0, 6943.166819981635, 6955.547889387173, 6957.095577574883, 6958.79123626292, 6974.232834388112, 4575.3365761965, 4665.6034237090225, 4683.765811709332, 4769.642276829182, 4821.035792841516, 6730.663466826737, 6758.662066896733, 6761.22245941723, 6773.18721753373, 6776.45788336922, 6591.802245932629, 6593.736250549924, 6594.70323835419, 6595.043718660863, 6596.70314835824, 6410.871782564416, 6515.934840651533, 6560.671966401756, 6574.04676321921, 6574.605523668595, 6454.128692626436, 6459.644719540471, 6465.61206327603, 6468.3855033771715, 6472.579282346633, 6580.1116849226655, 6582.637954912526, 6587.110740050032, 6591.670416479061, 6594.637294948824, 6350.460210882126, 6435.22777266731, 6467.126937863328, 6491.415772580491, 6498.285188629153], "unit": "ms", "name": "prototype.html", "value": 4950.079764074243}, {"lowerIsBetter": false, "replicates": [854.6282367170279, 858.2919091749308, 882.3691060891462, 895.2837729816146, 899.0515006667963, 13655.863441365584, 13893.722125557482, 13933.233672148028, 13933.651658708524, 13945.860541394595, 13792.379342929567, 13872.861271387283, 13888.236147011936, 13908.930455347709, 13911.513097041605, 756.1946526948782, 759.4228386426328, 888.9599968001439, 899.5097671768868, 921.3136213520936, 901.8962819275802, 902.6885724425096, 907.519014922089, 907.8592818113203, 909.4270609515995, 798.6286376834771, 950.0831697411996, 960.5677445149676, 961.6922584772875, 962.7593101724569, 799.8400319936036, 801.182793550578, 932.6269492203105, 949.5964215208578, 951.0204489375953, 709.0746575718686, 709.6558169287891, 710.0662628643317, 710.0910834132319, 710.8969199466101, 13109.278989655566, 13186.736265274736, 13284.269365185008, 13292.933535332359, 13317.866821331856, 12736.681582960407, 13301.0, 13465.596032119052, 13506.662333441644, 13510.662233444144, 10994.395308258043, 11152.609658661908, 11192.944035279854, 11193.0, 11360.0, 3794.2221844521805, 3830.885073447801, 3839.308924393608, 3883.572806991229, 3904.726669133162, 47602.5239747605, 47936.0, 48271.27593086071, 48310.758446207896, 48598.27102593464, 10629.149668026539, 10682.092022178047, 10683.465826708634, 10738.409387483607, 11116.0, 19040.238390464227, 19051.0, 19075.427737167905, 19095.61808763817, 19117.0, 8208.220219079178, 8228.177182281725, 8233.917660823316, 8321.833563328699, 8327.333813294921, 4639.907201855944, 4696.107739529547, 4736.573708366263, 4787.760611969387, 4858.441279252931, 2983.1498023063323, 3015.442143203514, 3018.0644000359957, 3020.3808219314988, 3026.72759451646, 555.2365497441018, 556.118552094926, 566.7364675425947, 566.9206311116448, 572.985675358111, 552.1772558887309, 560.3471955172179, 579.631933722081, 624.4224092714312, 648.4617767253169, 8802.955985220033, 8897.377183597086, 9038.728838134866, 9169.587368568431, 9816.656417025513, 593.7832691067729, 697.9022936788854, 708.7802781137864, 724.6521669598623, 743.4275607781977, 4418.0059486615255, 4483.125790470827, 4488.528704486047, 4591.403117594758, 4646.83736069236, 59214.0, 59634.70182649059, 60067.0, 60654.0, 60748.39251607427, 54885.451145488834, 54911.0, 55794.442055578926, 55795.72102139463, 56133.719331403896, 48259.517404826205, 49273.26090108651, 49278.26082608764, 50077.74961125171, 50157.0, 8758.956205218934, 9006.459612423276, 9033.77415564616, 9057.456552606865, 9150.40522366044, 37378.43932340963, 37473.81263093667, 38147.42778858375, 38604.0, 38801.223975519766, 44208.778956105016, 48148.27777583409, 48209.75895120502, 48235.75882120567, 48751.26873096977, 11568.0, 11624.476898539417, 11727.0, 11727.120465964916, 11979.401029948642, 12670.936645316715, 12688.251508009707, 12825.294608796607, 13637.795433068313, 13763.243021633907, 11240.156988225752, 11440.313581185155, 11550.0, 11792.941035294769, 12200.14598978063, 11873.228240164362, 11919.76160476803, 11932.522699091938, 12150.878491214975, 12422.813657795321, 9817.460039697886, 10691.5188816505, 10707.785844282915, 11368.317900925971, 11821.349825759666, 10681.46592670379, 10792.622258220925, 11272.267302625303, 11320.37737924422, 11368.147388945697, 9987.300888937705, 10112.988701129829, 10272.640457583948, 10307.226957978331, 10365.222608304559], "unit": "ms", "name": "yui.html", "value": 6668.319512856728}], "name": "dromaeo_css", "value": 7358.389317572526}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 109.0, 110.0, 111.0, 101.0, 110.0, 110.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [154.0, 120.0, 146.0, 156.0, 130.0, 146.0, 160.0, 128.0, 158.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 168.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 70.0, 145.0, 71.0, 72.0, 72.0, 73.0, 149.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 139.0, 92.0, 93.0, 92.0, 144.0, 92.0, 91.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 55.0, 56.0, 58.0, 56.0, 56.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 65.0, 63.0, 63.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 81.0, 81.0, 81.0, 79.0, 81.0, 81.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 110.0, 115.0, 107.0, 112.0, 115.0, 115.0, 121.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.1}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 143.0, 141.0, 141.0, 151.0, 143.0, 150.0, 140.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 66.0, 64.0, 63.0, 67.0, 64.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1477.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "Richards", "value": 214.42434799999998}, {"lowerIsBetter": false, "replicates": [173.10022503029253], "unit": "score", "name": "DeltaBlue", "value": 381.9636860000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [959.6928982725528], "unit": "score", "name": "RayTrace", "value": 771.0685379999996}, {"lowerIsBetter": false, "replicates": [558.659217877095], "unit": "score", "name": "Earley", "value": 1192.9687700000002}, {"lowerIsBetter": false, "replicates": [11065.934065934065], "unit": "score", "name": "Boyer", "value": 60.22654716981128}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [527.9831045406547], "unit": "score", "name": "Splay", "value": 154.34395400000002}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22987.282101605655}]} 02:44:24 INFO - RETURN: dromaeo_css: 7358.39 02:44:24 INFO - RETURN: kraken: 1477.70 02:44:24 INFO - RETURN: v8_7: 22987.28 02:44:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22987.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1477.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7358.39"}}} 02:44:24 INFO - Return code: 0 02:44:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:44:24 INFO - # TBPL SUCCESS # 02:44:24 INFO - Running post-action listener: _resource_record_post_action 02:44:24 INFO - Running post-run listener: _resource_record_post_run 02:44:25 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 356352; Write bytes: 503451648; Read time: 860; Write time: 365096 02:44:25 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237068288; Read time: 612; Write time: 212604 02:44:25 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 352256; Write bytes: 266080256; Read time: 248; Write time: 152472 02:44:25 INFO - Running post-run listener: _upload_blobber_files 02:44:25 INFO - Blob upload gear active. 02:44:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:44:25 INFO - Copying logs to upload dir... 02:44:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.958822 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-25 02:44:25.516175) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:25.519750) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/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-25 02:44:25.571914) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:25.572303) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453717157.581075-760827722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:25.622319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 02:44:25.622720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 02:44:25.623079) ========= ========= Total master_lag: 0.27 =========