builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1459513503.32 results: success (0) buildid: 20160401025139 builduid: 2449205b11c547489c018d5d3e4453ba revision: 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.318282) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.318761) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.319047) ========= 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006202 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.341475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.341824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.358174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.358576) ========= 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030680 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.408600) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.408915) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.409274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.409545) ========= 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 05:25:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-04-01 05:25:03 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.516378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.516700) ========= 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.049890 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.575529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:03.575920) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd --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 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd --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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 05:25:03,588 truncating revision to first 12 chars 2016-04-01 05:25:03,588 Setting DEBUG logging. 2016-04-01 05:25:03,589 attempt 1/10 2016-04-01 05:25:03,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/49baa8de350f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 05:25:03,859 unpacking tar archive at: mozilla-aurora-49baa8de350f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:04.166011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:04.166360) ========= echo 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49baa8de350f45216d7e2b4bb0509ac6c16ae9cd'] 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd program finished with exit code 0 elapsedTime=0.003948 script_repo_revision: '49baa8de350f45216d7e2b4bb0509ac6c16ae9cd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:04.216804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:04.217265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 05:25:04.227929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-01 05:25:04.228607) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:04 INFO - MultiFileLogger online at 20160401 05:25:04 in /builds/slave/test-pgo 05:25:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:25:04 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:25:04 INFO - {'append_to_log': False, 05:25:04 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:25:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:25:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:25:04 INFO - 'branch': 'Mozilla-Aurora', 05:25:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:04 INFO - 'config_files': ('talos/linux_config.py',), 05:25:04 INFO - 'default_actions': ('clobber', 05:25:04 INFO - 'read-buildbot-config', 05:25:04 INFO - 'download-and-extract', 05:25:04 INFO - 'populate-webroot', 05:25:04 INFO - 'create-virtualenv', 05:25:04 INFO - 'install', 05:25:04 INFO - 'run-tests'), 05:25:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:04 INFO - 'download_minidump_stackwalk': True, 05:25:04 INFO - 'download_symbols': 'ondemand', 05:25:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:04 INFO - 'installer_path': 'installer.exe', 05:25:04 INFO - 'log_level': 'info', 05:25:04 INFO - 'log_name': 'talos', 05:25:04 INFO - 'log_to_console': True, 05:25:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:04 INFO - 'opt_config_files': (), 05:25:04 INFO - 'pip_index': False, 05:25:04 INFO - 'sps_profile': False, 05:25:04 INFO - 'sps_profile_interval': 0, 05:25:04 INFO - 'suite': 'dromaeojs-e10s', 05:25:04 INFO - 'system_bits': '32', 05:25:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:04 INFO - 'title': 'talos-linux64-ix-003', 05:25:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:04 INFO - 'use_talos_json': True, 05:25:04 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:25:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:04 INFO - 'work_dir': 'build'} 05:25:04 INFO - ##### 05:25:04 INFO - ##### Running clobber step. 05:25:04 INFO - ##### 05:25:04 INFO - Running pre-action listener: _resource_record_pre_action 05:25:04 INFO - Running main action method: clobber 05:25:04 INFO - rmtree: /builds/slave/test-pgo/build 05:25:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:25:09 INFO - Running post-action listener: _resource_record_post_action 05:25:09 INFO - ##### 05:25:09 INFO - ##### Running read-buildbot-config step. 05:25:09 INFO - ##### 05:25:09 INFO - Running pre-action listener: _resource_record_pre_action 05:25:09 INFO - Running main action method: read_buildbot_config 05:25:09 INFO - Using buildbot properties: 05:25:09 INFO - { 05:25:09 INFO - "project": "", 05:25:09 INFO - "product": "firefox", 05:25:09 INFO - "script_repo_revision": "production", 05:25:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:25:09 INFO - "repository": "", 05:25:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:25:09 INFO - "buildid": "20160401025139", 05:25:09 INFO - "pgo_build": "True", 05:25:09 INFO - "basedir": "/builds/slave/test-pgo", 05:25:09 INFO - "buildnumber": 275, 05:25:09 INFO - "slavename": "talos-linux64-ix-003", 05:25:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:25:09 INFO - "platform": "ubuntu64_hw", 05:25:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:25:09 INFO - "branch": "mozilla-aurora", 05:25:09 INFO - "repo_path": "releases/mozilla-aurora", 05:25:09 INFO - "revision": "49baa8de350f45216d7e2b4bb0509ac6c16ae9cd", 05:25:09 INFO - "stage_platform": "linux64-pgo", 05:25:09 INFO - "builduid": "2449205b11c547489c018d5d3e4453ba", 05:25:09 INFO - "slavebuilddir": "test" 05:25:09 INFO - } 05:25:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 05:25:09 INFO - Running post-action listener: _resource_record_post_action 05:25:09 INFO - ##### 05:25:09 INFO - ##### Running download-and-extract step. 05:25:09 INFO - ##### 05:25:09 INFO - Running pre-action listener: _resource_record_pre_action 05:25:09 INFO - Running main action method: download_and_extract 05:25:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:09 INFO - https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:25:09 INFO - Downloaded 1448 bytes. 05:25:09 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:25:09 INFO - Using the following test package requirements: 05:25:09 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:25:09 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:25:09 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:25:09 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'jsshell-linux-x86_64.zip'], 05:25:09 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:25:09 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:25:09 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:25:09 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:25:09 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:25:09 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:25:09 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:25:09 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:25:09 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:09 INFO - https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:25:11 INFO - Downloaded 23344153 bytes. 05:25:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:25:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:25:12 INFO - Return code: 0 05:25:12 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:12 INFO - https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:25:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:25:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:25:15 INFO - Downloaded 23344153 bytes. 05:25:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:25:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:25:16 INFO - Return code: 0 05:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:16 INFO - https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:25:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:25:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:25:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:25:17 INFO - Downloaded 10845161 bytes. 05:25:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:25:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:25:17 INFO - Return code: 0 05:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:17 INFO - https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:25:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:25:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:25:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:25:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:25:19 INFO - Downloaded 60560186 bytes. 05:25:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:25:19 INFO - mkdir: /builds/slave/test-pgo/properties 05:25:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:25:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:25:19 INFO - Contents: 05:25:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:25:20 INFO - Running post-action listener: _resource_record_post_action 05:25:20 INFO - Running post-action listener: set_extra_try_arguments 05:25:20 INFO - ##### 05:25:20 INFO - ##### Running populate-webroot step. 05:25:20 INFO - ##### 05:25:20 INFO - Running pre-action listener: _resource_record_pre_action 05:25:20 INFO - Running main action method: populate_webroot 05:25:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:20 INFO - '--tppagecycles', 05:25:20 INFO - '7'], 05:25:20 INFO - 'tests': ['tsvgm']}}, 05:25:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:25:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:25:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'tests': ['damp', 'tps']}, 05:25:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['damp', 'tps']}, 05:25:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:25:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:20 INFO - 'other': {'tests': ['a11yr', 05:25:20 INFO - 'ts_paint', 05:25:20 INFO - 'tpaint', 05:25:20 INFO - 'sessionrestore', 05:25:20 INFO - 'sessionrestore_no_auto_restore', 05:25:20 INFO - 'tabpaint']}, 05:25:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['a11yr', 05:25:20 INFO - 'ts_paint', 05:25:20 INFO - 'tpaint', 05:25:20 INFO - 'sessionrestore', 05:25:20 INFO - 'sessionrestore_no_auto_restore', 05:25:20 INFO - 'tabpaint']}, 05:25:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['a11yr', 05:25:20 INFO - 'ts_paint', 05:25:20 INFO - 'tpaint', 05:25:20 INFO - 'sessionrestore', 05:25:20 INFO - 'sessionrestore_no_auto_restore', 05:25:20 INFO - 'tabpaint']}, 05:25:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['a11yr', 05:25:20 INFO - 'ts_paint', 05:25:20 INFO - 'tpaint', 05:25:20 INFO - 'sessionrestore', 05:25:20 INFO - 'sessionrestore_no_auto_restore', 05:25:20 INFO - 'tabpaint']}, 05:25:20 INFO - 'other_l64': {'tests': ['a11yr', 05:25:20 INFO - 'ts_paint', 05:25:20 INFO - 'tpaint', 05:25:20 INFO - 'sessionrestore', 05:25:20 INFO - 'sessionrestore_no_auto_restore', 05:25:20 INFO - 'tabpaint']}, 05:25:20 INFO - 'other_nol64': {'tests': ['a11yr', 05:25:20 INFO - 'ts_paint', 05:25:20 INFO - 'tpaint', 05:25:20 INFO - 'sessionrestore', 05:25:20 INFO - 'sessionrestore_no_auto_restore', 05:25:20 INFO - 'tabpaint']}, 05:25:20 INFO - 'svgr': {'tests': ['tsvgx', 05:25:20 INFO - 'tsvgr_opacity', 05:25:20 INFO - 'tart', 05:25:20 INFO - 'tscrollx', 05:25:20 INFO - 'cart']}, 05:25:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['tsvgx', 05:25:20 INFO - 'tsvgr_opacity', 05:25:20 INFO - 'tart', 05:25:20 INFO - 'tscrollx', 05:25:20 INFO - 'cart']}, 05:25:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'tests': ['tp5o']}, 05:25:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'talos_options': ['--e10s'], 05:25:20 INFO - 'tests': ['tp5o']}, 05:25:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'talos_options': ['--xperf_path', 05:25:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:20 INFO - 'tests': ['tp5n']}, 05:25:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:20 INFO - 'talos_options': ['--e10s', 05:25:20 INFO - '--xperf_path', 05:25:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:20 INFO - 'tests': ['tp5n']}}, 05:25:20 INFO - 'talos.zip': {'path': '', 05:25:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:20 INFO - Running post-action listener: _resource_record_post_action 05:25:20 INFO - ##### 05:25:20 INFO - ##### Running create-virtualenv step. 05:25:20 INFO - ##### 05:25:20 INFO - Running pre-action listener: _resource_record_pre_action 05:25:20 INFO - Running main action method: create_virtualenv 05:25:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:25:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:25:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:25:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:20 INFO - Using real prefix '/usr' 05:25:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:25:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:22 INFO - Installing pip.................done. 05:25:22 INFO - Return code: 0 05:25:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:22 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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:22 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 05:25:22 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 05:25:22 INFO - Using env: {'DISPLAY': ':0', 05:25:22 INFO - 'HOME': '/home/cltbld', 05:25:22 INFO - 'LANG': 'en_US.UTF-8', 05:25:22 INFO - 'LANGUAGE': 'en_US:en', 05:25:22 INFO - 'LOGNAME': 'cltbld', 05:25:22 INFO - 'MAIL': '/var/mail/cltbld', 05:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:22 INFO - 'MOZ_NO_REMOTE': '1', 05:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:22 INFO - 'NO_EM_RESTART': '1', 05:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:22 INFO - 'SHELL': '/bin/bash', 05:25:22 INFO - 'SHLVL': '1', 05:25:22 INFO - 'TERM': 'linux', 05:25:22 INFO - 'TMOUT': '86400', 05:25:22 INFO - 'USER': 'cltbld', 05:25:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:22 INFO - '_': '/tools/buildbot/bin/python'} 05:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:25:22 INFO - Cleaning up... 05:25:22 INFO - Return code: 0 05:25:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:22 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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:22 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 05:25:22 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 05:25:22 INFO - Using env: {'DISPLAY': ':0', 05:25:22 INFO - 'HOME': '/home/cltbld', 05:25:22 INFO - 'LANG': 'en_US.UTF-8', 05:25:22 INFO - 'LANGUAGE': 'en_US:en', 05:25:22 INFO - 'LOGNAME': 'cltbld', 05:25:22 INFO - 'MAIL': '/var/mail/cltbld', 05:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:22 INFO - 'MOZ_NO_REMOTE': '1', 05:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:22 INFO - 'NO_EM_RESTART': '1', 05:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:22 INFO - 'SHELL': '/bin/bash', 05:25:22 INFO - 'SHLVL': '1', 05:25:22 INFO - 'TERM': 'linux', 05:25:22 INFO - 'TMOUT': '86400', 05:25:22 INFO - 'USER': 'cltbld', 05:25:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:22 INFO - '_': '/tools/buildbot/bin/python'} 05:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:23 INFO - Downloading/unpacking psutil>=0.7.1 05:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:25 INFO - Installing collected packages: psutil 05:25:25 INFO - Running setup.py install for psutil 05:25:25 INFO - building 'psutil._psutil_linux' extension 05:25:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:25:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:25:25 INFO - building 'psutil._psutil_posix' extension 05:25:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:25:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:25:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:25 INFO - Successfully installed psutil 05:25:25 INFO - Cleaning up... 05:25:25 INFO - Return code: 0 05:25:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:25:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:25:25 INFO - Using env: {'DISPLAY': ':0', 05:25:25 INFO - 'HOME': '/home/cltbld', 05:25:25 INFO - 'LANG': 'en_US.UTF-8', 05:25:25 INFO - 'LANGUAGE': 'en_US:en', 05:25:25 INFO - 'LOGNAME': 'cltbld', 05:25:25 INFO - 'MAIL': '/var/mail/cltbld', 05:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:25 INFO - 'MOZ_NO_REMOTE': '1', 05:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:25 INFO - 'NO_EM_RESTART': '1', 05:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:25 INFO - 'SHELL': '/bin/bash', 05:25:25 INFO - 'SHLVL': '1', 05:25:25 INFO - 'TERM': 'linux', 05:25:25 INFO - 'TMOUT': '86400', 05:25:25 INFO - 'USER': 'cltbld', 05:25:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:25 INFO - '_': '/tools/buildbot/bin/python'} 05:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:25:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:25:27 INFO - Installing collected packages: mozsystemmonitor 05:25:27 INFO - Running setup.py install for mozsystemmonitor 05:25:27 INFO - Successfully installed mozsystemmonitor 05:25:27 INFO - Cleaning up... 05:25:27 INFO - Return code: 0 05:25:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:27 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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:27 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 05:25:27 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 05:25:27 INFO - Using env: {'DISPLAY': ':0', 05:25:27 INFO - 'HOME': '/home/cltbld', 05:25:27 INFO - 'LANG': 'en_US.UTF-8', 05:25:27 INFO - 'LANGUAGE': 'en_US:en', 05:25:27 INFO - 'LOGNAME': 'cltbld', 05:25:27 INFO - 'MAIL': '/var/mail/cltbld', 05:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:27 INFO - 'MOZ_NO_REMOTE': '1', 05:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:27 INFO - 'NO_EM_RESTART': '1', 05:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:27 INFO - 'SHELL': '/bin/bash', 05:25:27 INFO - 'SHLVL': '1', 05:25:27 INFO - 'TERM': 'linux', 05:25:27 INFO - 'TMOUT': '86400', 05:25:27 INFO - 'USER': 'cltbld', 05:25:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:27 INFO - '_': '/tools/buildbot/bin/python'} 05:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:25:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:30 INFO - Downloading docopt-0.6.1.tar.gz 05:25:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:30 INFO - Running setup.py install for blobuploader 05:25:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:25:30 INFO - Running setup.py install for requests 05:25:31 INFO - Running setup.py install for docopt 05:25:31 INFO - Successfully installed blobuploader requests docopt 05:25:31 INFO - Cleaning up... 05:25:31 INFO - Return code: 0 05:25:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:31 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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:31 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 05:25:31 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 05:25:31 INFO - Using env: {'DISPLAY': ':0', 05:25:31 INFO - 'HOME': '/home/cltbld', 05:25:31 INFO - 'LANG': 'en_US.UTF-8', 05:25:31 INFO - 'LANGUAGE': 'en_US:en', 05:25:31 INFO - 'LOGNAME': 'cltbld', 05:25:31 INFO - 'MAIL': '/var/mail/cltbld', 05:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:31 INFO - 'MOZ_NO_REMOTE': '1', 05:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:31 INFO - 'NO_EM_RESTART': '1', 05:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:31 INFO - 'SHELL': '/bin/bash', 05:25:31 INFO - 'SHLVL': '1', 05:25:31 INFO - 'TERM': 'linux', 05:25:31 INFO - 'TMOUT': '86400', 05:25:31 INFO - 'USER': 'cltbld', 05:25:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:31 INFO - '_': '/tools/buildbot/bin/python'} 05:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:31 INFO - Running setup.py (path:/tmp/pip-j1pGld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:31 INFO - Running setup.py (path:/tmp/pip-uwroSk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:31 INFO - Running setup.py (path:/tmp/pip-3ugypG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:31 INFO - Running setup.py (path:/tmp/pip-6hXd4E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:31 INFO - Running setup.py (path:/tmp/pip-BmhwkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:31 INFO - Running setup.py (path:/tmp/pip-R6wXlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:32 INFO - Running setup.py (path:/tmp/pip-JNWnvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:32 INFO - Running setup.py (path:/tmp/pip-PmySn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:32 INFO - Running setup.py (path:/tmp/pip-AxE3hb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:32 INFO - Running setup.py (path:/tmp/pip-R6jJlE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:32 INFO - Running setup.py (path:/tmp/pip-mytRk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:32 INFO - Running setup.py (path:/tmp/pip-JV4W68-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:32 INFO - Running setup.py (path:/tmp/pip-gZ9_qf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:32 INFO - Running setup.py (path:/tmp/pip-_kBqW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:32 INFO - Running setup.py (path:/tmp/pip-Cdaa8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:32 INFO - Running setup.py (path:/tmp/pip-kyJPfA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:32 INFO - Running setup.py (path:/tmp/pip-2UkY1V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:32 INFO - Running setup.py install for manifestparser 05:25:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:25:32 INFO - Running setup.py install for mozcrash 05:25:33 INFO - Running setup.py install for mozdebug 05:25:33 INFO - Running setup.py install for mozdevice 05:25:33 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Running setup.py install for mozfile 05:25:33 INFO - Running setup.py install for mozhttpd 05:25:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Running setup.py install for mozinfo 05:25:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Running setup.py install for mozInstall 05:25:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Running setup.py install for mozleak 05:25:33 INFO - Running setup.py install for mozlog 05:25:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Running setup.py install for moznetwork 05:25:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:25:33 INFO - Running setup.py install for mozprocess 05:25:34 INFO - Running setup.py install for mozprofile 05:25:34 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:25:34 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:25:34 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:25:34 INFO - Running setup.py install for mozrunner 05:25:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:25:34 INFO - Running setup.py install for mozscreenshot 05:25:34 INFO - Running setup.py install for moztest 05:25:34 INFO - Running setup.py install for mozversion 05:25:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:25:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:34 INFO - Cleaning up... 05:25:34 INFO - Return code: 0 05:25:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:34 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 05:25:34 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 05:25:34 INFO - Using env: {'DISPLAY': ':0', 05:25:34 INFO - 'HOME': '/home/cltbld', 05:25:34 INFO - 'LANG': 'en_US.UTF-8', 05:25:34 INFO - 'LANGUAGE': 'en_US:en', 05:25:34 INFO - 'LOGNAME': 'cltbld', 05:25:34 INFO - 'MAIL': '/var/mail/cltbld', 05:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:34 INFO - 'MOZ_NO_REMOTE': '1', 05:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:34 INFO - 'NO_EM_RESTART': '1', 05:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:34 INFO - 'SHELL': '/bin/bash', 05:25:34 INFO - 'SHLVL': '1', 05:25:34 INFO - 'TERM': 'linux', 05:25:34 INFO - 'TMOUT': '86400', 05:25:34 INFO - 'USER': 'cltbld', 05:25:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:34 INFO - '_': '/tools/buildbot/bin/python'} 05:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:34 INFO - Running setup.py (path:/tmp/pip-BpdlCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:25:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:34 INFO - Running setup.py (path:/tmp/pip-fn2nUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:25:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:34 INFO - Running setup.py (path:/tmp/pip-DvKQZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:35 INFO - Running setup.py (path:/tmp/pip-67kuEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:35 INFO - Running setup.py (path:/tmp/pip-EX1VY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:35 INFO - Running setup.py (path:/tmp/pip-Uf1dBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:35 INFO - Running setup.py (path:/tmp/pip-kS7fGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:35 INFO - Running setup.py (path:/tmp/pip-KU2X6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:35 INFO - Running setup.py (path:/tmp/pip-KQU_HT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:35 INFO - Running setup.py (path:/tmp/pip-GsCtIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:35 INFO - Running setup.py (path:/tmp/pip-nAajEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:35 INFO - Running setup.py (path:/tmp/pip-TDlS_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:35 INFO - Running setup.py (path:/tmp/pip-fv9IKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:35 INFO - Running setup.py (path:/tmp/pip-k8ZMnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:35 INFO - Running setup.py (path:/tmp/pip-CJCBRl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:35 INFO - Running setup.py (path:/tmp/pip-FGgn5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:25:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:35 INFO - Running setup.py (path:/tmp/pip-XYCJ7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:25:36 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:25:36 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:25:36 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:25:36 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:25:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:37 INFO - Downloading blessings-1.6.tar.gz 05:25:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:37 INFO - Installing collected packages: blessings 05:25:37 INFO - Running setup.py install for blessings 05:25:38 INFO - Successfully installed blessings 05:25:38 INFO - Cleaning up... 05:25:38 INFO - Return code: 0 05:25:38 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:25:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:25:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:25:38 INFO - Reading from file tmpfile_stdout 05:25:38 INFO - Current package versions: 05:25:38 INFO - argparse == 1.2.1 05:25:38 INFO - blessings == 1.6 05:25:38 INFO - blobuploader == 1.2.4 05:25:38 INFO - docopt == 0.6.1 05:25:38 INFO - manifestparser == 1.1 05:25:38 INFO - mozInstall == 1.12 05:25:38 INFO - mozcrash == 0.17 05:25:38 INFO - mozdebug == 0.1 05:25:38 INFO - mozdevice == 0.48 05:25:38 INFO - mozfile == 1.2 05:25:38 INFO - mozhttpd == 0.7 05:25:38 INFO - mozinfo == 0.9 05:25:38 INFO - mozleak == 0.1 05:25:38 INFO - mozlog == 3.1 05:25:38 INFO - moznetwork == 0.27 05:25:38 INFO - mozprocess == 0.22 05:25:38 INFO - mozprofile == 0.28 05:25:38 INFO - mozrunner == 6.11 05:25:38 INFO - mozscreenshot == 0.1 05:25:38 INFO - mozsystemmonitor == 0.0 05:25:38 INFO - moztest == 0.7 05:25:38 INFO - mozversion == 1.4 05:25:38 INFO - psutil == 3.1.1 05:25:38 INFO - requests == 1.2.3 05:25:38 INFO - wsgiref == 0.1.2 05:25:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:25: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')]} 05:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:38 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 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25:38 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 05:25:38 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 05:25:38 INFO - Using env: {'DISPLAY': ':0', 05:25:38 INFO - 'HOME': '/home/cltbld', 05:25:38 INFO - 'LANG': 'en_US.UTF-8', 05:25:38 INFO - 'LANGUAGE': 'en_US:en', 05:25:38 INFO - 'LOGNAME': 'cltbld', 05:25:38 INFO - 'MAIL': '/var/mail/cltbld', 05:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:38 INFO - 'MOZ_NO_REMOTE': '1', 05:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:38 INFO - 'NO_EM_RESTART': '1', 05:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:38 INFO - 'SHELL': '/bin/bash', 05:25:38 INFO - 'SHLVL': '1', 05:25:38 INFO - 'TERM': 'linux', 05:25:38 INFO - 'TMOUT': '86400', 05:25:38 INFO - 'USER': 'cltbld', 05:25:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:38 INFO - '_': '/tools/buildbot/bin/python'} 05:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:25:38 INFO - Cleaning up... 05:25:38 INFO - Return code: 0 05:25:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:25: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')]} 05:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25: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', 'jsonschema'] in /builds/slave/test-pgo/build 05:25: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 jsonschema 05:25:38 INFO - Using env: {'DISPLAY': ':0', 05:25:38 INFO - 'HOME': '/home/cltbld', 05:25:38 INFO - 'LANG': 'en_US.UTF-8', 05:25:38 INFO - 'LANGUAGE': 'en_US:en', 05:25:38 INFO - 'LOGNAME': 'cltbld', 05:25:38 INFO - 'MAIL': '/var/mail/cltbld', 05:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:38 INFO - 'MOZ_NO_REMOTE': '1', 05:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:38 INFO - 'NO_EM_RESTART': '1', 05:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:38 INFO - 'SHELL': '/bin/bash', 05:25:38 INFO - 'SHLVL': '1', 05:25:38 INFO - 'TERM': 'linux', 05:25:38 INFO - 'TMOUT': '86400', 05:25:38 INFO - 'USER': 'cltbld', 05:25:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:38 INFO - '_': '/tools/buildbot/bin/python'} 05:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:38 INFO - Downloading/unpacking jsonschema 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:40 INFO - Downloading/unpacking functools32 (from jsonschema) 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:40 INFO - warning: no files found matching '*.txt' 05:25:40 INFO - no previously-included directories found matching 'build' 05:25:40 INFO - no previously-included directories found matching 'dist' 05:25:40 INFO - no previously-included directories found matching '.git*' 05:25:40 INFO - Installing collected packages: jsonschema, functools32 05:25:41 INFO - Running setup.py install for functools32 05:25:41 INFO - warning: no files found matching '*.txt' 05:25:41 INFO - no previously-included directories found matching 'build' 05:25:41 INFO - no previously-included directories found matching 'dist' 05:25:41 INFO - no previously-included directories found matching '.git*' 05:25:41 INFO - Successfully installed jsonschema functools32 05:25:41 INFO - Cleaning up... 05:25:41 INFO - Return code: 0 05:25:41 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc6df0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, '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': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:25: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', 'flake8'] in /builds/slave/test-pgo/build 05:25: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 flake8 05:25:41 INFO - Using env: {'DISPLAY': ':0', 05:25:41 INFO - 'HOME': '/home/cltbld', 05:25:41 INFO - 'LANG': 'en_US.UTF-8', 05:25:41 INFO - 'LANGUAGE': 'en_US:en', 05:25:41 INFO - 'LOGNAME': 'cltbld', 05:25:41 INFO - 'MAIL': '/var/mail/cltbld', 05:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:41 INFO - 'MOZ_NO_REMOTE': '1', 05:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:41 INFO - 'NO_EM_RESTART': '1', 05:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:41 INFO - 'SHELL': '/bin/bash', 05:25:41 INFO - 'SHLVL': '1', 05:25:41 INFO - 'TERM': 'linux', 05:25:41 INFO - 'TMOUT': '86400', 05:25:41 INFO - 'USER': 'cltbld', 05:25:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:41 INFO - '_': '/tools/buildbot/bin/python'} 05:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:41 INFO - Downloading/unpacking flake8 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:25:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:25:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:25:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:43 INFO - no previously-included directories found matching 'docs/_build' 05:25:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:25:44 INFO - Running setup.py install for pep8 05:25:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:44 INFO - no previously-included directories found matching 'docs/_build' 05:25:44 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:25:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:25:44 INFO - Cleaning up... 05:25:44 INFO - Return code: 0 05:25:44 INFO - Running post-action listener: _resource_record_post_action 05:25:44 INFO - Running post-action listener: _start_resource_monitoring 05:25:44 INFO - Starting resource monitoring. 05:25:44 INFO - ##### 05:25:44 INFO - ##### Running install step. 05:25:44 INFO - ##### 05:25:44 INFO - Running pre-action listener: _resource_record_pre_action 05:25:44 INFO - Running main action method: install 05:25:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:25:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:25:44 INFO - Reading from file tmpfile_stdout 05:25:44 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:25:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:25:44 INFO - Reading from file tmpfile_stdout 05:25:44 INFO - Output received: 05:25:44 INFO - Usage: mozinstall [options] installer 05:25:44 INFO - Options: 05:25:44 INFO - -h, --help show this help message and exit 05:25:44 INFO - -d DEST, --destination=DEST 05:25:44 INFO - Directory to install application into. [default: 05:25:44 INFO - "/builds/slave/test-pgo"] 05:25:44 INFO - --app=APP Application being installed. [default: firefox] 05:25:44 INFO - mkdir: /builds/slave/test-pgo/build/application 05:25:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:25:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:25:59 INFO - Reading from file tmpfile_stdout 05:25:59 INFO - Output received: 05:25:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:25:59 INFO - Running post-action listener: _resource_record_post_action 05:25:59 INFO - ##### 05:25:59 INFO - ##### Running run-tests step. 05:25:59 INFO - ##### 05:25:59 INFO - Running pre-action listener: _resource_record_pre_action 05:25:59 INFO - Running main action method: run_tests 05:25:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:25:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:25:59 INFO - Python 2.7.3 05:25:59 INFO - Return code: 0 05:25:59 INFO - grabbing minidump binary from tooltool 05:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:59 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 0xe8b920>, '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 0xe8c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8ccb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:25:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:25:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:25:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:59 INFO - Return code: 0 05:25:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:25:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:25:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:25:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:25:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:25:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:25:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:26:00 INFO - Return code: 0 05:26:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:26:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:26:00 INFO - Using env: {'DISPLAY': ':0', 05:26:00 INFO - 'HOME': '/home/cltbld', 05:26:00 INFO - 'LANG': 'en_US.UTF-8', 05:26:00 INFO - 'LANGUAGE': 'en_US:en', 05:26:00 INFO - 'LOGNAME': 'cltbld', 05:26:00 INFO - 'MAIL': '/var/mail/cltbld', 05:26:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:26:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:00 INFO - 'MOZ_NO_REMOTE': '1', 05:26:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:00 INFO - 'NO_EM_RESTART': '1', 05:26:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:26:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:26:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:26:00 INFO - 'SHELL': '/bin/bash', 05:26:00 INFO - 'SHLVL': '1', 05:26:00 INFO - 'TERM': 'linux', 05:26:00 INFO - 'TMOUT': '86400', 05:26:00 INFO - 'USER': 'cltbld', 05:26:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459513502.603047-2088649721', 05:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:00 INFO - '_': '/tools/buildbot/bin/python'} 05:26:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:26:00 INFO - mozversion application_buildid: 20160401025139 05:26:00 INFO - mozversion application_changeset: 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd 05:26:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:26:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:00 INFO - mozversion application_name: Firefox 05:26:00 INFO - mozversion application_remotingname: firefox-dev 05:26:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:26:00 INFO - mozversion application_vendor: Mozilla 05:26:00 INFO - mozversion application_version: 47.0a2 05:26:00 INFO - mozversion platform_buildid: 20160401025139 05:26:00 INFO - mozversion platform_changeset: 49baa8de350f45216d7e2b4bb0509ac6c16ae9cd 05:26:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:26:00 INFO - mozversion platform_version: 47.0a2 05:26:00 INFO - using testdate: 1459513560 05:26:00 INFO - actual date: 1459513560 05:26:00 INFO - starting webserver on 'localhost:36208' 05:26:00 INFO - SUITE-START | Running 2 tests 05:26:00 INFO - TEST-START | dromaeo_css 05:26:00 INFO - operating with platform_type : linux_ 05:26:00 INFO - Initialising browser for dromaeo_css test... 05:26:00 INFO - TEST-INFO | started process 12674 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMb_SzS/profile http://localhost:36208/getInfo.html) 05:26:04 INFO - PROCESS | 12674 | 05:26:04 INFO - PROCESS | 12674 | (process:12748): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:26:05 INFO - PROCESS | 12674 | __metrics Screen width/height:1600/1200 05:26:05 INFO - PROCESS | 12674 | colorDepth:24 05:26:05 INFO - PROCESS | 12674 | Browser inner width/height: 1024/697 05:26:05 INFO - PROCESS | 12674 | __metrics 05:26:06 ERROR - PROCESS | 12674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:26:07 INFO - TEST-INFO | 12674: exit 0 05:26:07 INFO - Browser initialized. 05:26:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:07 INFO - TEST-INFO | started process 12799 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMb_SzS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:09 INFO - PROCESS | 12799 | 05:26:09 INFO - PROCESS | 12799 | (process:12866): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:26:19 INFO - PROCESS | 12799 | RSS: Main: 154066944 05:26:19 INFO - PROCESS | 12799 | 05:27:08 INFO - PROCESS | 12799 | 1459513628793 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:29:16 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:36208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36208/tests/dromaeo/cssquery-ext.html) 05:29:17 INFO - PROCESS | 12799 | RSS: Main: 157491200 05:29:17 INFO - PROCESS | 12799 | 05:32:19 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:36208/tests/dromaeo/cssquery-ext.html (next: http://localhost:36208/tests/dromaeo/cssquery-jquery.html) 05:32:20 INFO - PROCESS | 12799 | RSS: Main: 155525120 05:32:20 INFO - PROCESS | 12799 | 05:35:22 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:36208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36208/tests/dromaeo/cssquery-mootools.html) 05:35:22 INFO - PROCESS | 12799 | RSS: Main: 154931200 05:35:22 INFO - PROCESS | 12799 | 05:38:24 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:36208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36208/tests/dromaeo/cssquery-prototype.html) 05:38:25 INFO - PROCESS | 12799 | RSS: Main: 154349568 05:38:25 INFO - PROCESS | 12799 | 05:41:27 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:36208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36208/tests/dromaeo/cssquery-yui.html) 05:41:27 INFO - PROCESS | 12799 | RSS: Main: 156209152 05:41:27 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:36208/tests/dromaeo/cssquery-yui.html (next: http://localhost:36208/tests/dromaeo/cssquery-dojo.html) 05:44:30 INFO - PROCESS | 12799 | RSS: Main: 158810112 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | __start_tp_report 05:44:30 INFO - PROCESS | 12799 | _x_x_mozilla_page_load 05:44:30 INFO - PROCESS | 12799 | _x_x_mozilla_page_load_details 05:44:30 INFO - PROCESS | 12799 | |i|pagename|runs| 05:44:30 INFO - PROCESS | 12799 | |0;dojo.html;3315.883944061958;3398.6601339866015;3424;3460.1003739027847;3469.774464659797;5324.65389749666;5509.752061157247;5513.751881165347;5514.448555144489;5542.1409681499335;5542.0855558832745;5562;5562.888742225153;5579.302587176603;5586.10622300431;5063.696178229299;5097.872553186163;5129.051125541768;5141.228815677659;5159.2003239497935;5071.112555302826;5094.821681241157;5214.869628259305;5243.501867322599;5244.239585260135;5112.8977420451565;5129.204973229155;5182.274481572583;5196.350456192976;5214.035403450355;5103.770330335125;5166.664166829163;5173.948260517384;5177.76700048495;5180.6891586504935;4951.43058548268;4998.375203099613;5149.459306772772;5160.638755287131;5184.870378240536;5454.809081682122;5455.427180146107;5456.072467680504;5461.371942226655;5485.9725701371635;6047.939520604782;6068.241469816273;6084.60450070744;6093.939060609381;6094.847628809271;5948.940510594882;6039.305479869828;6106.328303886569;6112.724927378279;6119.785807496761;5574.526165275915;5576.944230557724;5577.386487486373;5579.553635709133;5583.469570390806;6016.8796624068145;6021.969890150521;6026.156338112668;6033.456988871023;6042.879142417127;5826.038703613941;5886.676232807151;5950;5976.804639072116;6002.699865006733;6009.06859436788;6012.579119461596;6013.51891848651;6019.969900150471;6035.7283922223605;5897.49871260939;5965.075413310944;5974.761009559656;5978.372270911578;5980.342162362137;5940.316863560746;5967.522598192134;5974.761009559569;6000.879982400327;6032.155498230251;4575.084983003346;4595.977020114878;4611.8847028823875;4617.353570500132;4634.72191668501;4025.6578190854107;4067.349224124185;4107.835686572564;4148.522919864194;4187.539370669224;5713.05734553794;5730.71346432685;5756.827295181151;5794.797182098607;5802.593818432669;6027;6071.210742603522;6118.1087851938255;6127.325994140641;6136.0902143038675;5689.374168841424;5695.088785794253;5714.228579141846;5722;5734.741936612862;5100.795968161232;5130.948690513122;5155.7679904404395;5165.66423182492;5165.741712914414;6196.442320191204;6234.127222188898;6243.531735119885;6249;6254.530910181755;6100.206973093558;6106.267247930276;6108.450239478469;6111;6112.480439162721;6068.817935461943;6167.074938759222;6200.627962322094;6208.751649933952;6227.719752611053;6053.485453736482;6055.364186760503;6057.273127224761;6057.333693293646;6067.726952287246;6137.478314343331;6154.569180157346;6157.107219453064;6163.3836616338;6171.691415429121;5812.389699081536;5871.794487192928;5923.229980102559;5925.1704761332585;5959.73181206838;5891.410858914074;5928.34788173292;5932.673702946379;5936.406359364029;5949.672767997802;5789.1605717171615;5816.214811000461;5839.5036421904615;5855.560832937632;5861.296644402699;6002.33974262822;6003.849903752441;6005.609635373687;6049.364816694359;6059.121427393092;5837.474627283565;5854.326752423355;5868.149118377897;5889.352171261244;5890.793822216202 05:44:30 INFO - PROCESS | 12799 | |1;ext.html;545.6071628427534;559.2869091907816;590.4213870407002;591.7366771786557;615.5260449453923;39955.80022099889;40437;40454.797726011406;40482.392764108525;40587.188256234855;43370.34944475835;44468.3329750054;44486;44499.33251001238;44676.55323446765;8805.779855503599;8943.731688049369;8988.640454381817;8990.640374385017;9003.14470125337;8822.161894620001;8870.73387798364;8924.732258032236;8944.508052057134;8989.505577193251;8931.77670558238;8987;9011.684591039315;9017.729468115967;9060.184583387494;8759.562021898912;8966.462012279251;8971.955140224258;9001.459912405211;9001.639934402649;8838.381313308008;8886.688965886164;8942.910570894273;8986.955065224698;8998.820023599492;35566;40967.59032409667;41623.791881040706;41771;41782.582174178475;3199.360127974391;3641.927161456756;3681.5950245472977;3701.3337599232127;3757.7369584129124;31772;31812.840935795404;31984.520232196304;32263.677363226303;33074;4294.205571969195;4298.677599180042;4316;4370.519242883281;4384.824607015716;240078;242978;243809;244466;247260;48809.75595122002;65542;66758;66923.66538167375;67058;49951.25073123906;49988;50099;50185;50444;15341.309641066178;15386.615334616501;15465;15477.380904763684;15503.844961550465;10785.83821242682;10813.891861081289;10816.080633146114;10821.83767243492;10843.728906777395;15923.363065477482;16005.599860003593;16611.169441527876;16612.667746645;16727.330906763837;6573.868522629521;6718.899216511756;6724.058631791553;6734.326567343226;6769.526133170631;1024.9699052452386;1044.9268551201344;1068.2628985999636;1107.363266121983;1145.5074318043155;29898.252543686584;30136.24659383533;30264.394712106074;31043.379132417223;31043.844780776402;1099.796537640539;1192.5229908036854;1195.5516681244533;1268.987310126887;1270.1490001698885;15718.764218536731;15821.446249381217;16031.358745650277;16035.278412471467;16129.919350403174;339063;464049;492668;498586;499312;57738;59204;59274;59334.10998835021;59472.702636487404;1486.5391728563964;1491.2394678713933;1496.8802495800528;1497.5582203250067;1503.8420965798434;29751.851240743657;30871.382572348877;31988.520172197903;32681.34637307288;32750.51104451575;51316.23025654544;51626.74186629043;52093.739531302104;52094;52179.478205218984;315906;319343;319462;319508;320066;36133;36347;36432;36456.81771591125;36606.267874642894;47591.52408475871;48058.75970620124;48332;48477;48719.5128048715;38917.41623875701;39063.80468097641;39180;39196;39504;38714.80642596769;39316.41025384564;40039.39940900831;40783.59216407798;40876.1824763509;39344.40983385194;40535.594644053184;40619.390709139974;40680;40861.795691021354;34825.65174348326;34963.65036349604;35265.47101793424;35741.82129089442;35758.28483430265;27197.184084477496;27668.44663106767;27701.168964931083;27864.442711145257;27947.860260698566 05:44:30 INFO - PROCESS | 12799 | |2;jquery.html;366.79826095647405;370.54238016050175;373.6319725070805;379.1261143065235;383.1513198265841;17920.731189032158;18737.812621873778;19797.109130089146;19814.504637384038;19816.70274945877;17789.55526111848;18053.187606557705;18119.18463669135;18214.271429142853;18348.541286467844;5515.944840551593;5673.943260567383;5761.395053519383;5763.049096899007;5771.682557459338;4276.144771045788;6086.847828804293;6292.5595208335435;6310.021946598262;6326.145970293997;6028.095785632168;6158.630482171062;6243.500519958415;6250.5937114087665;6256.562040657156;6175.66033868137;6179.505639548848;6209.410106039919;6220.284667263278;6231.563790534665;5426.782928682848;5485.067538518461;5493.917591236134;5499.752511137009;5553.583481238923;21512;21791;22012.779872201234;22088.33734987953;22277.888610557005;2453.828232023759;2530.3547595363066;2557.3095264278727;2648.523265812153;2913.4318807832483;14168.220747858864;14197.716045679132;14239.78640320396;14281.571552853431;14478.710425791425;1915.6168766246806;1930.5559721264046;1942.2134035715417;2009.7990200979932;2013.818756311939;65530.34469655338;66184.66907665478;66259;67530.3246967529;68889.31110688929;10216.591336346612;10307.278490505592;10582.894171058344;10608.787824243473;10716.624918127829;13819.654508637163;13842.238676872666;13860.861391386159;13922.234277114654;13955.372008259652;7871.134175240719;8015.879761803578;8075.838483230303;8141.715039973573;8142.267195952274;7600.923990760021;7671.232876712395;7748.57382843949;7813.257740514642;7968.362530997506;6371.96814015927;6442.0014897690935;6456.386643268882;6487.837804054936;6539.934600653933;1914.497119761009;2005.7492813398326;2005.7994200579826;2034.7253120828498;2063.535704466483;957.9042095790365;997.5062344139552;1015.3095894791612;1078.6009176604707;1081.5781845080426;17346.548426360583;17549.473515794547;18088.27646894136;18113.275468981356;18602.162902669414;989.1592146675268;999.4403134244847;1018.8267994440963;1023.8720159980003;1028.753099256173;10133.797324053477;10596.682099537025;10605.304648053172;10692.786144277072;10780.676579702622;429415;440404;451537;453762;454855;75733.62133189409;77704.2229577697;77788.61105694436;77816.2218377809;77862.61068694733;986.659602437158;988.9554970026367;995.8356871116184;999.5402115027024;1001.6544292219027;16108.758368624714;16233.918830405772;16298.918505407872;16497.752533712242;16644.58388540296;34300;35181.29637407289;35427;35554;36063.27873442569;49002.26496602483;49889;50496.747516262185;50690;50849.237261440365;8417.242448179693;8469.237768600855;8469.407141500282;8488.702895398632;8660.437071590326;9658.3722058066;12613.558525451564;12839.550615728778;12962.416691248727;12968.35158242103;10878.40168790724;11124.555017799521;11146.665600032013;11218.214724969173;11378.943105284421;10881.510332034919;11123.165762567678;11175.441227938732;11609.419529023684;11693.239939403911;11142.721431964266;11203.495842686936;11264.605738799102;11365.090792736395;11991;8559.95720021396;8564.143585641386;8579.914200858162;8603.139686031347;8603.52680602573;9091.363604547883;10610.628627997983;11578;11597.768044638891;11725.589604363806 05:44:30 INFO - PROCESS | 12799 | |3;mootools.html;1536.3560989740974;1547.4815936661219;1797.1822820616621;1895.715642653601;1934.032983508245;7796.103448103469;8363.330933525318;8522.147785221474;8723.040465548784;8723.738287851367;8301.294389976843;8349.874751878726;8358;8415.70545030924;8424.326053915687;2463.8275320727557;2490.8380955237853;2492.526419980207;2501.1996161228412;2507.9749202508015;2383.5709572276983;2443.645671377658;2446.7308596054418;2461.507698460306;2469.8271121021535;2415.1909110448023;2417.504411595619;2480.466699659573;2492.0779311654715;2492.1775813981435;2435.305937807725;2449.6815413996155;2451.8774061296954;2497.113524698742;2517.446161844391;2424.842385244971;2432.2581612608146;2448.3144719478573;2455.6316552517087;2459.4958033603248;8529.57352132391;8561.229489345926;8569;8589.828203435958;8616.310695144373;5180.844574662766;5351.9296140772;5355.919661205085;5369.060414427459;5386.569074474032;3239.578854748891;3275.197576593726;3292.308615190813;3308.4871844864083;3330.350581636582;990.4799980010553;1006.4565134827185;1021.1269364693229;1024.155072065549;1024.293237666008;11711.063114950868;11751.529938802438;11809.645710628694;11858.644240672707;11875.762484750257;4775.598786994008;4789.784459699322;4807.302941073594;4833.73414462208;4872.561469467694;10070.899291007143;10134;10151.898481015243;10158.339707918962;10172.745681358025;5367.302250707383;5370.516653501204;5392.460753924576;5395.4604539545735;5395.62230643859;4361.062371590124;4821.710697358169;4886.682365646222;4931.309616653672;4957.90084198314;4061.0794260077173;4119.773412462283;4152.356384760367;4155.501339839238;4180.143070670505;1287.3241548187277;1333.6732500537237;1337.8996575256895;1341.5908148014753;1341.6981179234594;1434.8780353670054;1448.3989144504912;1454.6436123149897;1455.6797504548983;1459.88320934325;8238.382121340923;8369.665213391396;8399.748007559783;8406.117357677356;8424.452410593292;1175.5709166154293;1199.5501686867424;1218.7867123253395;1224.0758227538329;1228.3919459867245;6426.164598602245;6458.54790164684;6479.157709497735;6517.989711594711;6551.246606640298;10281.588736450458;10612;10618.681439556825;10677.412742299248;10939.28894621847;10530.73673158162;10655.946720266349;10662.520186591622;10702.625408110678;10803.351798892092;8072.636731346986;8139.75580732579;8178.223068808454;8222.218889205516;8268.627911743986;7574.5833979129475;7643.503172294006;7682.961585192038;7749.65126569317;7752.806179845549;9185.954070229605;9226.907730922605;9405.717828465156;9432.528373581155;9669.226461882892;9557.856632150384;9563.713088607354;9656.275779316438;9669.033096690557;9715.07706767856;6556.311587283458;6983.406410455168;7147.53541019832;7148;7319;8069.152738962559;8082;8091.55496447701;8143.6742530298125;8200.343972482067;7207.675654595451;7254.927450725425;7289.088863892013;7317.414606831334;7398.778036658909;7064.187618423742;7112.715491380287;7134.072570565793;7271;7403.851922961619;7757.26306000929;7792;7853.1361550228285;7859.056913170456;7861.8034549134445;7157.964210178916;7159.677814498465;7176;7195.956586294853;7214.170370407471;7124.964375178091;7151.249118842655;7176.605286709281;7179.389751871149;7194.784156475314 05:44:30 INFO - PROCESS | 12799 | |4;prototype.html;336.74239207006644;350.8561489789186;353.2000019954803;356.64691954964593;363.3586719440187;6402.5198110141755;6452.483801295897;6455.83860403489;6457.225132984043;6460.321666225049;6313.337099604544;6333.619982801024;6335.11308416822;6350.14273073135;6378.266499352576;4702.106599746055;4825.782839772201;4833.613310935134;4834.540718631742;4839.322494850715;4836.081144582518;4864;4864.975675121619;4877.853664390074;4888.071266459379;4793.089313030513;4817.060673168733;4818.831340903069;4824.083424149418;4829.806807727704;4818.229083346648;4827.734474603895;4831.444383895861;4836.830710925136;4836.97581512092;4211.936820947688;4223.260929337384;4225.936610950838;4225.957740422587;4248.426462427564;5900.380460051676;6064.818055458343;6077.058056001327;6079.848003799896;6089.908651370233;5600.383957764642;5615.438456154393;5617.578681598897;5629.3526244482;5633.549316054706;6789.623631728905;6794.830129246759;6798.966005169992;6807.115075040263;6850.520463567552;4498.6626003049905;4509.86470405885;4521.886952826173;4535.183666939949;4552.817887284537;6999.895001574981;7079.185893622248;7082.043924070236;7089.326513981215;7098.148222213367;4610.53894610543;4613.492515823256;4629.328747331685;4711.552402521755;4724.503927087675;4691.366665500113;4694.389729335165;4699.083678682624;4763.857084287477;4786.540105267926;5483.848391837679;5513.558915286768;5515.365732940683;5516.558675305966;5527.309086364205;6739.427148692416;6783;6806.7957961261245;6817.795466136024;6821.488388370892;1649.1918959709897;1660.8339166083294;1662.8919120257144;1666.7249903765985;1674.7739055227632;1067.4662668665667;1081.9296745711504;1086.2396322574073;1105.3754628634795;1125.0212315285753;6525.282218955911;6557.868842623217;6564.8030559082345;6570.967145164339;6599.934000660028;7017.47368947331;7023.192332881784;7032.472564557678;7042.401395881305;7062.6821793019435;6557.311482294386;6568.376004279586;6570.474362051024;6570.507211959122;6572.638504882182;3774.0753515388906;3799.905002374963;3819.8472061117245;3826.0626146594263;3833.6358045985585;7197.964010179916;7339.266073392618;7343.412526997934;7365.852682946311;7388.630568471555;7163.3552980232025;7281.1990681025045;7309.744158954411;7319.41444684424;7335.193128755833;7330.303621155982;7336.7798966031105;7343.37581305595;7378.372838308804;7412.592307423036;6936.583804971718;7069.540479868792;7072.9646351767915;7086.220515743161;7094.645267736696;6935.167779866449;6939.236683964659;6959.338862808025;6960.825979350557;6962.512624116466;7273.127224733066;7285.854282914206;7291.562506249642;7313.012743279589;7326.084239470067;4791.904161916812;4795.688280261911;4809.519048095162;4833.492483289204;4842.201036828884;6868.381845633917;6953.235144134243;7027.367536921702;7040.3663670269925;7122.786316410516;6873.793786186422;6885.2770459101075;6904.240533541206;6905.102336696197;6916.3429474199875;6814.046033555405;6858.5199036067;6864.6910889011115;6897.620630865351;6897.7585784497305;6707.1616047994;6736.663166841737;6760.256371799;6763.425108865801;6773.153355830521;6764.28974957642;6892.207396149306;6951.374376306157;6997.405220556309;7000.264972177848;6717;6725.730970761115;6736.4947628929;6740.561863478858;6776.220734615582 05:44:30 INFO - PROCESS | 12799 | |5;yui.html;816.6447595296046;924.5793164110329;926.4904302633549;931.5063016601199;941.0166376136937;14924.701505969888;14999.775003374945;15086.094834309935;15363.3086511107;15411.383544658229;14255.928720356409;14318.355673994669;14338.068025578355;14438;14502.202378869159;894.6779159502606;913.3880300198882;918.2929144558685;919.2691810011057;924.2421214604027;902.4449963272573;913.2146354135439;916.724982505249;922.5018490015417;925.4077390470104;941.2422999485411;945.6312038305067;948.7628092976756;955.7323949294208;956.5026186383077;937.0582564522646;950.619752099159;950.7242899559119;952.0194199974038;952.4428209497453;696.1333140240382;700.0199720391441;701.1901254051579;704.0600797934763;707.3987110955698;15296.235188240544;15320.463783767515;15395.538133856002;15426.3829446822;15469.381224750996;13933.164010159422;13968;14021.298935053206;14126.92936535321;14161.29193540319;11716.414179291087;11803.881961180365;11815.645530634094;11873.406329683568;12148.757024859453;4011.97994010031;4021.175658989929;4040.9191816163807;4097.364908439196;4130.380442933554;50005.749971250276;50084.248736268986;50525;50739.74630126826;50856.23715644305;10893.83659245112;11151.944240278746;11170;11194.328340299446;11229.943850280859;18891.14989825461;18984.335548256022;19316.806831931783;19461.22155113808;19548.51128721765;8232.670693172326;8265.710700125466;8313.625886835107;8317;8336.749897503085;4637;4714.057188562301;4863.319135321058;4939.580135688507;5009.7244651544515;3389.7796643218603;3402.6767457091537;3405.335959487876;3413.5562376891344;3422.161570415264;594.1177351632822;625.4214851262564;641.3682522715122;643.6556442303345;644.452215616722;695.4575431163701;702.6943279673359;706.7137809187287;711.1963481266137;719.4818136522173;8204.8359032819;8511.65953361871;8544.53005084714;8549.487030778173;8983.685571004984;562.9043062679273;588.552699948034;661.5468404143178;695;706.9893951590731;4185.874423767292;4192.622663960258;4270.807813648394;4341.370501277297;4415.690901636919;59978;60831.39168608257;61399.69300153471;61892.69053654703;62076.68961655253;52669;53226.73386633042;53360;53520.73239633777;53730.73134634302;47247.29129063067;47494.318323719155;48234;48995.51004489909;50135.49864501381;9293.210077143518;9299.814003719752;9356.672516461891;9435.05649435051;9684.128428441192;34968.82515587406;35651.10872228215;36323;36341.63658363382;36673.26653466969;42039.7898010508;42395.7880210597;45845.54154458546;46537.53462465332;47320;11931;11954.701132471759;12022.939885300517;12344.074194435274;12650.620481385573;12985.28580928058;13029.934850325688;13381.330933453482;14408.783868241775;14651.780223296446;11792.882071179178;11817.29096254193;12359.69100772452;12807.807882881578;13233.735325293634;12618.36908154607;12641.936790316358;12794.936025319814;12849.550265740654;12923.870761292266;11327.603533876274;12516.249025058525;12544.310062946626;12720.491180353052;13121.868781312065;10558.472076396303;10559.841602376124;10603.416812075102;10778.137748979905;10820.5130769114;10683.091937185116;10735.570577176826;10777.784444311226;10792.946035269773;10926.071283940953 05:44:30 INFO - PROCESS | 12799 | __end_tp_report 05:44:30 INFO - PROCESS | 12799 | __start_cc_report 05:44:30 INFO - PROCESS | 12799 | _x_x_mozilla_cycle_collect,336 05:44:30 INFO - PROCESS | 12799 | __end_cc_report 05:44:30 INFO - PROCESS | 12799 | __startTimestamp1459514670300__endTimestamp 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | ------- Summary: start ------- 05:44:30 INFO - PROCESS | 12799 | Number of tests: 6 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | [#0] dojo.html Cycles:165 Average:5605.44 Median:5855.56 stddev:625.44 (10.7%) stddev-sans-first:601.02 05:44:30 INFO - PROCESS | 12799 | Values: 3315.9 3398.7 3424.0 3460.1 3469.8 5324.7 5509.8 5513.8 5514.4 5542.1 5542.1 5562.0 5562.9 5579.3 5586.1 5063.7 5097.9 5129.1 5141.2 5159.2 5071.1 5094.8 5214.9 5243.5 5244.2 5112.9 5129.2 5182.3 5196.4 5214.0 5103.8 5166.7 5173.9 5177.8 5180.7 4951.4 4998.4 5149.5 5160.6 5184.9 5454.8 5455.4 5456.1 5461.4 5486.0 6047.9 6068.2 6084.6 6093.9 6094.8 5948.9 6039.3 6106.3 6112.7 6119.8 5574.5 5576.9 5577.4 5579.6 5583.5 6016.9 6022.0 6026.2 6033.5 6042.9 5826.0 5886.7 5950.0 5976.8 6002.7 6009.1 6012.6 6013.5 6020.0 6035.7 5897.5 5965.1 5974.8 5978.4 5980.3 5940.3 5967.5 5974.8 6000.9 6032.2 4575.1 4596.0 4611.9 4617.4 4634.7 4025.7 4067.3 4107.8 4148.5 4187.5 5713.1 5730.7 5756.8 5794.8 5802.6 6027.0 6071.2 6118.1 6127.3 6136.1 5689.4 5695.1 5714.2 5722.0 5734.7 5100.8 5130.9 5155.8 5165.7 5165.7 6196.4 6234.1 6243.5 6249.0 6254.5 6100.2 6106.3 6108.5 6111.0 6112.5 6068.8 6167.1 6200.6 6208.8 6227.7 6053.5 6055.4 6057.3 6057.3 6067.7 6137.5 6154.6 6157.1 6163.4 6171.7 5812.4 5871.8 5923.2 5925.2 5959.7 5891.4 5928.3 5932.7 5936.4 5949.7 5789.2 5816.2 5839.5 5855.6 5861.3 6002.3 6003.8 6005.6 6049.4 6059.1 5837.5 5854.3 5868.1 5889.4 5890.8 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | [#1] ext.html Cycles:180 Average:51501.75 Median:39997.60 stddev:93423.68 (233.6%) stddev-sans-first:93607.42 05:44:30 INFO - PROCESS | 12799 | Values: 545.6 559.3 590.4 591.7 615.5 39955.8 40437.0 40454.8 40482.4 40587.2 43370.3 44468.3 44486.0 44499.3 44676.6 8805.8 8943.7 8988.6 8990.6 9003.1 8822.2 8870.7 8924.7 8944.5 8989.5 8931.8 8987.0 9011.7 9017.7 9060.2 8759.6 8966.5 8972.0 9001.5 9001.6 8838.4 8886.7 8942.9 8987.0 8998.8 35566.0 40967.6 41623.8 41771.0 41782.6 3199.4 3641.9 3681.6 3701.3 3757.7 31772.0 31812.8 31984.5 32263.7 33074.0 4294.2 4298.7 4316.0 4370.5 4384.8 240078.0 242978.0 243809.0 244466.0 247260.0 48809.8 65542.0 66758.0 66923.7 67058.0 49951.3 49988.0 50099.0 50185.0 50444.0 15341.3 15386.6 15465.0 15477.4 15503.8 10785.8 10813.9 10816.1 10821.8 10843.7 15923.4 16005.6 16611.2 16612.7 16727.3 6573.9 6718.9 6724.1 6734.3 6769.5 1025.0 1044.9 1068.3 1107.4 1145.5 29898.3 30136.2 30264.4 31043.4 31043.8 1099.8 1192.5 1195.6 1269.0 1270.1 15718.8 15821.4 16031.4 16035.3 16129.9 339063.0 464049.0 492668.0 498586.0 499312.0 57738.0 59204.0 59274.0 59334.1 59472.7 1486.5 1491.2 1496.9 1497.6 1503.8 29751.9 30871.4 31988.5 32681.3 32750.5 51316.2 51626.7 52093.7 52094.0 52179.5 315906.0 319343.0 319462.0 319508.0 320066.0 36133.0 36347.0 36432.0 36456.8 36606.3 47591.5 48058.8 48332.0 48477.0 48719.5 38917.4 39063.8 39180.0 39196.0 39504.0 38714.8 39316.4 40039.4 40783.6 40876.2 39344.4 40535.6 40619.4 40680.0 40861.8 34825.7 34963.7 35265.5 35741.8 35758.3 27197.2 27668.4 27701.2 27864.4 27947.9 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | [#2] jquery.html Cycles:180 Average:26507.12 Median:34740.65 stddev:73135.06 (210.5%) stddev-sans-first:73313.89 05:44:30 INFO - PROCESS | 12799 | Values: 366.8 370.5 373.6 379.1 383.2 17920.7 18737.8 19797.1 19814.5 19816.7 17789.6 18053.2 18119.2 18214.3 18348.5 5515.9 5673.9 5761.4 5763.0 5771.7 4276.1 6086.8 6292.6 6310.0 6326.1 6028.1 6158.6 6243.5 6250.6 6256.6 6175.7 6179.5 6209.4 6220.3 6231.6 5426.8 5485.1 5493.9 5499.8 5553.6 21512.0 21791.0 22012.8 22088.3 22277.9 2453.8 2530.4 2557.3 2648.5 2913.4 14168.2 14197.7 14239.8 14281.6 14478.7 1915.6 1930.6 1942.2 2009.8 2013.8 65530.3 66184.7 66259.0 67530.3 68889.3 10216.6 10307.3 10582.9 10608.8 10716.6 13819.7 13842.2 13860.9 13922.2 13955.4 7871.1 8015.9 8075.8 8141.7 8142.3 7600.9 7671.2 7748.6 7813.3 7968.4 6372.0 6442.0 6456.4 6487.8 6539.9 1914.5 2005.7 2005.8 2034.7 2063.5 957.9 997.5 1015.3 1078.6 1081.6 17346.5 17549.5 18088.3 18113.3 18602.2 989.2 999.4 1018.8 1023.9 1028.8 10133.8 10596.7 10605.3 10692.8 10780.7 429415.0 440404.0 451537.0 453762.0 454855.0 75733.6 77704.2 77788.6 77816.2 77862.6 986.7 989.0 995.8 999.5 1001.7 16108.8 16233.9 16298.9 16497.8 16644.6 34300.0 35181.3 35427.0 35554.0 36063.3 49002.3 49889.0 50496.7 50690.0 50849.2 8417.2 8469.2 8469.4 8488.7 8660.4 9658.4 12613.6 12839.6 12962.4 12968.4 10878.4 11124.6 11146.7 11218.2 11378.9 10881.5 11123.2 11175.4 11609.4 11693.2 11142.7 11203.5 11264.6 11365.1 11991.0 8560.0 8564.1 8579.9 8603.1 8603.5 9091.4 10610.6 11578.0 11597.8 11725.6 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | [#3] mootools.html Cycles:180 Average:6025.99 Median:5353.92 stddev:3130.71 (58.5%) stddev-sans-first:3121.30 05:44:30 INFO - PROCESS | 12799 | Values: 1536.4 1547.5 1797.2 1895.7 1934.0 7796.1 8363.3 8522.1 8723.0 8723.7 8301.3 8349.9 8358.0 8415.7 8424.3 2463.8 2490.8 2492.5 2501.2 2508.0 2383.6 2443.6 2446.7 2461.5 2469.8 2415.2 2417.5 2480.5 2492.1 2492.2 2435.3 2449.7 2451.9 2497.1 2517.4 2424.8 2432.3 2448.3 2455.6 2459.5 8529.6 8561.2 8569.0 8589.8 8616.3 5180.8 5351.9 5355.9 5369.1 5386.6 3239.6 3275.2 3292.3 3308.5 3330.4 990.5 1006.5 1021.1 1024.2 1024.3 11711.1 11751.5 11809.6 11858.6 11875.8 4775.6 4789.8 4807.3 4833.7 4872.6 10070.9 10134.0 10151.9 10158.3 10172.7 5367.3 5370.5 5392.5 5395.5 5395.6 4361.1 4821.7 4886.7 4931.3 4957.9 4061.1 4119.8 4152.4 4155.5 4180.1 1287.3 1333.7 1337.9 1341.6 1341.7 1434.9 1448.4 1454.6 1455.7 1459.9 8238.4 8369.7 8399.7 8406.1 8424.5 1175.6 1199.6 1218.8 1224.1 1228.4 6426.2 6458.5 6479.2 6518.0 6551.2 10281.6 10612.0 10618.7 10677.4 10939.3 10530.7 10655.9 10662.5 10702.6 10803.4 8072.6 8139.8 8178.2 8222.2 8268.6 7574.6 7643.5 7683.0 7749.7 7752.8 9186.0 9226.9 9405.7 9432.5 9669.2 9557.9 9563.7 9656.3 9669.0 9715.1 6556.3 6983.4 7147.5 7148.0 7319.0 8069.2 8082.0 8091.6 8143.7 8200.3 7207.7 7254.9 7289.1 7317.4 7398.8 7064.2 7112.7 7134.1 7271.0 7403.9 7757.3 7792.0 7853.1 7859.1 7861.8 7158.0 7159.7 7176.0 7196.0 7214.2 7125.0 7151.2 7176.6 7179.4 7194.8 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | [#4] prototype.html Cycles:180 Average:5678.72 Median:6541.30 stddev:1751.66 (26.8%) stddev-sans-first:1710.07 05:44:30 INFO - PROCESS | 12799 | Values: 336.7 350.9 353.2 356.6 363.4 6402.5 6452.5 6455.8 6457.2 6460.3 6313.3 6333.6 6335.1 6350.1 6378.3 4702.1 4825.8 4833.6 4834.5 4839.3 4836.1 4864.0 4865.0 4877.9 4888.1 4793.1 4817.1 4818.8 4824.1 4829.8 4818.2 4827.7 4831.4 4836.8 4837.0 4211.9 4223.3 4225.9 4226.0 4248.4 5900.4 6064.8 6077.1 6079.8 6089.9 5600.4 5615.4 5617.6 5629.4 5633.5 6789.6 6794.8 6799.0 6807.1 6850.5 4498.7 4509.9 4521.9 4535.2 4552.8 6999.9 7079.2 7082.0 7089.3 7098.1 4610.5 4613.5 4629.3 4711.6 4724.5 4691.4 4694.4 4699.1 4763.9 4786.5 5483.8 5513.6 5515.4 5516.6 5527.3 6739.4 6783.0 6806.8 6817.8 6821.5 1649.2 1660.8 1662.9 1666.7 1674.8 1067.5 1081.9 1086.2 1105.4 1125.0 6525.3 6557.9 6564.8 6571.0 6599.9 7017.5 7023.2 7032.5 7042.4 7062.7 6557.3 6568.4 6570.5 6570.5 6572.6 3774.1 3799.9 3819.8 3826.1 3833.6 7198.0 7339.3 7343.4 7365.9 7388.6 7163.4 7281.2 7309.7 7319.4 7335.2 7330.3 7336.8 7343.4 7378.4 7412.6 6936.6 7069.5 7073.0 7086.2 7094.6 6935.2 6939.2 6959.3 6960.8 6962.5 7273.1 7285.9 7291.6 7313.0 7326.1 4791.9 4795.7 4809.5 4833.5 4842.2 6868.4 6953.2 7027.4 7040.4 7122.8 6873.8 6885.3 6904.2 6905.1 6916.3 6814.0 6858.5 6864.7 6897.6 6897.8 6707.2 6736.7 6760.3 6763.4 6773.2 6764.3 6892.2 6951.4 6997.4 7000.3 6717.0 6725.7 6736.5 6740.6 6776.2 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - PROCESS | 12799 | [#5] yui.html Cycles:180 Average:14736.37 Median:4378.53 stddev:16566.01 (378.3%) stddev-sans-first:16579.50 05:44:30 INFO - PROCESS | 12799 | Values: 816.6 924.6 926.5 931.5 941.0 14924.7 14999.8 15086.1 15363.3 15411.4 14255.9 14318.4 14338.1 14438.0 14502.2 894.7 913.4 918.3 919.3 924.2 902.4 913.2 916.7 922.5 925.4 941.2 945.6 948.8 955.7 956.5 937.1 950.6 950.7 952.0 952.4 696.1 700.0 701.2 704.1 707.4 15296.2 15320.5 15395.5 15426.4 15469.4 13933.2 13968.0 14021.3 14126.9 14161.3 11716.4 11803.9 11815.6 11873.4 12148.8 4012.0 4021.2 4040.9 4097.4 4130.4 50005.7 50084.2 50525.0 50739.7 50856.2 10893.8 11151.9 11170.0 11194.3 11229.9 18891.1 18984.3 19316.8 19461.2 19548.5 8232.7 8265.7 8313.6 8317.0 8336.7 4637.0 4714.1 4863.3 4939.6 5009.7 3389.8 3402.7 3405.3 3413.6 3422.2 594.1 625.4 641.4 643.7 644.5 695.5 702.7 706.7 711.2 719.5 8204.8 8511.7 8544.5 8549.5 8983.7 562.9 588.6 661.5 695.0 707.0 4185.9 4192.6 4270.8 4341.4 4415.7 59978.0 60831.4 61399.7 61892.7 62076.7 52669.0 53226.7 53360.0 53520.7 53730.7 47247.3 47494.3 48234.0 48995.5 50135.5 9293.2 9299.8 9356.7 9435.1 9684.1 34968.8 35651.1 36323.0 36341.6 36673.3 42039.8 42395.8 45845.5 46537.5 47320.0 11931.0 11954.7 12022.9 12344.1 12650.6 12985.3 13029.9 13381.3 14408.8 14651.8 11792.9 11817.3 12359.7 12807.8 13233.7 12618.4 12641.9 12794.9 12849.6 12923.9 11327.6 12516.2 12544.3 12720.5 13121.9 10558.5 10559.8 10603.4 10778.1 10820.5 10683.1 10735.6 10777.8 10792.9 10926.1 05:44:30 INFO - PROCESS | 12799 | -------- Summary: end -------- 05:44:30 INFO - PROCESS | 12799 | 05:44:30 INFO - TEST-INFO | 12799: exit 0 05:44:30 INFO - TEST-OK | dromaeo_css | took 1110005ms 05:44:30 INFO - TEST-START | kraken 05:44:30 INFO - operating with platform_type : linux_ 05:44:30 INFO - Initialising browser for kraken test... 05:44:30 INFO - TEST-INFO | started process 13044 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWw_hxa/profile http://localhost:36208/getInfo.html) 05:44:34 INFO - PROCESS | 13044 | 05:44:34 INFO - PROCESS | 13044 | (process:13120): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:35 INFO - PROCESS | 13044 | __metrics Screen width/height:1600/1200 05:44:35 INFO - PROCESS | 13044 | colorDepth:24 05:44:35 INFO - PROCESS | 13044 | Browser inner width/height: 1024/697 05:44:35 INFO - PROCESS | 13044 | __metrics 05:44:36 ERROR - PROCESS | 13044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:44:37 INFO - TEST-INFO | 13044: exit 0 05:44:37 INFO - Browser initialized. 05:44:37 INFO - Running cycle 1/1 for kraken test... 05:44:37 INFO - TEST-INFO | started process 13171 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWw_hxa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:38 INFO - PROCESS | 13171 | 05:44:38 INFO - PROCESS | 13171 | (process:13241): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:48 INFO - PROCESS | 13171 | RSS: Main: 154525696 05:44:48 INFO - PROCESS | 13171 | 05:44:51 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36208/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:51 INFO - PROCESS | 13171 | RSS: Main: 159354880 05:44:51 INFO - PROCESS | 13171 | 05:44:54 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36208/tests/kraken/driver.html?testName=audio-dft) 05:44:55 INFO - PROCESS | 13171 | RSS: Main: 158023680 05:44:55 INFO - PROCESS | 13171 | 05:44:58 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36208/tests/kraken/driver.html?testName=audio-fft) 05:44:58 INFO - PROCESS | 13171 | RSS: Main: 158961664 05:44:58 INFO - PROCESS | 13171 | 05:45:00 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36208/tests/kraken/driver.html?testName=audio-oscillator) 05:45:01 INFO - PROCESS | 13171 | RSS: Main: 159023104 05:45:01 INFO - PROCESS | 13171 | 05:45:03 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:04 INFO - PROCESS | 13171 | RSS: Main: 160280576 05:45:04 INFO - PROCESS | 13171 | 05:45:07 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36208/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:07 INFO - PROCESS | 13171 | RSS: Main: 158605312 05:45:07 INFO - PROCESS | 13171 | 05:45:11 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36208/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:11 INFO - PROCESS | 13171 | RSS: Main: 159330304 05:45:11 INFO - PROCESS | 13171 | 05:45:14 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36208/tests/kraken/driver.html?testName=json-parse-financial) 05:45:15 INFO - PROCESS | 13171 | RSS: Main: 158547968 05:45:15 INFO - PROCESS | 13171 | 05:45:16 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:17 INFO - PROCESS | 13171 | RSS: Main: 160399360 05:45:17 INFO - PROCESS | 13171 | 05:45:18 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:19 INFO - PROCESS | 13171 | RSS: Main: 158613504 05:45:19 INFO - PROCESS | 13171 | 05:45:21 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:22 INFO - PROCESS | 13171 | RSS: Main: 158994432 05:45:22 INFO - PROCESS | 13171 | 05:45:24 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:25 INFO - PROCESS | 13171 | RSS: Main: 160718848 05:45:25 INFO - PROCESS | 13171 | 05:45:27 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:28 INFO - PROCESS | 13171 | RSS: Main: 160256000 05:45:28 INFO - PROCESS | 13171 | 05:45:29 INFO - PROCESS | 13171 | Cycle 1(1): loaded http://localhost:36208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36208/tests/kraken/driver.html?testName=ai-astar) 05:45:30 INFO - PROCESS | 13171 | RSS: Main: 160948224 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | __start_tp_report 05:45:30 INFO - PROCESS | 13171 | _x_x_mozilla_page_load 05:45:30 INFO - PROCESS | 13171 | _x_x_mozilla_page_load_details 05:45:30 INFO - PROCESS | 13171 | |i|pagename|runs| 05:45:30 INFO - PROCESS | 13171 | |0;ai-astar;111;106;110;111;110;121;111;109;110;110 05:45:30 INFO - PROCESS | 13171 | |1;audio-beat-detection;148;128;145;164;131;148;161;126;174;137 05:45:30 INFO - PROCESS | 13171 | |2;audio-dft;163;163;162;163;161;161;164;162;164;161 05:45:30 INFO - PROCESS | 13171 | |3;audio-fft;74;72;74;165;76;73;73;73;161;74 05:45:30 INFO - PROCESS | 13171 | |4;audio-oscillator;93;92;147;94;101;93;149;92;93;142 05:45:30 INFO - PROCESS | 13171 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;120;118;116 05:45:30 INFO - PROCESS | 13171 | |6;imaging-darkroom;146;147;147;146;148;147;146;146;148;147 05:45:30 INFO - PROCESS | 13171 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 05:45:30 INFO - PROCESS | 13171 | |8;json-parse-financial;59;55;56;55;54;55;59;61;58;54 05:45:30 INFO - PROCESS | 13171 | |9;json-stringify-tinderbox;65;64;65;64;65;64;65;65;64;65 05:45:30 INFO - PROCESS | 13171 | |10;stanford-crypto-aes;79;78;78;89;79;82;81;80;86;80 05:45:30 INFO - PROCESS | 13171 | |11;stanford-crypto-ccm;118;110;110;118;118;121;113;111;110;116 05:45:30 INFO - PROCESS | 13171 | |12;stanford-crypto-pbkdf2;153;151;141;135;142;142;133;134;147;131 05:45:30 INFO - PROCESS | 13171 | |13;stanford-crypto-sha256-iterative;66;65;68;65;66;64;66;68;65;65 05:45:30 INFO - PROCESS | 13171 | __end_tp_report 05:45:30 INFO - PROCESS | 13171 | __start_cc_report 05:45:30 INFO - PROCESS | 13171 | _x_x_mozilla_cycle_collect,818 05:45:30 INFO - PROCESS | 13171 | __end_cc_report 05:45:30 INFO - PROCESS | 13171 | __startTimestamp1459514730194__endTimestamp 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | ------- Summary: start ------- 05:45:30 INFO - PROCESS | 13171 | Number of tests: 14 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.50 stddev:3.84 (3.5%) stddev-sans-first:4.08 05:45:30 INFO - PROCESS | 13171 | Values: 111.0 106.0 110.0 111.0 110.0 121.0 111.0 109.0 110.0 110.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:148.00 stddev:16.23 (11.0%) stddev-sans-first:17.20 05:45:30 INFO - PROCESS | 13171 | Values: 148.0 128.0 145.0 164.0 131.0 148.0 161.0 126.0 174.0 137.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 05:45:30 INFO - PROCESS | 13171 | Values: 163.0 163.0 162.0 163.0 161.0 161.0 164.0 162.0 164.0 161.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#3] audio-fft Cycles:10 Average:91.50 Median:73.50 stddev:37.71 (51.3%) stddev-sans-first:39.46 05:45:30 INFO - PROCESS | 13171 | Values: 74.0 72.0 74.0 165.0 76.0 73.0 73.0 73.0 161.0 74.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.50 stddev:25.31 (27.4%) stddev-sans-first:26.12 05:45:30 INFO - PROCESS | 13171 | Values: 93.0 92.0 147.0 94.0 101.0 93.0 149.0 92.0 93.0 142.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 05:45:30 INFO - PROCESS | 13171 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 120.0 118.0 116.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:45:30 INFO - PROCESS | 13171 | Values: 146.0 147.0 147.0 146.0 148.0 147.0 146.0 146.0 148.0 147.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:45:30 INFO - PROCESS | 13171 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:2.46 (4.3%) stddev-sans-first:2.45 05:45:30 INFO - PROCESS | 13171 | Values: 59.0 55.0 56.0 55.0 54.0 55.0 59.0 61.0 58.0 54.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:45:30 INFO - PROCESS | 13171 | Values: 65.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:3.61 (4.5%) stddev-sans-first:3.75 05:45:30 INFO - PROCESS | 13171 | Values: 79.0 78.0 78.0 89.0 79.0 82.0 81.0 80.0 86.0 80.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#11] stanford-crypto-ccm Cycles:10 Average:114.50 Median:117.00 stddev:4.17 (3.6%) stddev-sans-first:4.23 05:45:30 INFO - PROCESS | 13171 | Values: 118.0 110.0 110.0 118.0 118.0 121.0 113.0 111.0 110.0 116.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:142.00 stddev:7.68 (5.4%) stddev-sans-first:6.78 05:45:30 INFO - PROCESS | 13171 | Values: 153.0 151.0 141.0 135.0 142.0 142.0 133.0 134.0 147.0 131.0 05:45:30 INFO - PROCESS | 13171 | 05:45:30 INFO - PROCESS | 13171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 05:45:30 INFO - PROCESS | 13171 | Values: 66.0 65.0 68.0 65.0 66.0 64.0 66.0 68.0 65.0 65.0 05:45:30 INFO - PROCESS | 13171 | -------- Summary: end -------- 05:45:30 INFO - PROCESS | 13171 | 05:45:31 INFO - TEST-INFO | 13171: exit 0 05:45:31 INFO - TEST-OK | kraken | took 60117ms 05:45:31 INFO - SUITE-END | took 1170s 05:45:31 INFO - Completed test suite (00:19:30) 05:45:31 INFO - javascript benchmark 05:45:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3315.883944061958, 3398.6601339866015, 3424.0, 3460.1003739027847, 3469.774464659797, 5324.65389749666, 5509.752061157247, 5513.751881165347, 5514.448555144489, 5542.1409681499335, 5542.0855558832745, 5562.0, 5562.888742225153, 5579.302587176603, 5586.10622300431, 5063.696178229299, 5097.872553186163, 5129.051125541768, 5141.228815677659, 5159.2003239497935, 5071.112555302826, 5094.821681241157, 5214.869628259305, 5243.501867322599, 5244.239585260135, 5112.8977420451565, 5129.204973229155, 5182.274481572583, 5196.350456192976, 5214.035403450355, 5103.770330335125, 5166.664166829163, 5173.948260517384, 5177.76700048495, 5180.6891586504935, 4951.43058548268, 4998.375203099613, 5149.459306772772, 5160.638755287131, 5184.870378240536, 5454.809081682122, 5455.427180146107, 5456.072467680504, 5461.371942226655, 5485.9725701371635, 6047.939520604782, 6068.241469816273, 6084.60450070744, 6093.939060609381, 6094.847628809271, 5948.940510594882, 6039.305479869828, 6106.328303886569, 6112.724927378279, 6119.785807496761, 5574.526165275915, 5576.944230557724, 5577.386487486373, 5579.553635709133, 5583.469570390806, 6016.8796624068145, 6021.969890150521, 6026.156338112668, 6033.456988871023, 6042.879142417127, 5826.038703613941, 5886.676232807151, 5950.0, 5976.804639072116, 6002.699865006733, 6009.06859436788, 6012.579119461596, 6013.51891848651, 6019.969900150471, 6035.7283922223605, 5897.49871260939, 5965.075413310944, 5974.761009559656, 5978.372270911578, 5980.342162362137, 5940.316863560746, 5967.522598192134, 5974.761009559569, 6000.879982400327, 6032.155498230251, 4575.084983003346, 4595.977020114878, 4611.8847028823875, 4617.353570500132, 4634.72191668501, 4025.6578190854107, 4067.349224124185, 4107.835686572564, 4148.522919864194, 4187.539370669224, 5713.05734553794, 5730.71346432685, 5756.827295181151, 5794.797182098607, 5802.593818432669, 6027.0, 6071.210742603522, 6118.1087851938255, 6127.325994140641, 6136.0902143038675, 5689.374168841424, 5695.088785794253, 5714.228579141846, 5722.0, 5734.741936612862, 5100.795968161232, 5130.948690513122, 5155.7679904404395, 5165.66423182492, 5165.741712914414, 6196.442320191204, 6234.127222188898, 6243.531735119885, 6249.0, 6254.530910181755, 6100.206973093558, 6106.267247930276, 6108.450239478469, 6111.0, 6112.480439162721, 6068.817935461943, 6167.074938759222, 6200.627962322094, 6208.751649933952, 6227.719752611053, 6053.485453736482, 6055.364186760503, 6057.273127224761, 6057.333693293646, 6067.726952287246, 6137.478314343331, 6154.569180157346, 6157.107219453064, 6163.3836616338, 6171.691415429121, 5812.389699081536, 5871.794487192928, 5923.229980102559, 5925.1704761332585, 5959.73181206838, 5891.410858914074, 5928.34788173292, 5932.673702946379, 5936.406359364029, 5949.672767997802, 5789.1605717171615, 5816.214811000461, 5839.5036421904615, 5855.560832937632, 5861.296644402699, 6002.33974262822, 6003.849903752441, 6005.609635373687, 6049.364816694359, 6059.121427393092, 5837.474627283565, 5854.326752423355, 5868.149118377897, 5889.352171261244, 5890.793822216202], "unit": "score", "name": "dojo.html", "value": 5564.763246046265}, {"lowerIsBetter": false, "replicates": [545.6071628427534, 559.2869091907816, 590.4213870407002, 591.7366771786557, 615.5260449453923, 39955.80022099889, 40437.0, 40454.797726011406, 40482.392764108525, 40587.188256234855, 43370.34944475835, 44468.3329750054, 44486.0, 44499.33251001238, 44676.55323446765, 8805.779855503599, 8943.731688049369, 8988.640454381817, 8990.640374385017, 9003.14470125337, 8822.161894620001, 8870.73387798364, 8924.732258032236, 8944.508052057134, 8989.505577193251, 8931.77670558238, 8987.0, 9011.684591039315, 9017.729468115967, 9060.184583387494, 8759.562021898912, 8966.462012279251, 8971.955140224258, 9001.459912405211, 9001.639934402649, 8838.381313308008, 8886.688965886164, 8942.910570894273, 8986.955065224698, 8998.820023599492, 35566.0, 40967.59032409667, 41623.791881040706, 41771.0, 41782.582174178475, 3199.360127974391, 3641.927161456756, 3681.5950245472977, 3701.3337599232127, 3757.7369584129124, 31772.0, 31812.840935795404, 31984.520232196304, 32263.677363226303, 33074.0, 4294.205571969195, 4298.677599180042, 4316.0, 4370.519242883281, 4384.824607015716, 240078.0, 242978.0, 243809.0, 244466.0, 247260.0, 48809.75595122002, 65542.0, 66758.0, 66923.66538167375, 67058.0, 49951.25073123906, 49988.0, 50099.0, 50185.0, 50444.0, 15341.309641066178, 15386.615334616501, 15465.0, 15477.380904763684, 15503.844961550465, 10785.83821242682, 10813.891861081289, 10816.080633146114, 10821.83767243492, 10843.728906777395, 15923.363065477482, 16005.599860003593, 16611.169441527876, 16612.667746645, 16727.330906763837, 6573.868522629521, 6718.899216511756, 6724.058631791553, 6734.326567343226, 6769.526133170631, 1024.9699052452386, 1044.9268551201344, 1068.2628985999636, 1107.363266121983, 1145.5074318043155, 29898.252543686584, 30136.24659383533, 30264.394712106074, 31043.379132417223, 31043.844780776402, 1099.796537640539, 1192.5229908036854, 1195.5516681244533, 1268.987310126887, 1270.1490001698885, 15718.764218536731, 15821.446249381217, 16031.358745650277, 16035.278412471467, 16129.919350403174, 339063.0, 464049.0, 492668.0, 498586.0, 499312.0, 57738.0, 59204.0, 59274.0, 59334.10998835021, 59472.702636487404, 1486.5391728563964, 1491.2394678713933, 1496.8802495800528, 1497.5582203250067, 1503.8420965798434, 29751.851240743657, 30871.382572348877, 31988.520172197903, 32681.34637307288, 32750.51104451575, 51316.23025654544, 51626.74186629043, 52093.739531302104, 52094.0, 52179.478205218984, 315906.0, 319343.0, 319462.0, 319508.0, 320066.0, 36133.0, 36347.0, 36432.0, 36456.81771591125, 36606.267874642894, 47591.52408475871, 48058.75970620124, 48332.0, 48477.0, 48719.5128048715, 38917.41623875701, 39063.80468097641, 39180.0, 39196.0, 39504.0, 38714.80642596769, 39316.41025384564, 40039.39940900831, 40783.59216407798, 40876.1824763509, 39344.40983385194, 40535.594644053184, 40619.390709139974, 40680.0, 40861.795691021354, 34825.65174348326, 34963.65036349604, 35265.47101793424, 35741.82129089442, 35758.28483430265, 27197.184084477496, 27668.44663106767, 27701.168964931083, 27864.442711145257, 27947.860260698566], "unit": "score", "name": "ext.html", "value": 19440.194283962977}, {"lowerIsBetter": false, "replicates": [366.79826095647405, 370.54238016050175, 373.6319725070805, 379.1261143065235, 383.1513198265841, 17920.731189032158, 18737.812621873778, 19797.109130089146, 19814.504637384038, 19816.70274945877, 17789.55526111848, 18053.187606557705, 18119.18463669135, 18214.271429142853, 18348.541286467844, 5515.944840551593, 5673.943260567383, 5761.395053519383, 5763.049096899007, 5771.682557459338, 4276.144771045788, 6086.847828804293, 6292.5595208335435, 6310.021946598262, 6326.145970293997, 6028.095785632168, 6158.630482171062, 6243.500519958415, 6250.5937114087665, 6256.562040657156, 6175.66033868137, 6179.505639548848, 6209.410106039919, 6220.284667263278, 6231.563790534665, 5426.782928682848, 5485.067538518461, 5493.917591236134, 5499.752511137009, 5553.583481238923, 21512.0, 21791.0, 22012.779872201234, 22088.33734987953, 22277.888610557005, 2453.828232023759, 2530.3547595363066, 2557.3095264278727, 2648.523265812153, 2913.4318807832483, 14168.220747858864, 14197.716045679132, 14239.78640320396, 14281.571552853431, 14478.710425791425, 1915.6168766246806, 1930.5559721264046, 1942.2134035715417, 2009.7990200979932, 2013.818756311939, 65530.34469655338, 66184.66907665478, 66259.0, 67530.3246967529, 68889.31110688929, 10216.591336346612, 10307.278490505592, 10582.894171058344, 10608.787824243473, 10716.624918127829, 13819.654508637163, 13842.238676872666, 13860.861391386159, 13922.234277114654, 13955.372008259652, 7871.134175240719, 8015.879761803578, 8075.838483230303, 8141.715039973573, 8142.267195952274, 7600.923990760021, 7671.232876712395, 7748.57382843949, 7813.257740514642, 7968.362530997506, 6371.96814015927, 6442.0014897690935, 6456.386643268882, 6487.837804054936, 6539.934600653933, 1914.497119761009, 2005.7492813398326, 2005.7994200579826, 2034.7253120828498, 2063.535704466483, 957.9042095790365, 997.5062344139552, 1015.3095894791612, 1078.6009176604707, 1081.5781845080426, 17346.548426360583, 17549.473515794547, 18088.27646894136, 18113.275468981356, 18602.162902669414, 989.1592146675268, 999.4403134244847, 1018.8267994440963, 1023.8720159980003, 1028.753099256173, 10133.797324053477, 10596.682099537025, 10605.304648053172, 10692.786144277072, 10780.676579702622, 429415.0, 440404.0, 451537.0, 453762.0, 454855.0, 75733.62133189409, 77704.2229577697, 77788.61105694436, 77816.2218377809, 77862.61068694733, 986.659602437158, 988.9554970026367, 995.8356871116184, 999.5402115027024, 1001.6544292219027, 16108.758368624714, 16233.918830405772, 16298.918505407872, 16497.752533712242, 16644.58388540296, 34300.0, 35181.29637407289, 35427.0, 35554.0, 36063.27873442569, 49002.26496602483, 49889.0, 50496.747516262185, 50690.0, 50849.237261440365, 8417.242448179693, 8469.237768600855, 8469.407141500282, 8488.702895398632, 8660.437071590326, 9658.3722058066, 12613.558525451564, 12839.550615728778, 12962.416691248727, 12968.35158242103, 10878.40168790724, 11124.555017799521, 11146.665600032013, 11218.214724969173, 11378.943105284421, 10881.510332034919, 11123.165762567678, 11175.441227938732, 11609.419529023684, 11693.239939403911, 11142.721431964266, 11203.495842686936, 11264.605738799102, 11365.090792736395, 11991.0, 8559.95720021396, 8564.143585641386, 8579.914200858162, 8603.139686031347, 8603.52680602573, 9091.363604547883, 10610.628627997983, 11578.0, 11597.768044638891, 11725.589604363806], "unit": "score", "name": "jquery.html", "value": 9087.789358635102}, {"lowerIsBetter": false, "replicates": [1536.3560989740974, 1547.4815936661219, 1797.1822820616621, 1895.715642653601, 1934.032983508245, 7796.103448103469, 8363.330933525318, 8522.147785221474, 8723.040465548784, 8723.738287851367, 8301.294389976843, 8349.874751878726, 8358.0, 8415.70545030924, 8424.326053915687, 2463.8275320727557, 2490.8380955237853, 2492.526419980207, 2501.1996161228412, 2507.9749202508015, 2383.5709572276983, 2443.645671377658, 2446.7308596054418, 2461.507698460306, 2469.8271121021535, 2415.1909110448023, 2417.504411595619, 2480.466699659573, 2492.0779311654715, 2492.1775813981435, 2435.305937807725, 2449.6815413996155, 2451.8774061296954, 2497.113524698742, 2517.446161844391, 2424.842385244971, 2432.2581612608146, 2448.3144719478573, 2455.6316552517087, 2459.4958033603248, 8529.57352132391, 8561.229489345926, 8569.0, 8589.828203435958, 8616.310695144373, 5180.844574662766, 5351.9296140772, 5355.919661205085, 5369.060414427459, 5386.569074474032, 3239.578854748891, 3275.197576593726, 3292.308615190813, 3308.4871844864083, 3330.350581636582, 990.4799980010553, 1006.4565134827185, 1021.1269364693229, 1024.155072065549, 1024.293237666008, 11711.063114950868, 11751.529938802438, 11809.645710628694, 11858.644240672707, 11875.762484750257, 4775.598786994008, 4789.784459699322, 4807.302941073594, 4833.73414462208, 4872.561469467694, 10070.899291007143, 10134.0, 10151.898481015243, 10158.339707918962, 10172.745681358025, 5367.302250707383, 5370.516653501204, 5392.460753924576, 5395.4604539545735, 5395.62230643859, 4361.062371590124, 4821.710697358169, 4886.682365646222, 4931.309616653672, 4957.90084198314, 4061.0794260077173, 4119.773412462283, 4152.356384760367, 4155.501339839238, 4180.143070670505, 1287.3241548187277, 1333.6732500537237, 1337.8996575256895, 1341.5908148014753, 1341.6981179234594, 1434.8780353670054, 1448.3989144504912, 1454.6436123149897, 1455.6797504548983, 1459.88320934325, 8238.382121340923, 8369.665213391396, 8399.748007559783, 8406.117357677356, 8424.452410593292, 1175.5709166154293, 1199.5501686867424, 1218.7867123253395, 1224.0758227538329, 1228.3919459867245, 6426.164598602245, 6458.54790164684, 6479.157709497735, 6517.989711594711, 6551.246606640298, 10281.588736450458, 10612.0, 10618.681439556825, 10677.412742299248, 10939.28894621847, 10530.73673158162, 10655.946720266349, 10662.520186591622, 10702.625408110678, 10803.351798892092, 8072.636731346986, 8139.75580732579, 8178.223068808454, 8222.218889205516, 8268.627911743986, 7574.5833979129475, 7643.503172294006, 7682.961585192038, 7749.65126569317, 7752.806179845549, 9185.954070229605, 9226.907730922605, 9405.717828465156, 9432.528373581155, 9669.226461882892, 9557.856632150384, 9563.713088607354, 9656.275779316438, 9669.033096690557, 9715.07706767856, 6556.311587283458, 6983.406410455168, 7147.53541019832, 7148.0, 7319.0, 8069.152738962559, 8082.0, 8091.55496447701, 8143.6742530298125, 8200.343972482067, 7207.675654595451, 7254.927450725425, 7289.088863892013, 7317.414606831334, 7398.778036658909, 7064.187618423742, 7112.715491380287, 7134.072570565793, 7271.0, 7403.851922961619, 7757.26306000929, 7792.0, 7853.1361550228285, 7859.056913170456, 7861.8034549134445, 7157.964210178916, 7159.677814498465, 7176.0, 7195.956586294853, 7214.170370407471, 7124.964375178091, 7151.249118842655, 7176.605286709281, 7179.389751871149, 7194.784156475314], "unit": "score", "name": "mootools.html", "value": 4951.128925174649}, {"lowerIsBetter": false, "replicates": [336.74239207006644, 350.8561489789186, 353.2000019954803, 356.64691954964593, 363.3586719440187, 6402.5198110141755, 6452.483801295897, 6455.83860403489, 6457.225132984043, 6460.321666225049, 6313.337099604544, 6333.619982801024, 6335.11308416822, 6350.14273073135, 6378.266499352576, 4702.106599746055, 4825.782839772201, 4833.613310935134, 4834.540718631742, 4839.322494850715, 4836.081144582518, 4864.0, 4864.975675121619, 4877.853664390074, 4888.071266459379, 4793.089313030513, 4817.060673168733, 4818.831340903069, 4824.083424149418, 4829.806807727704, 4818.229083346648, 4827.734474603895, 4831.444383895861, 4836.830710925136, 4836.97581512092, 4211.936820947688, 4223.260929337384, 4225.936610950838, 4225.957740422587, 4248.426462427564, 5900.380460051676, 6064.818055458343, 6077.058056001327, 6079.848003799896, 6089.908651370233, 5600.383957764642, 5615.438456154393, 5617.578681598897, 5629.3526244482, 5633.549316054706, 6789.623631728905, 6794.830129246759, 6798.966005169992, 6807.115075040263, 6850.520463567552, 4498.6626003049905, 4509.86470405885, 4521.886952826173, 4535.183666939949, 4552.817887284537, 6999.895001574981, 7079.185893622248, 7082.043924070236, 7089.326513981215, 7098.148222213367, 4610.53894610543, 4613.492515823256, 4629.328747331685, 4711.552402521755, 4724.503927087675, 4691.366665500113, 4694.389729335165, 4699.083678682624, 4763.857084287477, 4786.540105267926, 5483.848391837679, 5513.558915286768, 5515.365732940683, 5516.558675305966, 5527.309086364205, 6739.427148692416, 6783.0, 6806.7957961261245, 6817.795466136024, 6821.488388370892, 1649.1918959709897, 1660.8339166083294, 1662.8919120257144, 1666.7249903765985, 1674.7739055227632, 1067.4662668665667, 1081.9296745711504, 1086.2396322574073, 1105.3754628634795, 1125.0212315285753, 6525.282218955911, 6557.868842623217, 6564.8030559082345, 6570.967145164339, 6599.934000660028, 7017.47368947331, 7023.192332881784, 7032.472564557678, 7042.401395881305, 7062.6821793019435, 6557.311482294386, 6568.376004279586, 6570.474362051024, 6570.507211959122, 6572.638504882182, 3774.0753515388906, 3799.905002374963, 3819.8472061117245, 3826.0626146594263, 3833.6358045985585, 7197.964010179916, 7339.266073392618, 7343.412526997934, 7365.852682946311, 7388.630568471555, 7163.3552980232025, 7281.1990681025045, 7309.744158954411, 7319.41444684424, 7335.193128755833, 7330.303621155982, 7336.7798966031105, 7343.37581305595, 7378.372838308804, 7412.592307423036, 6936.583804971718, 7069.540479868792, 7072.9646351767915, 7086.220515743161, 7094.645267736696, 6935.167779866449, 6939.236683964659, 6959.338862808025, 6960.825979350557, 6962.512624116466, 7273.127224733066, 7285.854282914206, 7291.562506249642, 7313.012743279589, 7326.084239470067, 4791.904161916812, 4795.688280261911, 4809.519048095162, 4833.492483289204, 4842.201036828884, 6868.381845633917, 6953.235144134243, 7027.367536921702, 7040.3663670269925, 7122.786316410516, 6873.793786186422, 6885.2770459101075, 6904.240533541206, 6905.102336696197, 6916.3429474199875, 6814.046033555405, 6858.5199036067, 6864.6910889011115, 6897.620630865351, 6897.7585784497305, 6707.1616047994, 6736.663166841737, 6760.256371799, 6763.425108865801, 6773.153355830521, 6764.28974957642, 6892.207396149306, 6951.374376306157, 6997.405220556309, 7000.264972177848, 6717.0, 6725.730970761115, 6736.4947628929, 6740.561863478858, 6776.220734615582], "unit": "score", "name": "prototype.html", "value": 5101.637023384691}, {"lowerIsBetter": false, "replicates": [816.6447595296046, 924.5793164110329, 926.4904302633549, 931.5063016601199, 941.0166376136937, 14924.701505969888, 14999.775003374945, 15086.094834309935, 15363.3086511107, 15411.383544658229, 14255.928720356409, 14318.355673994669, 14338.068025578355, 14438.0, 14502.202378869159, 894.6779159502606, 913.3880300198882, 918.2929144558685, 919.2691810011057, 924.2421214604027, 902.4449963272573, 913.2146354135439, 916.724982505249, 922.5018490015417, 925.4077390470104, 941.2422999485411, 945.6312038305067, 948.7628092976756, 955.7323949294208, 956.5026186383077, 937.0582564522646, 950.619752099159, 950.7242899559119, 952.0194199974038, 952.4428209497453, 696.1333140240382, 700.0199720391441, 701.1901254051579, 704.0600797934763, 707.3987110955698, 15296.235188240544, 15320.463783767515, 15395.538133856002, 15426.3829446822, 15469.381224750996, 13933.164010159422, 13968.0, 14021.298935053206, 14126.92936535321, 14161.29193540319, 11716.414179291087, 11803.881961180365, 11815.645530634094, 11873.406329683568, 12148.757024859453, 4011.97994010031, 4021.175658989929, 4040.9191816163807, 4097.364908439196, 4130.380442933554, 50005.749971250276, 50084.248736268986, 50525.0, 50739.74630126826, 50856.23715644305, 10893.83659245112, 11151.944240278746, 11170.0, 11194.328340299446, 11229.943850280859, 18891.14989825461, 18984.335548256022, 19316.806831931783, 19461.22155113808, 19548.51128721765, 8232.670693172326, 8265.710700125466, 8313.625886835107, 8317.0, 8336.749897503085, 4637.0, 4714.057188562301, 4863.319135321058, 4939.580135688507, 5009.7244651544515, 3389.7796643218603, 3402.6767457091537, 3405.335959487876, 3413.5562376891344, 3422.161570415264, 594.1177351632822, 625.4214851262564, 641.3682522715122, 643.6556442303345, 644.452215616722, 695.4575431163701, 702.6943279673359, 706.7137809187287, 711.1963481266137, 719.4818136522173, 8204.8359032819, 8511.65953361871, 8544.53005084714, 8549.487030778173, 8983.685571004984, 562.9043062679273, 588.552699948034, 661.5468404143178, 695.0, 706.9893951590731, 4185.874423767292, 4192.622663960258, 4270.807813648394, 4341.370501277297, 4415.690901636919, 59978.0, 60831.39168608257, 61399.69300153471, 61892.69053654703, 62076.68961655253, 52669.0, 53226.73386633042, 53360.0, 53520.73239633777, 53730.73134634302, 47247.29129063067, 47494.318323719155, 48234.0, 48995.51004489909, 50135.49864501381, 9293.210077143518, 9299.814003719752, 9356.672516461891, 9435.05649435051, 9684.128428441192, 34968.82515587406, 35651.10872228215, 36323.0, 36341.63658363382, 36673.26653466969, 42039.7898010508, 42395.7880210597, 45845.54154458546, 46537.53462465332, 47320.0, 11931.0, 11954.701132471759, 12022.939885300517, 12344.074194435274, 12650.620481385573, 12985.28580928058, 13029.934850325688, 13381.330933453482, 14408.783868241775, 14651.780223296446, 11792.882071179178, 11817.29096254193, 12359.69100772452, 12807.807882881578, 13233.735325293634, 12618.36908154607, 12641.936790316358, 12794.936025319814, 12849.550265740654, 12923.870761292266, 11327.603533876274, 12516.249025058525, 12544.310062946626, 12720.491180353052, 13121.868781312065, 10558.472076396303, 10559.841602376124, 10603.416812075102, 10778.137748979905, 10820.5130769114, 10683.091937185116, 10735.570577176826, 10777.784444311226, 10792.946035269773, 10926.071283940953], "unit": "score", "name": "yui.html", "value": 6895.487658537595}], "name": "dromaeo_css", "value": 7451.947263431916}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 111.0, 110.0, 121.0, 111.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [148.0, 128.0, 145.0, 164.0, 131.0, 148.0, 161.0, 126.0, 174.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 163.0, 161.0, 161.0, 164.0, 162.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 74.0, 165.0, 76.0, 73.0, 73.0, 73.0, 161.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.5}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 147.0, 94.0, 101.0, 93.0, 149.0, 92.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 120.0, 118.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 55.0, 56.0, 55.0, 54.0, 55.0, 59.0, 61.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 78.0, 89.0, 79.0, 82.0, 81.0, 80.0, 86.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [118.0, 110.0, 110.0, 118.0, 118.0, 121.0, 113.0, 111.0, 110.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.5}, {"lowerIsBetter": true, "replicates": [153.0, 151.0, 141.0, 135.0, 142.0, 142.0, 133.0, 134.0, 147.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 68.0, 65.0, 66.0, 64.0, 66.0, 68.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1504.6000000000001}]} 05:45:31 INFO - Return code: 0 05:45:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:45:31 ERROR - # TBPL SUCCESS # 05:45:31 INFO - Running post-action listener: _resource_record_post_action 05:45:31 INFO - Running post-run listener: _resource_record_post_run 05:45:32 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 397312; Write bytes: 499531776; Read time: 220; Write time: 382632 05:45:32 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 81920; Write bytes: 244387840; Read time: 112; Write time: 249560 05:45:32 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 315392; Write bytes: 248143872; Read time: 108; Write time: 128360 05:45:32 INFO - Running post-run listener: _upload_blobber_files 05:45:32 INFO - Blob upload gear active. 05:45:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:45:32 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:45:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:45:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:45:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:33 INFO - (blobuploader) - INFO - Done attempting. 05:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:45:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:34 INFO - (blobuploader) - INFO - Done attempting. 05:45:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:34 INFO - Return code: 0 05:45:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:45:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4714763f6fa44799d81f56c2c26d9a36733847f8c6e30ac6d0deb09cdd5a52e346c5e4de9bb4f251ca9b96d16efb0f2b392b90a60d6241b0fcb1e7b03e5890fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/492bb382aec1b8a3bae53c87b28034c3748545412f001ef095c92d804a0cf9d1f29256e1638b9803a0fd9358811b69b8cd64260da5ce74a0ae9d89328421d790"} 05:45:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:45:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:45:34 INFO - Contents: 05:45:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4714763f6fa44799d81f56c2c26d9a36733847f8c6e30ac6d0deb09cdd5a52e346c5e4de9bb4f251ca9b96d16efb0f2b392b90a60d6241b0fcb1e7b03e5890fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/492bb382aec1b8a3bae53c87b28034c3748545412f001ef095c92d804a0cf9d1f29256e1638b9803a0fd9358811b69b8cd64260da5ce74a0ae9d89328421d790"} 05:45:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:34 INFO - Copying logs to upload dir... 05:45:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:45:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.609478 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-01 05:45:34.861059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 05:45:34.865106) ========= 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4714763f6fa44799d81f56c2c26d9a36733847f8c6e30ac6d0deb09cdd5a52e346c5e4de9bb4f251ca9b96d16efb0f2b392b90a60d6241b0fcb1e7b03e5890fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/492bb382aec1b8a3bae53c87b28034c3748545412f001ef095c92d804a0cf9d1f29256e1638b9803a0fd9358811b69b8cd64260da5ce74a0ae9d89328421d790"} build_url:https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/ZIEwdX5EQbuTM6RBFncckg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4714763f6fa44799d81f56c2c26d9a36733847f8c6e30ac6d0deb09cdd5a52e346c5e4de9bb4f251ca9b96d16efb0f2b392b90a60d6241b0fcb1e7b03e5890fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/492bb382aec1b8a3bae53c87b28034c3748545412f001ef095c92d804a0cf9d1f29256e1638b9803a0fd9358811b69b8cd64260da5ce74a0ae9d89328421d790"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 05:45:34.889971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:45:34.890327) ========= 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=7de08804244eb36560b44971000001c3-1459513502.603047-2088649721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 05:45:34.975487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 05:45:34.975812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 05:45:34.976104) ========= ========= Total master_lag: 0.23 =========