builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1456811958.75 results: success (0) buildid: 20160229193222 builduid: 06143fd3821141338b8aa3eca5ce8811 revision: 87ea50b0a2603d94b38276891684cba2b9e5df12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.746787) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.747243) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.747573) ========= 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.792135) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.792496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.822097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.822696) ========= 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.878650) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.878946) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.879340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.879705) ========= 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 21:59:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.7M=0s 2016-02-29 21:59:19 (84.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.994991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:18.995302) ========= 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022910 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.058738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.059106) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87ea50b0a2603d94b38276891684cba2b9e5df12 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87ea50b0a2603d94b38276891684cba2b9e5df12 --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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 21:59:19,734 truncating revision to first 12 chars 2016-02-29 21:59:19,734 Setting DEBUG logging. 2016-02-29 21:59:19,734 attempt 1/10 2016-02-29 21:59:19,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/87ea50b0a260?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 21:59:20,007 unpacking tar archive at: mozilla-inbound-87ea50b0a260/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.677342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.677708) ========= echo 87ea50b0a2603d94b38276891684cba2b9e5df12 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'87ea50b0a2603d94b38276891684cba2b9e5df12'] 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 87ea50b0a2603d94b38276891684cba2b9e5df12 program finished with exit code 0 elapsedTime=0.004650 script_repo_revision: '87ea50b0a2603d94b38276891684cba2b9e5df12' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.737985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.738296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 21:59:19.758737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-29 21:59:19.759132) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:20 INFO - MultiFileLogger online at 20160229 21:59:20 in /builds/slave/test-pgo 21:59:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:59:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:59:20 INFO - {'append_to_log': False, 21:59:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:59:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:59:20 INFO - 'branch': 'Mozilla-Inbound', 21:59:20 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:20 INFO - 'config_files': ('talos/linux_config.py',), 21:59:20 INFO - 'default_actions': ('clobber', 21:59:20 INFO - 'read-buildbot-config', 21:59:20 INFO - 'download-and-extract', 21:59:20 INFO - 'populate-webroot', 21:59:20 INFO - 'create-virtualenv', 21:59:20 INFO - 'install', 21:59:20 INFO - 'run-tests'), 21:59:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:20 INFO - 'download_minidump_stackwalk': True, 21:59:20 INFO - 'download_symbols': 'ondemand', 21:59:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:20 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:20 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:20 INFO - 'installer_path': 'installer.exe', 21:59:20 INFO - 'log_level': 'info', 21:59:20 INFO - 'log_name': 'talos', 21:59:20 INFO - 'log_to_console': True, 21:59:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:20 INFO - 'opt_config_files': (), 21:59:20 INFO - 'pip_index': False, 21:59:20 INFO - 'sps_profile': False, 21:59:20 INFO - 'sps_profile_interval': 0, 21:59:20 INFO - 'suite': 'dromaeojs', 21:59:20 INFO - 'system_bits': '32', 21:59:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:20 INFO - 'title': 'talos-linux64-ix-029', 21:59:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:20 INFO - 'use_talos_json': True, 21:59:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:59:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:20 INFO - 'work_dir': 'build'} 21:59:20 INFO - ##### 21:59:20 INFO - ##### Running clobber step. 21:59:20 INFO - ##### 21:59:20 INFO - Running pre-action listener: _resource_record_pre_action 21:59:20 INFO - Running main action method: clobber 21:59:20 INFO - rmtree: /builds/slave/test-pgo/build 21:59:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:59:20 INFO - Running post-action listener: _resource_record_post_action 21:59:20 INFO - ##### 21:59:20 INFO - ##### Running read-buildbot-config step. 21:59:20 INFO - ##### 21:59:20 INFO - Running pre-action listener: _resource_record_pre_action 21:59:20 INFO - Running main action method: read_buildbot_config 21:59:20 INFO - Using buildbot properties: 21:59:20 INFO - { 21:59:20 INFO - "project": "", 21:59:20 INFO - "product": "firefox", 21:59:20 INFO - "script_repo_revision": "production", 21:59:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:59:20 INFO - "repository": "", 21:59:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:59:20 INFO - "buildid": "20160229193222", 21:59:20 INFO - "pgo_build": "True", 21:59:20 INFO - "basedir": "/builds/slave/test-pgo", 21:59:20 INFO - "buildnumber": 1555, 21:59:20 INFO - "slavename": "talos-linux64-ix-029", 21:59:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:59:20 INFO - "platform": "ubuntu64_hw", 21:59:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:20 INFO - "branch": "mozilla-inbound", 21:59:20 INFO - "repo_path": "integration/mozilla-inbound", 21:59:20 INFO - "revision": "87ea50b0a2603d94b38276891684cba2b9e5df12", 21:59:20 INFO - "stage_platform": "linux64-pgo", 21:59:20 INFO - "builduid": "06143fd3821141338b8aa3eca5ce8811", 21:59:20 INFO - "slavebuilddir": "test" 21:59:20 INFO - } 21:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:59:20 INFO - Running post-action listener: _resource_record_post_action 21:59:20 INFO - ##### 21:59:20 INFO - ##### Running download-and-extract step. 21:59:20 INFO - ##### 21:59:20 INFO - Running pre-action listener: _resource_record_pre_action 21:59:20 INFO - Running main action method: download_and_extract 21:59:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:20 INFO - https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:59:27 INFO - Downloaded 1448 bytes. 21:59:27 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:27 INFO - Using the following test package requirements: 21:59:27 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:27 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:27 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:27 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'jsshell-linux-x86_64.zip'], 21:59:27 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:27 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:27 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:27 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:27 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:27 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:27 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59: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')]} 21:59:27 INFO - https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:35 INFO - Downloaded 23383750 bytes. 21:59:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:36 INFO - Return code: 0 21:59:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59:36 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')]} 21:59:36 INFO - https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:37 INFO - Downloaded 23383750 bytes. 21:59:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:38 INFO - Return code: 0 21:59: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')]} 21:59:38 INFO - https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:40 INFO - Downloaded 10713413 bytes. 21:59:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:40 INFO - Return code: 0 21:59:40 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')]} 21:59:40 INFO - https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:42 INFO - Downloaded 56642100 bytes. 21:59:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:42 INFO - mkdir: /builds/slave/test-pgo/properties 21:59:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:59:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:59:42 INFO - Contents: 21:59:42 INFO - build_url:https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:42 INFO - Running post-action listener: _resource_record_post_action 21:59:42 INFO - Running post-action listener: set_extra_try_arguments 21:59:42 INFO - ##### 21:59:42 INFO - ##### Running populate-webroot step. 21:59:42 INFO - ##### 21:59:42 INFO - Running pre-action listener: _resource_record_pre_action 21:59:42 INFO - Running main action method: populate_webroot 21:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:42 INFO - '--tppagecycles', 21:59:42 INFO - '7'], 21:59:42 INFO - 'tests': ['tsvgm']}}, 21:59:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:59:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:59:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'tests': ['damp', 'tps']}, 21:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['damp', 'tps']}, 21:59:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:42 INFO - 'other': {'tests': ['a11yr', 21:59:42 INFO - 'ts_paint', 21:59:42 INFO - 'tpaint', 21:59:42 INFO - 'sessionrestore', 21:59:42 INFO - 'sessionrestore_no_auto_restore']}, 21:59:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['a11yr', 21:59:42 INFO - 'ts_paint', 21:59:42 INFO - 'tpaint', 21:59:42 INFO - 'sessionrestore', 21:59:42 INFO - 'sessionrestore_no_auto_restore']}, 21:59:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['a11yr', 21:59:42 INFO - 'ts_paint', 21:59:42 INFO - 'tpaint', 21:59:42 INFO - 'sessionrestore', 21:59:42 INFO - 'sessionrestore_no_auto_restore']}, 21:59:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['a11yr', 21:59:42 INFO - 'ts_paint', 21:59:42 INFO - 'tpaint', 21:59:42 INFO - 'sessionrestore', 21:59:42 INFO - 'sessionrestore_no_auto_restore']}, 21:59:42 INFO - 'other_l64': {'tests': ['a11yr', 21:59:42 INFO - 'ts_paint', 21:59:42 INFO - 'tpaint', 21:59:42 INFO - 'sessionrestore', 21:59:42 INFO - 'sessionrestore_no_auto_restore']}, 21:59:42 INFO - 'other_nol64': {'tests': ['a11yr', 21:59:42 INFO - 'ts_paint', 21:59:42 INFO - 'tpaint', 21:59:42 INFO - 'sessionrestore', 21:59:42 INFO - 'sessionrestore_no_auto_restore']}, 21:59:42 INFO - 'svgr': {'tests': ['tsvgx', 21:59:42 INFO - 'tsvgr_opacity', 21:59:42 INFO - 'tart', 21:59:42 INFO - 'tscrollx', 21:59:42 INFO - 'cart']}, 21:59:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['tsvgx', 21:59:42 INFO - 'tsvgr_opacity', 21:59:42 INFO - 'tart', 21:59:42 INFO - 'tscrollx', 21:59:42 INFO - 'cart']}, 21:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'tests': ['tp5o']}, 21:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'talos_options': ['--e10s'], 21:59:42 INFO - 'tests': ['tp5o']}, 21:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'talos_options': ['--xperf_path', 21:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:42 INFO - 'tests': ['tp5n']}, 21:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:42 INFO - 'talos_options': ['--e10s', 21:59:42 INFO - '--xperf_path', 21:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:42 INFO - 'tests': ['tp5n']}}, 21:59:42 INFO - 'talos.zip': {'path': '', 21:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:42 INFO - Running post-action listener: _resource_record_post_action 21:59:42 INFO - ##### 21:59:42 INFO - ##### Running create-virtualenv step. 21:59:42 INFO - ##### 21:59:42 INFO - Running pre-action listener: _resource_record_pre_action 21:59:42 INFO - Running main action method: create_virtualenv 21:59:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:59:42 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 21:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:59:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:43 INFO - Using real prefix '/usr' 21:59:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:59:43 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:45 INFO - Installing pip.................done. 21:59:45 INFO - Return code: 0 21:59:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:45 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 21:59:45 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 21:59:45 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 21:59:45 INFO - Using env: {'DISPLAY': ':0', 21:59:45 INFO - 'HOME': '/home/cltbld', 21:59:45 INFO - 'LANG': 'en_US.UTF-8', 21:59:45 INFO - 'LANGUAGE': 'en_US:en', 21:59:45 INFO - 'LOGNAME': 'cltbld', 21:59:45 INFO - 'MAIL': '/var/mail/cltbld', 21:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:45 INFO - 'MOZ_NO_REMOTE': '1', 21:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:45 INFO - 'NO_EM_RESTART': '1', 21:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:45 INFO - 'SHELL': '/bin/bash', 21:59:45 INFO - 'SHLVL': '1', 21:59:45 INFO - 'TERM': 'linux', 21:59:45 INFO - 'TMOUT': '86400', 21:59:45 INFO - 'USER': 'cltbld', 21:59:45 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 21:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:45 INFO - '_': '/tools/buildbot/bin/python'} 21:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:45 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 21:59:45 INFO - Cleaning up... 21:59:45 INFO - Return code: 0 21:59:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:45 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 21:59:45 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 21:59:45 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 21:59:45 INFO - Using env: {'DISPLAY': ':0', 21:59:45 INFO - 'HOME': '/home/cltbld', 21:59:45 INFO - 'LANG': 'en_US.UTF-8', 21:59:45 INFO - 'LANGUAGE': 'en_US:en', 21:59:45 INFO - 'LOGNAME': 'cltbld', 21:59:45 INFO - 'MAIL': '/var/mail/cltbld', 21:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:45 INFO - 'MOZ_NO_REMOTE': '1', 21:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:45 INFO - 'NO_EM_RESTART': '1', 21:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:45 INFO - 'SHELL': '/bin/bash', 21:59:45 INFO - 'SHLVL': '1', 21:59:45 INFO - 'TERM': 'linux', 21:59:45 INFO - 'TMOUT': '86400', 21:59:45 INFO - 'USER': 'cltbld', 21:59:45 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 21:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:45 INFO - '_': '/tools/buildbot/bin/python'} 21:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:45 INFO - Downloading/unpacking psutil>=0.7.1 21:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:47 INFO - Installing collected packages: psutil 21:59:47 INFO - Running setup.py install for psutil 21:59:47 INFO - building 'psutil._psutil_linux' extension 21:59:47 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 21:59:48 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 21:59:48 INFO - building 'psutil._psutil_posix' extension 21:59:48 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 21:59:48 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 21:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:48 INFO - Successfully installed psutil 21:59:48 INFO - Cleaning up... 21:59:48 INFO - Return code: 0 21:59:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:59:48 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')]} 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:48 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')]} 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:48 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 21:59:48 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 21:59:48 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 21:59:48 INFO - Using env: {'DISPLAY': ':0', 21:59:48 INFO - 'HOME': '/home/cltbld', 21:59:48 INFO - 'LANG': 'en_US.UTF-8', 21:59:48 INFO - 'LANGUAGE': 'en_US:en', 21:59:48 INFO - 'LOGNAME': 'cltbld', 21:59:48 INFO - 'MAIL': '/var/mail/cltbld', 21:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:48 INFO - 'MOZ_NO_REMOTE': '1', 21:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:48 INFO - 'NO_EM_RESTART': '1', 21:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:48 INFO - 'SHELL': '/bin/bash', 21:59:48 INFO - 'SHLVL': '1', 21:59:48 INFO - 'TERM': 'linux', 21:59:48 INFO - 'TMOUT': '86400', 21:59:48 INFO - 'USER': 'cltbld', 21:59:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 21:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:48 INFO - '_': '/tools/buildbot/bin/python'} 21:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:48 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 21:59:48 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 21:59:48 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 21:59:48 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 21:59:48 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 21:59:48 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 21:59:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:50 INFO - Installing collected packages: mozsystemmonitor 21:59:50 INFO - Running setup.py install for mozsystemmonitor 21:59:50 INFO - Successfully installed mozsystemmonitor 21:59:50 INFO - Cleaning up... 21:59:50 INFO - Return code: 0 21:59:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:59:50 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')]} 21:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:50 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')]} 21:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:50 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 21:59:50 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 21:59:50 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 21:59:50 INFO - Using env: {'DISPLAY': ':0', 21:59:50 INFO - 'HOME': '/home/cltbld', 21:59:50 INFO - 'LANG': 'en_US.UTF-8', 21:59:50 INFO - 'LANGUAGE': 'en_US:en', 21:59:50 INFO - 'LOGNAME': 'cltbld', 21:59:50 INFO - 'MAIL': '/var/mail/cltbld', 21:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:50 INFO - 'MOZ_NO_REMOTE': '1', 21:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:50 INFO - 'NO_EM_RESTART': '1', 21:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:50 INFO - 'SHELL': '/bin/bash', 21:59:50 INFO - 'SHLVL': '1', 21:59:50 INFO - 'TERM': 'linux', 21:59:50 INFO - 'TMOUT': '86400', 21:59:50 INFO - 'USER': 'cltbld', 21:59:50 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 21:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:50 INFO - '_': '/tools/buildbot/bin/python'} 21:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:50 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 21:59:50 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 21:59:50 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 21:59:50 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 21:59:50 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 21:59:50 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 21:59:52 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:52 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 21:59:52 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 21:59:52 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 21:59:52 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 21:59:52 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 21:59:52 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 21:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:59:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - Downloading docopt-0.6.1.tar.gz 21:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:53 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:53 INFO - Running setup.py install for blobuploader 21:59:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:59:53 INFO - Running setup.py install for requests 21:59:53 INFO - Running setup.py install for docopt 21:59:54 INFO - Successfully installed blobuploader requests docopt 21:59:54 INFO - Cleaning up... 21:59:54 INFO - Return code: 0 21:59:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:54 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 21:59:54 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 21:59:54 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 21:59:54 INFO - Using env: {'DISPLAY': ':0', 21:59:54 INFO - 'HOME': '/home/cltbld', 21:59:54 INFO - 'LANG': 'en_US.UTF-8', 21:59:54 INFO - 'LANGUAGE': 'en_US:en', 21:59:54 INFO - 'LOGNAME': 'cltbld', 21:59:54 INFO - 'MAIL': '/var/mail/cltbld', 21:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:54 INFO - 'MOZ_NO_REMOTE': '1', 21:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:54 INFO - 'NO_EM_RESTART': '1', 21:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:54 INFO - 'SHELL': '/bin/bash', 21:59:54 INFO - 'SHLVL': '1', 21:59:54 INFO - 'TERM': 'linux', 21:59:54 INFO - 'TMOUT': '86400', 21:59:54 INFO - 'USER': 'cltbld', 21:59:54 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 21:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:54 INFO - '_': '/tools/buildbot/bin/python'} 21:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:54 INFO - Running setup.py (path:/tmp/pip-zgFXc5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:54 INFO - Running setup.py (path:/tmp/pip-Dd9UH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:54 INFO - Running setup.py (path:/tmp/pip-P2rl14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:54 INFO - Running setup.py (path:/tmp/pip-umEFBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:54 INFO - Running setup.py (path:/tmp/pip-zcQ_jA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:54 INFO - Running setup.py (path:/tmp/pip-cLLD0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:54 INFO - Running setup.py (path:/tmp/pip-7Il9eB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:54 INFO - Running setup.py (path:/tmp/pip-n0ZS_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:54 INFO - Running setup.py (path:/tmp/pip-VhNfdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:54 INFO - Running setup.py (path:/tmp/pip-bCbPEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:55 INFO - Running setup.py (path:/tmp/pip-OoYgTg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:55 INFO - Running setup.py (path:/tmp/pip-4vfo2p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:55 INFO - Running setup.py (path:/tmp/pip-evJKwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:55 INFO - Running setup.py (path:/tmp/pip-jmO1GI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:55 INFO - Running setup.py (path:/tmp/pip-onJPiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:55 INFO - Running setup.py (path:/tmp/pip-cKLqSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:55 INFO - Running setup.py (path:/tmp/pip-0HRsbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:55 INFO - Running setup.py install for manifestparser 21:59:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozcrash 21:59:55 INFO - Running setup.py install for mozdebug 21:59:55 INFO - Running setup.py install for mozdevice 21:59:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozfile 21:59:56 INFO - Running setup.py install for mozhttpd 21:59:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozinfo 21:59:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozInstall 21:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozleak 21:59:56 INFO - Running setup.py install for mozlog 21:59:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for moznetwork 21:59:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozprocess 21:59:56 INFO - Running setup.py install for mozprofile 21:59:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozrunner 21:59:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozscreenshot 21:59:57 INFO - Running setup.py install for moztest 21:59:57 INFO - Running setup.py install for mozversion 21:59:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:57 INFO - Cleaning up... 21:59:57 INFO - Return code: 0 21:59:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:57 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')]} 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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')]} 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 21:59:57 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 21:59:57 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 21:59:57 INFO - Using env: {'DISPLAY': ':0', 21:59:57 INFO - 'HOME': '/home/cltbld', 21:59:57 INFO - 'LANG': 'en_US.UTF-8', 21:59:57 INFO - 'LANGUAGE': 'en_US:en', 21:59:57 INFO - 'LOGNAME': 'cltbld', 21:59:57 INFO - 'MAIL': '/var/mail/cltbld', 21:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:57 INFO - 'MOZ_NO_REMOTE': '1', 21:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:57 INFO - 'NO_EM_RESTART': '1', 21:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:57 INFO - 'SHELL': '/bin/bash', 21:59:57 INFO - 'SHLVL': '1', 21:59:57 INFO - 'TERM': 'linux', 21:59:57 INFO - 'TMOUT': '86400', 21:59:57 INFO - 'USER': 'cltbld', 21:59:57 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 21:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:57 INFO - '_': '/tools/buildbot/bin/python'} 21:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:57 INFO - Running setup.py (path:/tmp/pip-S1AQPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:57 INFO - Running setup.py (path:/tmp/pip-JneBKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:57 INFO - Running setup.py (path:/tmp/pip-lsfby0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:57 INFO - Running setup.py (path:/tmp/pip-oNl6n8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:57 INFO - Running setup.py (path:/tmp/pip-tTPV0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:57 INFO - Running setup.py (path:/tmp/pip-UNULt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:57 INFO - Running setup.py (path:/tmp/pip-0YriL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:58 INFO - Running setup.py (path:/tmp/pip-74Hi_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:58 INFO - Running setup.py (path:/tmp/pip-heg7T8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:58 INFO - Running setup.py (path:/tmp/pip-jAoE26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:58 INFO - Running setup.py (path:/tmp/pip-UDnn54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:58 INFO - Running setup.py (path:/tmp/pip-GdzOBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:58 INFO - Running setup.py (path:/tmp/pip-qO5cxr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:58 INFO - Running setup.py (path:/tmp/pip-h3m7GF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:58 INFO - Running setup.py (path:/tmp/pip-_Nh2MH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:58 INFO - Running setup.py (path:/tmp/pip-XXLirl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:58 INFO - Running setup.py (path:/tmp/pip-nR_PME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:58 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)) 21:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:58 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)) 21:59:58 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)) 21:59:58 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)) 21:59:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - Downloading blessings-1.6.tar.gz 22:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:00 INFO - Installing collected packages: blessings 22:00:00 INFO - Running setup.py install for blessings 22:00:00 INFO - Successfully installed blessings 22:00:00 INFO - Cleaning up... 22:00:00 INFO - Return code: 0 22:00:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:01 INFO - Reading from file tmpfile_stdout 22:00:01 INFO - Current package versions: 22:00:01 INFO - argparse == 1.2.1 22:00:01 INFO - blessings == 1.6 22:00:01 INFO - blobuploader == 1.2.4 22:00:01 INFO - docopt == 0.6.1 22:00:01 INFO - manifestparser == 1.1 22:00:01 INFO - mozInstall == 1.12 22:00:01 INFO - mozcrash == 0.16 22:00:01 INFO - mozdebug == 0.1 22:00:01 INFO - mozdevice == 0.48 22:00:01 INFO - mozfile == 1.2 22:00:01 INFO - mozhttpd == 0.7 22:00:01 INFO - mozinfo == 0.9 22:00:01 INFO - mozleak == 0.1 22:00:01 INFO - mozlog == 3.1 22:00:01 INFO - moznetwork == 0.27 22:00:01 INFO - mozprocess == 0.22 22:00:01 INFO - mozprofile == 0.28 22:00:01 INFO - mozrunner == 6.11 22:00:01 INFO - mozscreenshot == 0.1 22:00:01 INFO - mozsystemmonitor == 0.0 22:00:01 INFO - moztest == 0.7 22:00:01 INFO - mozversion == 1.4 22:00:01 INFO - psutil == 3.1.1 22:00:01 INFO - requests == 1.2.3 22:00:01 INFO - wsgiref == 0.1.2 22:00:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 22:00:01 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 22:00:01 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 22:00:01 INFO - Using env: {'DISPLAY': ':0', 22:00:01 INFO - 'HOME': '/home/cltbld', 22:00:01 INFO - 'LANG': 'en_US.UTF-8', 22:00:01 INFO - 'LANGUAGE': 'en_US:en', 22:00:01 INFO - 'LOGNAME': 'cltbld', 22:00:01 INFO - 'MAIL': '/var/mail/cltbld', 22:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:01 INFO - 'MOZ_NO_REMOTE': '1', 22:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:01 INFO - 'NO_EM_RESTART': '1', 22:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:01 INFO - 'SHELL': '/bin/bash', 22:00:01 INFO - 'SHLVL': '1', 22:00:01 INFO - 'TERM': 'linux', 22:00:01 INFO - 'TMOUT': '86400', 22:00:01 INFO - 'USER': 'cltbld', 22:00:01 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 22:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:01 INFO - '_': '/tools/buildbot/bin/python'} 22:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 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)) 22:00:01 INFO - Cleaning up... 22:00:01 INFO - Return code: 0 22:00:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 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 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 22:00:01 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 22:00:01 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 22:00:01 INFO - Using env: {'DISPLAY': ':0', 22:00:01 INFO - 'HOME': '/home/cltbld', 22:00:01 INFO - 'LANG': 'en_US.UTF-8', 22:00:01 INFO - 'LANGUAGE': 'en_US:en', 22:00:01 INFO - 'LOGNAME': 'cltbld', 22:00:01 INFO - 'MAIL': '/var/mail/cltbld', 22:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:01 INFO - 'MOZ_NO_REMOTE': '1', 22:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:01 INFO - 'NO_EM_RESTART': '1', 22:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:01 INFO - 'SHELL': '/bin/bash', 22:00:01 INFO - 'SHLVL': '1', 22:00:01 INFO - 'TERM': 'linux', 22:00:01 INFO - 'TMOUT': '86400', 22:00:01 INFO - 'USER': 'cltbld', 22:00:01 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 22:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:01 INFO - '_': '/tools/buildbot/bin/python'} 22:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:01 INFO - Downloading/unpacking jsonschema 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:03 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:03 INFO - warning: no files found matching '*.txt' 22:00:03 INFO - no previously-included directories found matching 'build' 22:00:03 INFO - no previously-included directories found matching 'dist' 22:00:03 INFO - no previously-included directories found matching '.git*' 22:00:03 INFO - Installing collected packages: jsonschema, functools32 22:00:03 INFO - Running setup.py install for functools32 22:00:03 INFO - warning: no files found matching '*.txt' 22:00:03 INFO - no previously-included directories found matching 'build' 22:00:03 INFO - no previously-included directories found matching 'dist' 22:00:03 INFO - no previously-included directories found matching '.git*' 22:00:03 INFO - Successfully installed jsonschema functools32 22:00:03 INFO - Cleaning up... 22:00:03 INFO - Return code: 0 22:00:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87ad434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, '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': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', '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 22:00:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:00:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:00:03 INFO - Using env: {'DISPLAY': ':0', 22:00:03 INFO - 'HOME': '/home/cltbld', 22:00:03 INFO - 'LANG': 'en_US.UTF-8', 22:00:03 INFO - 'LANGUAGE': 'en_US:en', 22:00:03 INFO - 'LOGNAME': 'cltbld', 22:00:03 INFO - 'MAIL': '/var/mail/cltbld', 22:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:03 INFO - 'MOZ_NO_REMOTE': '1', 22:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:03 INFO - 'NO_EM_RESTART': '1', 22:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:03 INFO - 'SHELL': '/bin/bash', 22:00:03 INFO - 'SHLVL': '1', 22:00:03 INFO - 'TERM': 'linux', 22:00:03 INFO - 'TMOUT': '86400', 22:00:03 INFO - 'USER': 'cltbld', 22:00:03 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 22:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:03 INFO - '_': '/tools/buildbot/bin/python'} 22:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:03 INFO - Downloading/unpacking flake8 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:06 INFO - no previously-included directories found matching 'docs/_build' 22:00:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:06 INFO - Running setup.py install for pep8 22:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:06 INFO - no previously-included directories found matching 'docs/_build' 22:00:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:00:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:06 INFO - Cleaning up... 22:00:06 INFO - Return code: 0 22:00:06 INFO - Running post-action listener: _resource_record_post_action 22:00:06 INFO - Running post-action listener: _start_resource_monitoring 22:00:06 INFO - Starting resource monitoring. 22:00:06 INFO - ##### 22:00:06 INFO - ##### Running install step. 22:00:06 INFO - ##### 22:00:06 INFO - Running pre-action listener: _resource_record_pre_action 22:00:06 INFO - Running main action method: install 22:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:06 INFO - Reading from file tmpfile_stdout 22:00:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:07 INFO - Reading from file tmpfile_stdout 22:00:07 INFO - Output received: 22:00:07 INFO - Usage: mozinstall [options] installer 22:00:07 INFO - Options: 22:00:07 INFO - -h, --help show this help message and exit 22:00:07 INFO - -d DEST, --destination=DEST 22:00:07 INFO - Directory to install application into. [default: 22:00:07 INFO - "/builds/slave/test-pgo"] 22:00:07 INFO - --app=APP Application being installed. [default: firefox] 22:00:07 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:00:23 INFO - Reading from file tmpfile_stdout 22:00:23 INFO - Output received: 22:00:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:00:23 INFO - Running post-action listener: _resource_record_post_action 22:00:23 INFO - ##### 22:00:23 INFO - ##### Running run-tests step. 22:00:23 INFO - ##### 22:00:23 INFO - Running pre-action listener: _resource_record_pre_action 22:00:23 INFO - Running main action method: run_tests 22:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:00:23 INFO - Python 2.7.3 22:00:23 INFO - Return code: 0 22:00:23 INFO - grabbing minidump binary from tooltool 22:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:23 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 0xedc8c0>, '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 0xedd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:00:23 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 22:00:23 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 22:00:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:23 INFO - Return code: 0 22:00:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:00:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:00:24 INFO - Return code: 0 22:00:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:00:24 INFO - Using env: {'DISPLAY': ':0', 22:00:24 INFO - 'HOME': '/home/cltbld', 22:00:24 INFO - 'LANG': 'en_US.UTF-8', 22:00:24 INFO - 'LANGUAGE': 'en_US:en', 22:00:24 INFO - 'LOGNAME': 'cltbld', 22:00:24 INFO - 'MAIL': '/var/mail/cltbld', 22:00:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:24 INFO - 'MOZ_NO_REMOTE': '1', 22:00:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:24 INFO - 'NO_EM_RESTART': '1', 22:00:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:00:24 INFO - 'SHELL': '/bin/bash', 22:00:24 INFO - 'SHLVL': '1', 22:00:24 INFO - 'TERM': 'linux', 22:00:24 INFO - 'TMOUT': '86400', 22:00:24 INFO - 'USER': 'cltbld', 22:00:24 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910', 22:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:24 INFO - '_': '/tools/buildbot/bin/python'} 22:00:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:00:24 INFO - mozversion application_buildid: 20160229193222 22:00:24 INFO - mozversion application_changeset: 87ea50b0a2603d94b38276891684cba2b9e5df12 22:00:24 INFO - mozversion application_display_name: Nightly 22:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:24 INFO - mozversion application_name: Firefox 22:00:24 INFO - mozversion application_remotingname: firefox 22:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:24 INFO - mozversion application_vendor: Mozilla 22:00:24 INFO - mozversion application_version: 47.0a1 22:00:24 INFO - mozversion platform_buildid: 20160229193222 22:00:24 INFO - mozversion platform_changeset: 87ea50b0a2603d94b38276891684cba2b9e5df12 22:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:24 INFO - mozversion platform_version: 47.0a1 22:00:24 INFO - using testdate: 1456812024 22:00:24 INFO - actual date: 1456812024 22:00:24 INFO - starting webserver on 'localhost:51075' 22:00:24 INFO - SUITE-START | Running 2 tests 22:00:24 INFO - TEST-START | dromaeo_css 22:00:24 INFO - operating with platform_type : linux_ 22:00:24 INFO - Initialising browser for dromaeo_css test... 22:00:24 INFO - TEST-INFO | started process 18472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeuKGhz/profile http://localhost:51075/getInfo.html) 22:00:28 INFO - PROCESS | 18472 | __metrics Screen width/height:1600/1200 22:00:28 INFO - PROCESS | 18472 | colorDepth:24 22:00:28 INFO - PROCESS | 18472 | Browser inner width/height: 1024/697 22:00:28 INFO - PROCESS | 18472 | __metrics 22:00:29 INFO - PROCESS | 18472 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:29 INFO - PROCESS | 18472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:00:29 INFO - PROCESS | 18472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:00:29 INFO - PROCESS | 18472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:00:29 INFO - PROCESS | 18472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:00:29 INFO - PROCESS | 18472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:00:29 INFO - PROCESS | 18472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:00:29 INFO - PROCESS | 18472 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:00:30 INFO - TEST-INFO | 18472: exit 0 22:00:30 INFO - Browser initialized. 22:00:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:30 INFO - TEST-INFO | started process 18568 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeuKGhz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:41 INFO - PROCESS | 18568 | RSS: Main: 153075712 22:00:41 INFO - PROCESS | 18568 | 22:01:33 INFO - PROCESS | 18568 | 1456812093500 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] 22:03:41 INFO - PROCESS | 18568 | Cycle 1(1): loaded http://localhost:51075/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51075/tests/dromaeo/cssquery-ext.html) 22:03:42 INFO - PROCESS | 18568 | RSS: Main: 244731904 22:03:42 INFO - PROCESS | 18568 | 22:06:44 INFO - PROCESS | 18568 | Cycle 1(1): loaded http://localhost:51075/tests/dromaeo/cssquery-ext.html (next: http://localhost:51075/tests/dromaeo/cssquery-jquery.html) 22:06:45 INFO - PROCESS | 18568 | RSS: Main: 233136128 22:06:45 INFO - PROCESS | 18568 | 22:09:47 INFO - PROCESS | 18568 | Cycle 1(1): loaded http://localhost:51075/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51075/tests/dromaeo/cssquery-mootools.html) 22:09:48 INFO - PROCESS | 18568 | RSS: Main: 245616640 22:09:48 INFO - PROCESS | 18568 | 22:12:49 INFO - PROCESS | 18568 | Cycle 1(1): loaded http://localhost:51075/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51075/tests/dromaeo/cssquery-prototype.html) 22:12:50 INFO - PROCESS | 18568 | RSS: Main: 215982080 22:12:50 INFO - PROCESS | 18568 | 22:15:53 INFO - PROCESS | 18568 | Cycle 1(1): loaded http://localhost:51075/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51075/tests/dromaeo/cssquery-yui.html) 22:15:53 INFO - PROCESS | 18568 | RSS: Main: 215998464 22:15:53 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | Cycle 1(1): loaded http://localhost:51075/tests/dromaeo/cssquery-yui.html (next: http://localhost:51075/tests/dromaeo/cssquery-dojo.html) 22:18:56 INFO - PROCESS | 18568 | RSS: Main: 306925568 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | __start_tp_report 22:18:56 INFO - PROCESS | 18568 | _x_x_mozilla_page_load 22:18:56 INFO - PROCESS | 18568 | _x_x_mozilla_page_load_details 22:18:56 INFO - PROCESS | 18568 | |i|pagename|runs| 22:18:56 INFO - PROCESS | 18568 | |0;dojo.html;3113.657497675256;3142.8742850286003;3164.6835316468355;3176.618805743311;3191.3457741163065;5102.1836506159025;5118.053160165367;5132.101882170619;5165.147750621143;5203.765830537625;5140.511651393112;5167.689938603687;5212.061828870802;5241.42344342122;5261.421243663194;4677.2750223715375;4688.718676879381;4719.858404247861;4771.5467030632035;4859.319695242669;4792.736399498026;4803.063402636487;4833.903321933559;4846.466888642247;4854.611631069523;4674.158651442739;4701.083288758693;4771.260454629521;4771.952280477186;4792.808287668489;4695.9668872847915;4713.599344055725;4716.221823399135;4717.056588682277;4745.288206768978;4652.046330502239;4668.299755036738;4674.252119660872;4678.976605116953;4687.320338550925;4980.427250866161;5002.324686167393;5031;5051.924221136685;5065.189569668835;5502.119660854244;5504.119340905436;5513.807016754395;5514.641548299388;5522.723863806794;5515.365732940683;5571.916421253684;5577.609567330289;5579.163125531203;5583.664980101207;5123.180291153435;5238.05714971305;5272.841814745564;5311.73441327936;5322.148456246982;5556.083246264402;5556.944430555643;5558.972205138948;5563.165525171256;5614.1859430382365;5344.518993290545;5373.7581808818695;5378.2470454136455;5379.838604841861;5391.487808658171;5474.206240095164;5478.863028424321;5502;5538.446155384429;5538.86152846174;5447.319085114361;5452.727363631802;5453.209284653703;5453.23654688344;5455.263539422207;5356.491133342326;5433.157860531624;5440.455954404607;5473.698946557977;5493.23094766733;4219.725717828332;4246;4273.594008569181;4284.378765079046;4284.378765079108;3800.25894950482;3812.6759225466144;3820.8471661133244;3843.557990831034;3849.0569810396073;5053.343065401475;5091.439941606421;5095.592352611782;5131.666441681279;5159.948400515947;5470.234167216593;5492.340919089735;5525.861853453615;5525.917111243334;5541.861453463695;5127.512886275797;5135.435102138762;5139.665921715076;5154.226865970059;5185.818496352609;4641.582257596832;4689.085628302449;4702.717836929795;4733.313669517901;4797.520247975174;5679.858003549862;5705.258316418839;5705.71471426427;5708.343540492813;5749.367569567345;5485.040117979417;5491.258680078298;5493.423190565093;5496.4503549646315;5510.118381059011;5693.259876216231;5700.173474846207;5739.253896993364;5798.391168927202;5810.477057064884;5439.537639300704;5444.3194600674915;5445.319335083114;5445.972770136124;5453.2365468833605;5503.284573005483;5509.3664228614225;5517.834464966058;5520.199571062254;5572.219889215594;5325.547328477122;5424.1321388577635;5463.672179669074;5468.179773034077;5513.972430137824;5349.759260833194;5361.303030605996;5370.838874833761;5374.6506477078865;5383.703896285742;5159;5294.708791016531;5306.814261500829;5309.601779866603;5351.785928562814;5362.356517217959;5363.678179309254;5406.972965135306;5430.592705547021;5457.072297709319;5386.48828361305;5393;5400.513953744182;5400.810971616132;5401.972990135024 22:18:56 INFO - PROCESS | 18568 | |1;ext.html;524.9973750131248;540.8242321245594;549.4587830986475;555.6499405374616;585.5432762445291;34708.479372809394;35206.119847003836;35267.823660881695;35309.11727206821;35316.823415882915;35851;36468.270634587294;36500.45249321256;36535.26929461409;36552.81723591385;7482.438817088713;7577.090749110114;8175.795605109875;9853.852192217122;10029.448380339078;9893.950530247339;10034.69895903124;10035.69892903214;10038.698839034842;10040.799184016316;7551.622418879061;10005.949970250138;10109.342892711988;10111.494425278706;10112.94943525285;10270.33242839213;10533.73665658361;10534.209934254885;10540.051395374454;10544.209184311207;9743.951280243624;10000.649977250834;10004.049615286536;10004.399736015863;10007.099361057468;35842.82078589616;35940;36114.81942590296;36121.63878361209;36152.81923590392;3196.105090574643;3325.1354647791504;3367.8821241256683;3543.167355671415;3730.8880733578035;29032.8548357259;29321.560176597155;29357;29814.701852981627;30467.69532304693;3929.5873933236885;3974.880753577397;4016.819243134066;4050.655694265991;4136.110736191733;273976;274049;274366;275750;275781;55210;56338.43661563414;56342.436575634536;56467.15299270432;56474;60064.69967650134;63736;65164.34835651678;65278;65285.67357163279;15182.240887955559;15306.540803775904;15318.387264509518;15352.616184595474;15374.615634609001;12096.697582560506;12185.817212741817;12221.938890305491;12241.755164896653;12251.938740306241;19656.90171549133;19685.901570492057;20657.17371305131;20671.79587163992;20708;6557.278699343068;7845.136525168273;7851.136374998746;7862.764117076496;7977.122516523178;911.5806728904646;922.5110691333604;962.2542529539522;1049.7270709615555;1059.750958524746;25557.48885022289;25914.352141196243;26063.08779192719;26082.217533474028;26166.6075008875;989.8762654668167;997.5211898288862;1025.195221750922;1089.493385575711;1152.004787552374;14194.290285485684;14576.936327007585;14647.680403416674;14819.851801482062;14862.479813206486;302250;305672;306032;308249;308734;51069.48930510647;51381.48618513842;51705.7414712924;51826.740866295426;51892.22161667578;1165.4871856383165;1254;1321.623337348851;1341.0478560222157;1350.0751984890383;25953.74046259513;27855.108668498626;28166;28441.146765597066;28667.28331791722;44739.55260447354;45133.548664512935;45327.320090198016;45408.54591454043;45516.54483455256;262612;267888;269117;269483;270490;29198.124056278346;29392.26519337034;30957.8452107738;31452.528212077294;31594;38494.615053849106;38580.228395431375;38962.220755585295;39109.2178156441;39734.60265397309;32845;32917.835410822794;33230.33539329248;33455.33089338248;33546.66453335436;34536;34767.4784878222;35312.47031294481;35362.64637353696;35760.28479430345;35963;36120;36365.27269454649;36714.26571468609;37465;28305.57541636918;29554.704452955197;29809.552856706734;30273.394532109676;30336.089917302517;24457.633135503336;24838;24866.50266994686;24999.250022499353;25016.874915626035 22:18:56 INFO - PROCESS | 18568 | |2;jquery.html;337.85472246933807;352.1442893768143;357.23729836798447;360.43411843405846;364.79753736676133;13911.582652520441;16864.91567542162;16910.74633880491;17141.74287385687;17687.55781105473;16035.438759643415;16248.75626865598;16411.753823692623;16477.423290184845;16497;5151.0728068947665;5385.973070134643;5406.756695948692;5417;5430.67415955042;4885.9511404886025;5380.789322402447;5411.242426060355;5421.105517589613;5424.810131645393;5365.624406291561;5368.3021207243;5374.758135883875;5376.327959005124;5376.892462150755;4872.853814385574;5055.747212639353;5057.4689657585795;5057.4689657585795;5352.357717073937;4838.032393521275;4847.466778654345;4852.2721591761165;4869.9269510957365;4913.803447862081;12221.633350999484;12375.876241237653;12577.937110314482;12579;12587.622371328875;2140.8501404901663;2259.423846919025;2375.9524809503714;2497.5379554782244;2927.5315949447986;8888.644454221823;9157.267418606496;9158.450492970444;9448.90551094494;9488.28837837165;1737.1227530097347;1894.6779047561947;1947.1821834829407;2003.1086166655843;2037.8777273363646;63930.04104938383;64376.034359485115;65854;65994.67002665004;66118.66940665265;9709.514524273758;9760.170385517311;9822.26333025026;9885.022995400948;9887.406755594688;12377.504899804087;12639.43122559487;12655.43050562727;12658.050646201387;13324.733505330032;7679.846403071907;7694.730684426018;7914.643841027052;7953.562554059582;8037.919620803834;7700;7729.149793522708;7791.532508049422;7809.0629124504285;7826.2173782621285;4320.978395108004;4346.6088052075465;4506.887327816831;4513.977430112828;4566.589006989387;1780.7328900665004;1815.2285278756476;1820.4356649438453;1829.652366050446;1850.898200598953;874.9431286966327;903.1690844423147;926.129438327983;943.8112377524523;978.320067553058;15798.21008949548;16483.258253378626;16672.333106675596;17013.829861701473;17061.914690426467;891.064382398479;920.5305294299956;925.8981512033671;931.2736065868634;969.5685419988179;6888.862222755617;9421.90578094224;9609.135177834029;9680.903190968142;9838.60645574169;404235;419060;419832;420067;420153;72626;72643.63678181576;73726;74193.62903185449;74887.25112748802;1003.4932359158724;1008.7982403519326;1012.9189664826944;1024.3137098144111;1028.9382637041801;14087.366068527146;15156.393744250106;15434;15732.68534629324;15860.76208856845;32788;34394.82802586071;34741.47887781635;35476.113097172776;35602.287954241285;43370.349444757725;44618.77690611656;45046.324305134796;45486.317705233785;45769.54230457786;7569.3566046886635;7777;7867.449278550446;7873.566953817366;7920.722774702857;8807.691730789391;11861.288322700666;11974.161808673309;12113.576024839089;12672;10445.268831181744;10677.46612669379;10833.945830270799;10929.836052459379;11203.88796112061;10256.38461692301;10794.31355005474;11219.214654974074;11228.606998755004;11552.191346605658;10539;11023.83464248021;11085.113190944867;11357.37534435614;11635.185537012328;7775.144734079134;8030.919690803017;8115.594220288844;8115.715949941724;8210.425270231266;10621.628243011457;11056.889431105586;11071.612493562687;11108.222424430212;11119.83320250213 22:18:56 INFO - PROCESS | 18568 | |3;mootools.html;1375.9105658132228;1456.4392708807109;1463.7511623024084;1638.967220655587;1789.6420715856823;7579.621018949051;7740.225977402271;7753.9919810424635;7776.96111519443;7795.649195786189;7536.35940945019;7707.537547747125;7720.806979825507;7726.072871255457;7732.574708391036;1973.2501649373219;2179.40066481718;2234.899429525667;2238.0935721033006;2266.5353602511445;2210.613142700021;2220.4892874638845;2222.977770222293;2223.132978138527;2223.266322113707;2163.9026243819067;2208.7680793516693;2211.524522227721;2211.9557608847813;2214.025828635395;2183.3449965010514;2187.4750059985568;2187.9453013674624;2235.8434909556336;2239.1603148819195;2172.1420039084474;2191.386411804697;2197.3298144066052;2198.230619283254;2242.843000989931;7884.250996155356;7919.683212671486;7926.365890728785;7928.682852685885;7940.761777146637;4617.468991066037;4669.976650116761;4681.250999840009;4697.647676424248;4706.176419126673;3014.427258820839;3038.635363756341;3107.1300035989957;3119.266972261517;3172.9682703172903;938.2822141062093;943.6980166346772;954.1031430455349;963.9614415423445;981.788915383196;10665.573377064908;10717.410542420243;10723.249372543925;10725.624603138853;10753.354798712102;3938.6455219030427;4079.571644977294;4085.754854708727;4160.875173744793;4165.208610364021;8531.402801803813;8721.781955451164;8783.648654053766;8832.337574681924;8834;4121.216968775923;4719.079779442975;4728.929066064012;4754.881127971759;4762.78567464465;4235.534091250021;4272.230998420314;4273.18809426208;4301.419308393327;4327.8485253016;3411.0619579615804;3465.4801779733243;3491.650834916488;3510.368133735952;3528.4883691864534;957.4207604399378;974.9122578967927;978.8727465429448;983.7343917142474;1000.6247657128577;1255.121415009497;1267.9809802852965;1291.5479582146174;1319.0964189530202;1342.4093398904452;7515.511491753018;7616.961915190499;7672;7683.577403242875;7691.5769632670745;450.86474057782533;456.24035980093436;459.3224993135099;468.1526437148772;469.31011413222507;5879.441453061952;5908.350081491032;5919.852003699856;5922.407759224129;5955.047192449188;8962.820743585222;9172.44965302084;9182.908170918205;9190.862137067948;9240.537973101318;9075.273978081737;9138.497382643885;9187.862182067274;9188.173064424234;9197.908020919838;7198.640067996579;7300.269973002763;7331;7357.52176108562;7437.925620743831;7308.196098429062;7326.194118647051;7336.926630733625;7341.045664063638;7356.77929662111;8463.28062114727;8465.83068338642;8745.125487451203;8752.34357423183;8776.254018408506;8612.48325100496;8877.33419993516;8926.553672316228;8945.59744811498;9010.189082982562;6165.753369865155;6309.936900630935;6317.7157027932935;6956.582605043714;7072.151341839012;7303.890441643273;7420.146683131509;7428.6285685716575;7429.257074292744;7453.366463850633;6557.475401967927;6690.397864192246;6757.425618822455;6782.898256526255;6879.1744990599445;6577.80266592003;6587.077809106825;6588.802335929738;6622.801315960529;6685.364890335411;6929.965350173217;6972.79081627552;6975.407090397373;7058.858822823412;7176.138863336433;6398.712057957497;6444.613323200623;6447.258565265054;6461.8061458156335;6464.903026454701;6519.185101862267;6573.80278591643;6602.702878370389;6609.239937407259;6611.041398997215 22:18:56 INFO - PROCESS | 18568 | |4;prototype.html;305.49135689077684;317.9777415580909;318.7545589895782;324.1248628702503;329.44817430803397;5765.567582431314;5900.468957793798;5964.821055368335;5968.373320801318;6035;5799.623024503404;5881.323647780507;5905.084711869667;5913.85215369616;5916.940830591693;4312.202242585116;4382.145481631083;4499.077689073749;4500.729956202622;4506.864794056183;4530.773461326937;4536.500984891659;4537.137943790685;4538.591526762591;4553.726776393427;4449.911001779962;4490.483594386638;4491.842785502508;4492.730436173823;4502.842400515966;4220.134872351161;4276.144771045803;4277.337012763027;4376.168527979674;4491.191585514606;3874.2057878134915;3887.961120388788;3890.1247219375414;3893.1824316893203;3902.8829135125993;5594.916076258859;5609.831705048814;5610.158476228598;5614.3543492498475;5618.297712785902;5160;5165.9225111623355;5167.224916262553;5174.689518628894;5175.663581867204;6191.380861913818;6202.255729312466;6202.4417802398;6203.844903877394;6205.441510264098;4177.4778152730905;4256.553061928484;4286.314189729659;4297.871063868089;4297.97851010746;6425.325340839191;6447.484201263935;6484.870302593922;6488.156539649863;6502.5448218624715;4318.935215971763;4325.394444777734;4331.263685173465;4333.804978775963;4339.132173565299;4370.737755734666;4379.671524635665;4386.298192289219;4387.473503179575;4388.319810429389;5117.053345131163;5118.667286626357;5125.8718532037;5128.410232823198;5128.692278463304;6237.064440333896;6251.343608921089;6252.437280644673;6260.7495700171485;6263.530235232376;1478.9556313310618;1540.3222582063856;1549.9767503487458;1562.5312406278072;1562.7733978573044;989.8960609136082;1000.2148313573955;1001.6293971230546;1009.4145395670494;1027.4605831938293;5775.942240577624;5829.038208695602;5841.9415805842245;5903.409659034062;5907.793227237026;6472.579282346633;6491.967540162364;6500.382463665944;6500.512461565401;6503.642299673469;5985.012472941916;5985.760569577168;5986;5988.850278743066;5992.850178745479;3453.32660131277;3492.4935884296633;3495.143689795965;3496.4755286707195;3499.177693242086;6601.174853143357;6742.426893713991;6783.491238157158;6786.1856577210065;6787.457003439713;6611.966940165268;6619.106420633153;6631.303713110054;6643.169603799525;6694.698738556776;6749.763758268437;6770.255271920085;6771.187457505131;6776.119104516282;6776.119104516381;6464.676766161767;6466.547341686037;6472.223333199858;6473.352664733489;6487.1566696331065;6256.874862502634;6412.487001039813;6419.261784894797;6420.454261387647;6422.389872962061;6767.89848152288;6791.252962174058;6803.625800581016;6804.4556435484055;6810.761623343159;4227.091175397304;4227.450431443893;4230.027093768389;4232.217039847638;4232.513260975027;6375.203099612549;6400.679966001774;6433.517486188648;6451.387118223761;6458.67706614658;6269.561130720988;6283.3402492737605;6283.403076707706;6286.842828929313;6292.244930608356;6081.847953801191;6282.560220784501;6330.240371155491;6336.904946425715;6342.175517182736;6167.5682702210415;6197.907031394442;6201.131841542097;6213.316535181036;6219.284782249918;6328.905066423915;6334.986402175814;6338.778142764981;6341.682915854281;6347;5960.0761881908375;6184.845378865564;6200.193974783249;6220.657863817352;6221.9377806223165 22:18:56 INFO - PROCESS | 18568 | |5;yui.html;597.0834768630151;612.9356417576155;652.6964961292999;698.3261152987372;764.9711138518692;12413.689657758561;12461.37693115344;12497.625071247854;12561.057920655941;12637.55768548101;12254.448549815257;12596;12664.303463309538;12744.808827867566;12770;688.5077169823575;817.6647574494458;825.4304529874397;842.810367667273;845.8984921809391;824.0729179672868;828.4283844147519;828.4615000249826;829.5022986208257;829.7925518620345;872.7032808844991;882.496976723268;883.1257055515026;883.218351758695;884.2660591708866;715.4097869257857;856.3149480415642;867.8524650809314;868.7958329792493;870.4646642314931;640.1837656987332;641.8010416770816;644.7131026693123;644.9645269510175;645.403002222942;12436.502539898393;12893.033022523254;12936.805947910789;12949.805752913713;12967.935160324232;13138.671533211746;13436.529721459701;13487.460501579924;13756.380962856696;13878.861211387857;9843.852342214872;9972.95013524935;10052.195824334036;10067.597296108146;10202.387856728546;4202.768847713374;4328.091100868822;4338.240807858644;4447.688661793643;4451.1765323415275;46067.308990364836;46155.53844461546;46227;46269.53730462686;46304.768476157406;9744.75638109053;9875.111239988435;9995.950020249998;10397.740056498496;10496.632617858491;17760;17779.288828446977;17843.73234401485;17860.821391786176;17866.01736904483;7462.365698915544;7851.332636725942;8187.79530511742;8202.26179643835;8267.793305167419;4353.782310884443;4495.842645507457;4495.88760280989;4588.977055114703;4611.077784443058;3107.2231942014496;3141.9214519637194;3146.889858854929;3146.9527957080663;3147.134538002022;497.1101727907078;540.2328693255587;558.7820749907539;580.3442110415203;585.4204337705726;613.7575657615217;682.2393031769641;687.6495563471339;692.2385376086365;699.9685014174374;8151.429399942066;8361.790955226168;8366.205210504992;8618.956905215433;8699.347548933856;531.388902761827;538.8275751759478;577.6678409914232;594.6818452128091;599.8980173370537;3850.6726928210855;3881.7670939743707;3951.249262640089;4091.6112969267874;4108.239975604522;55688.443115569135;56502.71748641231;56571;56910.430895691345;57407.138892915806;48981.75509122432;49914;50570.49429505658;50851.237231441555;51159.23261151086;45226.77386613046;46327;46475.83810404699;46962.76518617385;47494.28758568555;7852.528848269122;7938.206179382016;8099.473534220257;8125.752361353113;8230.259276665129;33963.66036339605;34237.315253695284;34510.654893450745;34954.12614684653;36103.27793444169;40714;44152.55847441613;44504.77747611241;44682.3297650529;45462.318065228385;10951.123910087015;10964.28732132409;11062.557497700001;11303.996367392645;11403.144764142888;12452.875471245172;12514.374281285716;12617.68455788576;12681.492740290285;12723.681907952376;11743.94304512598;11808.822867657163;11995.1003674723;12284.754304914031;12301.75396492083;11139.498722557666;11247.493862776031;11284.492197851281;11565.074794016291;11819.82270265964;11076.169287303323;11512.136589755635;11631.302121872377;11852.288862668267;12030.63908082759;10209.74475638115;10266.538005789907;10370;10428.739281518023;10555.89444105549;8866.290696744116;9222.538873056454;9603.759906002126;9618.278629102706;9958.352707074017 22:18:56 INFO - PROCESS | 18568 | __end_tp_report 22:18:56 INFO - PROCESS | 18568 | __start_cc_report 22:18:56 INFO - PROCESS | 18568 | _x_x_mozilla_cycle_collect,888 22:18:56 INFO - PROCESS | 18568 | __end_cc_report 22:18:56 INFO - PROCESS | 18568 | __startTimestamp1456813136541__endTimestamp 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | ------- Summary: start ------- 22:18:56 INFO - PROCESS | 18568 | Number of tests: 6 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | [#0] dojo.html Cycles:165 Average:5129.95 Median:5351.79 stddev:548.56 (10.3%) stddev-sans-first:526.95 22:18:56 INFO - PROCESS | 18568 | Values: 3113.7 3142.9 3164.7 3176.6 3191.3 5102.2 5118.1 5132.1 5165.1 5203.8 5140.5 5167.7 5212.1 5241.4 5261.4 4677.3 4688.7 4719.9 4771.5 4859.3 4792.7 4803.1 4833.9 4846.5 4854.6 4674.2 4701.1 4771.3 4772.0 4792.8 4696.0 4713.6 4716.2 4717.1 4745.3 4652.0 4668.3 4674.3 4679.0 4687.3 4980.4 5002.3 5031.0 5051.9 5065.2 5502.1 5504.1 5513.8 5514.6 5522.7 5515.4 5571.9 5577.6 5579.2 5583.7 5123.2 5238.1 5272.8 5311.7 5322.1 5556.1 5556.9 5559.0 5563.2 5614.2 5344.5 5373.8 5378.2 5379.8 5391.5 5474.2 5478.9 5502.0 5538.4 5538.9 5447.3 5452.7 5453.2 5453.2 5455.3 5356.5 5433.2 5440.5 5473.7 5493.2 4219.7 4246.0 4273.6 4284.4 4284.4 3800.3 3812.7 3820.8 3843.6 3849.1 5053.3 5091.4 5095.6 5131.7 5159.9 5470.2 5492.3 5525.9 5525.9 5541.9 5127.5 5135.4 5139.7 5154.2 5185.8 4641.6 4689.1 4702.7 4733.3 4797.5 5679.9 5705.3 5705.7 5708.3 5749.4 5485.0 5491.3 5493.4 5496.5 5510.1 5693.3 5700.2 5739.3 5798.4 5810.5 5439.5 5444.3 5445.3 5446.0 5453.2 5503.3 5509.4 5517.8 5520.2 5572.2 5325.5 5424.1 5463.7 5468.2 5514.0 5349.8 5361.3 5370.8 5374.7 5383.7 5159.0 5294.7 5306.8 5309.6 5351.8 5362.4 5363.7 5407.0 5430.6 5457.1 5386.5 5393.0 5400.5 5400.8 5402.0 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | [#1] ext.html Cycles:180 Average:44876.77 Median:31205.19 stddev:73969.36 (237.0%) stddev-sans-first:74101.90 22:18:56 INFO - PROCESS | 18568 | Values: 525.0 540.8 549.5 555.6 585.5 34708.5 35206.1 35267.8 35309.1 35316.8 35851.0 36468.3 36500.5 36535.3 36552.8 7482.4 7577.1 8175.8 9853.9 10029.4 9894.0 10034.7 10035.7 10038.7 10040.8 7551.6 10005.9 10109.3 10111.5 10112.9 10270.3 10533.7 10534.2 10540.1 10544.2 9744.0 10000.6 10004.0 10004.4 10007.1 35842.8 35940.0 36114.8 36121.6 36152.8 3196.1 3325.1 3367.9 3543.2 3730.9 29032.9 29321.6 29357.0 29814.7 30467.7 3929.6 3974.9 4016.8 4050.7 4136.1 273976.0 274049.0 274366.0 275750.0 275781.0 55210.0 56338.4 56342.4 56467.2 56474.0 60064.7 63736.0 65164.3 65278.0 65285.7 15182.2 15306.5 15318.4 15352.6 15374.6 12096.7 12185.8 12221.9 12241.8 12251.9 19656.9 19685.9 20657.2 20671.8 20708.0 6557.3 7845.1 7851.1 7862.8 7977.1 911.6 922.5 962.3 1049.7 1059.8 25557.5 25914.4 26063.1 26082.2 26166.6 989.9 997.5 1025.2 1089.5 1152.0 14194.3 14576.9 14647.7 14819.9 14862.5 302250.0 305672.0 306032.0 308249.0 308734.0 51069.5 51381.5 51705.7 51826.7 51892.2 1165.5 1254.0 1321.6 1341.0 1350.1 25953.7 27855.1 28166.0 28441.1 28667.3 44739.6 45133.5 45327.3 45408.5 45516.5 262612.0 267888.0 269117.0 269483.0 270490.0 29198.1 29392.3 30957.8 31452.5 31594.0 38494.6 38580.2 38962.2 39109.2 39734.6 32845.0 32917.8 33230.3 33455.3 33546.7 34536.0 34767.5 35312.5 35362.6 35760.3 35963.0 36120.0 36365.3 36714.3 37465.0 28305.6 29554.7 29809.6 30273.4 30336.1 24457.6 24838.0 24866.5 24999.3 25016.9 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | [#2] jquery.html Cycles:180 Average:24438.25 Median:23858.48 stddev:68444.66 (286.9%) stddev-sans-first:68612.74 22:18:56 INFO - PROCESS | 18568 | Values: 337.9 352.1 357.2 360.4 364.8 13911.6 16864.9 16910.7 17141.7 17687.6 16035.4 16248.8 16411.8 16477.4 16497.0 5151.1 5386.0 5406.8 5417.0 5430.7 4886.0 5380.8 5411.2 5421.1 5424.8 5365.6 5368.3 5374.8 5376.3 5376.9 4872.9 5055.7 5057.5 5057.5 5352.4 4838.0 4847.5 4852.3 4869.9 4913.8 12221.6 12375.9 12577.9 12579.0 12587.6 2140.9 2259.4 2376.0 2497.5 2927.5 8888.6 9157.3 9158.5 9448.9 9488.3 1737.1 1894.7 1947.2 2003.1 2037.9 63930.0 64376.0 65854.0 65994.7 66118.7 9709.5 9760.2 9822.3 9885.0 9887.4 12377.5 12639.4 12655.4 12658.1 13324.7 7679.8 7694.7 7914.6 7953.6 8037.9 7700.0 7729.1 7791.5 7809.1 7826.2 4321.0 4346.6 4506.9 4514.0 4566.6 1780.7 1815.2 1820.4 1829.7 1850.9 874.9 903.2 926.1 943.8 978.3 15798.2 16483.3 16672.3 17013.8 17061.9 891.1 920.5 925.9 931.3 969.6 6888.9 9421.9 9609.1 9680.9 9838.6 404235.0 419060.0 419832.0 420067.0 420153.0 72626.0 72643.6 73726.0 74193.6 74887.3 1003.5 1008.8 1012.9 1024.3 1028.9 14087.4 15156.4 15434.0 15732.7 15860.8 32788.0 34394.8 34741.5 35476.1 35602.3 43370.3 44618.8 45046.3 45486.3 45769.5 7569.4 7777.0 7867.4 7873.6 7920.7 8807.7 11861.3 11974.2 12113.6 12672.0 10445.3 10677.5 10833.9 10929.8 11203.9 10256.4 10794.3 11219.2 11228.6 11552.2 10539.0 11023.8 11085.1 11357.4 11635.2 7775.1 8030.9 8115.6 8115.7 8210.4 10621.6 11056.9 11071.6 11108.2 11119.8 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | [#3] mootools.html Cycles:180 Average:5407.46 Median:6565.64 stddev:2864.18 (43.6%) stddev-sans-first:2856.19 22:18:56 INFO - PROCESS | 18568 | Values: 1375.9 1456.4 1463.8 1639.0 1789.6 7579.6 7740.2 7754.0 7777.0 7795.6 7536.4 7707.5 7720.8 7726.1 7732.6 1973.3 2179.4 2234.9 2238.1 2266.5 2210.6 2220.5 2223.0 2223.1 2223.3 2163.9 2208.8 2211.5 2212.0 2214.0 2183.3 2187.5 2187.9 2235.8 2239.2 2172.1 2191.4 2197.3 2198.2 2242.8 7884.3 7919.7 7926.4 7928.7 7940.8 4617.5 4670.0 4681.3 4697.6 4706.2 3014.4 3038.6 3107.1 3119.3 3173.0 938.3 943.7 954.1 964.0 981.8 10665.6 10717.4 10723.2 10725.6 10753.4 3938.6 4079.6 4085.8 4160.9 4165.2 8531.4 8721.8 8783.6 8832.3 8834.0 4121.2 4719.1 4728.9 4754.9 4762.8 4235.5 4272.2 4273.2 4301.4 4327.8 3411.1 3465.5 3491.7 3510.4 3528.5 957.4 974.9 978.9 983.7 1000.6 1255.1 1268.0 1291.5 1319.1 1342.4 7515.5 7617.0 7672.0 7683.6 7691.6 450.9 456.2 459.3 468.2 469.3 5879.4 5908.4 5919.9 5922.4 5955.0 8962.8 9172.4 9182.9 9190.9 9240.5 9075.3 9138.5 9187.9 9188.2 9197.9 7198.6 7300.3 7331.0 7357.5 7437.9 7308.2 7326.2 7336.9 7341.0 7356.8 8463.3 8465.8 8745.1 8752.3 8776.3 8612.5 8877.3 8926.6 8945.6 9010.2 6165.8 6309.9 6317.7 6956.6 7072.2 7303.9 7420.1 7428.6 7429.3 7453.4 6557.5 6690.4 6757.4 6782.9 6879.2 6577.8 6587.1 6588.8 6622.8 6685.4 6930.0 6972.8 6975.4 7058.9 7176.1 6398.7 6444.6 6447.3 6461.8 6464.9 6519.2 6573.8 6602.7 6609.2 6611.0 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | [#4] prototype.html Cycles:180 Average:5213.59 Median:5938.51 stddev:1604.68 (27.0%) stddev-sans-first:1566.33 22:18:56 INFO - PROCESS | 18568 | Values: 305.5 318.0 318.8 324.1 329.4 5765.6 5900.5 5964.8 5968.4 6035.0 5799.6 5881.3 5905.1 5913.9 5916.9 4312.2 4382.1 4499.1 4500.7 4506.9 4530.8 4536.5 4537.1 4538.6 4553.7 4449.9 4490.5 4491.8 4492.7 4502.8 4220.1 4276.1 4277.3 4376.2 4491.2 3874.2 3888.0 3890.1 3893.2 3902.9 5594.9 5609.8 5610.2 5614.4 5618.3 5160.0 5165.9 5167.2 5174.7 5175.7 6191.4 6202.3 6202.4 6203.8 6205.4 4177.5 4256.6 4286.3 4297.9 4298.0 6425.3 6447.5 6484.9 6488.2 6502.5 4318.9 4325.4 4331.3 4333.8 4339.1 4370.7 4379.7 4386.3 4387.5 4388.3 5117.1 5118.7 5125.9 5128.4 5128.7 6237.1 6251.3 6252.4 6260.7 6263.5 1479.0 1540.3 1550.0 1562.5 1562.8 989.9 1000.2 1001.6 1009.4 1027.5 5775.9 5829.0 5841.9 5903.4 5907.8 6472.6 6492.0 6500.4 6500.5 6503.6 5985.0 5985.8 5986.0 5988.9 5992.9 3453.3 3492.5 3495.1 3496.5 3499.2 6601.2 6742.4 6783.5 6786.2 6787.5 6612.0 6619.1 6631.3 6643.2 6694.7 6749.8 6770.3 6771.2 6776.1 6776.1 6464.7 6466.5 6472.2 6473.4 6487.2 6256.9 6412.5 6419.3 6420.5 6422.4 6767.9 6791.3 6803.6 6804.5 6810.8 4227.1 4227.5 4230.0 4232.2 4232.5 6375.2 6400.7 6433.5 6451.4 6458.7 6269.6 6283.3 6283.4 6286.8 6292.2 6081.8 6282.6 6330.2 6336.9 6342.2 6167.6 6197.9 6201.1 6213.3 6219.3 6328.9 6335.0 6338.8 6341.7 6347.0 5960.1 6184.8 6200.2 6220.7 6221.9 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | [#5] yui.html Cycles:180 Average:13701.30 Median:25339.19 stddev:15640.57 (61.7%) stddev-sans-first:15653.49 22:18:56 INFO - PROCESS | 18568 | Values: 597.1 612.9 652.7 698.3 765.0 12413.7 12461.4 12497.6 12561.1 12637.6 12254.4 12596.0 12664.3 12744.8 12770.0 688.5 817.7 825.4 842.8 845.9 824.1 828.4 828.5 829.5 829.8 872.7 882.5 883.1 883.2 884.3 715.4 856.3 867.9 868.8 870.5 640.2 641.8 644.7 645.0 645.4 12436.5 12893.0 12936.8 12949.8 12967.9 13138.7 13436.5 13487.5 13756.4 13878.9 9843.9 9973.0 10052.2 10067.6 10202.4 4202.8 4328.1 4338.2 4447.7 4451.2 46067.3 46155.5 46227.0 46269.5 46304.8 9744.8 9875.1 9996.0 10397.7 10496.6 17760.0 17779.3 17843.7 17860.8 17866.0 7462.4 7851.3 8187.8 8202.3 8267.8 4353.8 4495.8 4495.9 4589.0 4611.1 3107.2 3141.9 3146.9 3147.0 3147.1 497.1 540.2 558.8 580.3 585.4 613.8 682.2 687.6 692.2 700.0 8151.4 8361.8 8366.2 8619.0 8699.3 531.4 538.8 577.7 594.7 599.9 3850.7 3881.8 3951.2 4091.6 4108.2 55688.4 56502.7 56571.0 56910.4 57407.1 48981.8 49914.0 50570.5 50851.2 51159.2 45226.8 46327.0 46475.8 46962.8 47494.3 7852.5 7938.2 8099.5 8125.8 8230.3 33963.7 34237.3 34510.7 34954.1 36103.3 40714.0 44152.6 44504.8 44682.3 45462.3 10951.1 10964.3 11062.6 11304.0 11403.1 12452.9 12514.4 12617.7 12681.5 12723.7 11743.9 11808.8 11995.1 12284.8 12301.8 11139.5 11247.5 11284.5 11565.1 11819.8 11076.2 11512.1 11631.3 11852.3 12030.6 10209.7 10266.5 10370.0 10428.7 10555.9 8866.3 9222.5 9603.8 9618.3 9958.4 22:18:56 INFO - PROCESS | 18568 | -------- Summary: end -------- 22:18:56 INFO - PROCESS | 18568 | 22:18:56 INFO - PROCESS | 18568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:18:56 INFO - PROCESS | 18568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:18:56 INFO - PROCESS | 18568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:18:56 INFO - PROCESS | 18568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:18:56 INFO - PROCESS | 18568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:18:57 INFO - TEST-INFO | 18568: exit 0 22:18:57 INFO - TEST-OK | dromaeo_css | took 1112534ms 22:18:57 INFO - TEST-START | kraken 22:18:57 INFO - operating with platform_type : linux_ 22:18:57 INFO - Initialising browser for kraken test... 22:18:57 INFO - TEST-INFO | started process 18753 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5pkoiw/profile http://localhost:51075/getInfo.html) 22:19:00 INFO - PROCESS | 18753 | __metrics Screen width/height:1600/1200 22:19:00 INFO - PROCESS | 18753 | colorDepth:24 22:19:00 INFO - PROCESS | 18753 | Browser inner width/height: 1024/697 22:19:00 INFO - PROCESS | 18753 | __metrics 22:19:01 INFO - PROCESS | 18753 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:01 INFO - PROCESS | 18753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:01 INFO - PROCESS | 18753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:01 INFO - PROCESS | 18753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:01 INFO - PROCESS | 18753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:01 INFO - PROCESS | 18753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:01 INFO - PROCESS | 18753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:01 INFO - PROCESS | 18753 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:19:02 INFO - TEST-INFO | 18753: exit 0 22:19:02 INFO - Browser initialized. 22:19:02 INFO - Running cycle 1/1 for kraken test... 22:19:02 INFO - TEST-INFO | started process 18837 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5pkoiw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:14 INFO - PROCESS | 18837 | RSS: Main: 153620480 22:19:14 INFO - PROCESS | 18837 | 22:19:16 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51075/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:17 INFO - PROCESS | 18837 | RSS: Main: 196800512 22:19:17 INFO - PROCESS | 18837 | 22:19:20 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51075/tests/kraken/driver.html?testName=audio-dft) 22:19:20 INFO - PROCESS | 18837 | RSS: Main: 185434112 22:19:20 INFO - PROCESS | 18837 | 22:19:23 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51075/tests/kraken/driver.html?testName=audio-fft) 22:19:24 INFO - PROCESS | 18837 | RSS: Main: 172859392 22:19:24 INFO - PROCESS | 18837 | 22:19:26 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51075/tests/kraken/driver.html?testName=audio-oscillator) 22:19:26 INFO - PROCESS | 18837 | RSS: Main: 174071808 22:19:26 INFO - PROCESS | 18837 | 22:19:29 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51075/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:29 INFO - PROCESS | 18837 | RSS: Main: 174927872 22:19:29 INFO - PROCESS | 18837 | 22:19:32 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51075/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:33 INFO - PROCESS | 18837 | RSS: Main: 176058368 22:19:33 INFO - PROCESS | 18837 | 22:19:36 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51075/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:37 INFO - PROCESS | 18837 | RSS: Main: 175939584 22:19:37 INFO - PROCESS | 18837 | 22:19:39 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51075/tests/kraken/driver.html?testName=json-parse-financial) 22:19:40 INFO - PROCESS | 18837 | RSS: Main: 177135616 22:19:40 INFO - PROCESS | 18837 | 22:19:41 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51075/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:42 INFO - PROCESS | 18837 | RSS: Main: 187940864 22:19:42 INFO - PROCESS | 18837 | 22:19:44 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:44 INFO - PROCESS | 18837 | RSS: Main: 186122240 22:19:44 INFO - PROCESS | 18837 | 22:19:47 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:47 INFO - PROCESS | 18837 | RSS: Main: 191414272 22:19:47 INFO - PROCESS | 18837 | 22:19:50 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:50 INFO - PROCESS | 18837 | RSS: Main: 201113600 22:19:50 INFO - PROCESS | 18837 | 22:19:53 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:53 INFO - PROCESS | 18837 | RSS: Main: 200892416 22:19:53 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:51075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51075/tests/kraken/driver.html?testName=ai-astar) 22:19:55 INFO - PROCESS | 18837 | RSS: Main: 260083712 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | __start_tp_report 22:19:55 INFO - PROCESS | 18837 | _x_x_mozilla_page_load 22:19:55 INFO - PROCESS | 18837 | _x_x_mozilla_page_load_details 22:19:55 INFO - PROCESS | 18837 | |i|pagename|runs| 22:19:55 INFO - PROCESS | 18837 | |0;ai-astar;110;110;105;110;115;109;99;110;110;111 22:19:55 INFO - PROCESS | 18837 | |1;audio-beat-detection;151;127;154;182;127;157;163;129;180;128 22:19:55 INFO - PROCESS | 18837 | |2;audio-dft;161;163;161;161;162;160;160;163;160;162 22:19:55 INFO - PROCESS | 18837 | |3;audio-fft;73;76;93;98;76;76;75;116;100;73 22:19:55 INFO - PROCESS | 18837 | |4;audio-oscillator;93;95;149;92;94;94;146;92;93;142 22:19:55 INFO - PROCESS | 18837 | |5;imaging-gaussian-blur;117;118;116;118;117;117;118;117;116;117 22:19:55 INFO - PROCESS | 18837 | |6;imaging-darkroom;145;147;145;145;146;145;145;145;145;145 22:19:55 INFO - PROCESS | 18837 | |7;imaging-desaturate;96;95;96;95;95;95;96;95;95;96 22:19:55 INFO - PROCESS | 18837 | |8;json-parse-financial;57;58;57;55;59;56;57;69;53;56 22:19:55 INFO - PROCESS | 18837 | |9;json-stringify-tinderbox;67;69;68;68;69;69;69;69;69;69 22:19:55 INFO - PROCESS | 18837 | |10;stanford-crypto-aes;84;81;83;83;89;82;83;83;82;82 22:19:55 INFO - PROCESS | 18837 | |11;stanford-crypto-ccm;125;118;116;127;117;117;119;123;120;128 22:19:55 INFO - PROCESS | 18837 | |12;stanford-crypto-pbkdf2;154;142;159;150;142;150;153;159;143;155 22:19:55 INFO - PROCESS | 18837 | |13;stanford-crypto-sha256-iterative;68;69;69;69;68;68;70;68;69;69 22:19:55 INFO - PROCESS | 18837 | __end_tp_report 22:19:55 INFO - PROCESS | 18837 | __start_cc_report 22:19:55 INFO - PROCESS | 18837 | _x_x_mozilla_cycle_collect,1084 22:19:55 INFO - PROCESS | 18837 | __end_cc_report 22:19:55 INFO - PROCESS | 18837 | __startTimestamp1456813195765__endTimestamp 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | ------- Summary: start ------- 22:19:55 INFO - PROCESS | 18837 | Number of tests: 14 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:4.23 (3.8%) stddev-sans-first:4.47 22:19:55 INFO - PROCESS | 18837 | Values: 110.0 110.0 105.0 110.0 115.0 109.0 99.0 110.0 110.0 111.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:155.50 stddev:21.45 (13.8%) stddev-sans-first:22.75 22:19:55 INFO - PROCESS | 18837 | Values: 151.0 127.0 154.0 182.0 127.0 157.0 163.0 129.0 180.0 128.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 22:19:55 INFO - PROCESS | 18837 | Values: 161.0 163.0 161.0 161.0 162.0 160.0 160.0 163.0 160.0 162.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#3] audio-fft Cycles:10 Average:85.60 Median:76.00 stddev:15.08 (19.8%) stddev-sans-first:15.29 22:19:55 INFO - PROCESS | 18837 | Values: 73.0 76.0 93.0 98.0 76.0 76.0 75.0 116.0 100.0 73.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:25.37 (27.3%) stddev-sans-first:26.24 22:19:55 INFO - PROCESS | 18837 | Values: 93.0 95.0 149.0 92.0 94.0 94.0 146.0 92.0 93.0 142.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 22:19:55 INFO - PROCESS | 18837 | Values: 117.0 118.0 116.0 118.0 117.0 117.0 118.0 117.0 116.0 117.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:19:55 INFO - PROCESS | 18837 | Values: 145.0 147.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:19:55 INFO - PROCESS | 18837 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:4.30 (7.5%) stddev-sans-first:4.55 22:19:55 INFO - PROCESS | 18837 | Values: 57.0 58.0 57.0 55.0 59.0 56.0 57.0 69.0 53.0 56.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.44 22:19:55 INFO - PROCESS | 18837 | Values: 67.0 69.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.20 (2.7%) stddev-sans-first:2.32 22:19:55 INFO - PROCESS | 18837 | Values: 84.0 81.0 83.0 83.0 89.0 82.0 83.0 83.0 82.0 82.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.50 stddev:4.42 (3.6%) stddev-sans-first:4.45 22:19:55 INFO - PROCESS | 18837 | Values: 125.0 118.0 116.0 127.0 117.0 117.0 119.0 123.0 120.0 128.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:153.50 stddev:6.53 (4.3%) stddev-sans-first:6.82 22:19:55 INFO - PROCESS | 18837 | Values: 154.0 142.0 159.0 150.0 142.0 150.0 153.0 159.0 143.0 155.0 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:19:55 INFO - PROCESS | 18837 | Values: 68.0 69.0 69.0 69.0 68.0 68.0 70.0 68.0 69.0 69.0 22:19:55 INFO - PROCESS | 18837 | -------- Summary: end -------- 22:19:55 INFO - PROCESS | 18837 | 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:55 INFO - PROCESS | 18837 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:19:56 INFO - TEST-INFO | 18837: exit 0 22:19:56 INFO - TEST-OK | kraken | took 59443ms 22:19:56 INFO - SUITE-END | took 1171s 22:19:56 INFO - Completed test suite (00:19:32) 22:19:56 INFO - Working with test: dromaeo_css 22:19:56 INFO - Generating results file: dromaeo_css 22:19:56 INFO - Working with test: kraken 22:19:56 INFO - Generating results file: kraken 22:19:56 INFO - javascript benchmark 22:19:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:19:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:19:56 INFO - process_Request line: dromaeo_css 6783.95 graph.html#tests=[[72,63,35]] 22:19:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:19:57 INFO - process_Request line: kraken 1522.30 graph.html#tests=[[232,63,35]] 22:19:57 INFO - RETURN: dromaeo_css: 6783.95 22:19:57 INFO - RETURN: kraken: 1522.30 22:19:57 INFO - javascript benchmark 22:19:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.657497675256, 3142.8742850286003, 3164.6835316468355, 3176.618805743311, 3191.3457741163065, 5102.1836506159025, 5118.053160165367, 5132.101882170619, 5165.147750621143, 5203.765830537625, 5140.511651393112, 5167.689938603687, 5212.061828870802, 5241.42344342122, 5261.421243663194, 4677.2750223715375, 4688.718676879381, 4719.858404247861, 4771.5467030632035, 4859.319695242669, 4792.736399498026, 4803.063402636487, 4833.903321933559, 4846.466888642247, 4854.611631069523, 4674.158651442739, 4701.083288758693, 4771.260454629521, 4771.952280477186, 4792.808287668489, 4695.9668872847915, 4713.599344055725, 4716.221823399135, 4717.056588682277, 4745.288206768978, 4652.046330502239, 4668.299755036738, 4674.252119660872, 4678.976605116953, 4687.320338550925, 4980.427250866161, 5002.324686167393, 5031.0, 5051.924221136685, 5065.189569668835, 5502.119660854244, 5504.119340905436, 5513.807016754395, 5514.641548299388, 5522.723863806794, 5515.365732940683, 5571.916421253684, 5577.609567330289, 5579.163125531203, 5583.664980101207, 5123.180291153435, 5238.05714971305, 5272.841814745564, 5311.73441327936, 5322.148456246982, 5556.083246264402, 5556.944430555643, 5558.972205138948, 5563.165525171256, 5614.1859430382365, 5344.518993290545, 5373.7581808818695, 5378.2470454136455, 5379.838604841861, 5391.487808658171, 5474.206240095164, 5478.863028424321, 5502.0, 5538.446155384429, 5538.86152846174, 5447.319085114361, 5452.727363631802, 5453.209284653703, 5453.23654688344, 5455.263539422207, 5356.491133342326, 5433.157860531624, 5440.455954404607, 5473.698946557977, 5493.23094766733, 4219.725717828332, 4246.0, 4273.594008569181, 4284.378765079046, 4284.378765079108, 3800.25894950482, 3812.6759225466144, 3820.8471661133244, 3843.557990831034, 3849.0569810396073, 5053.343065401475, 5091.439941606421, 5095.592352611782, 5131.666441681279, 5159.948400515947, 5470.234167216593, 5492.340919089735, 5525.861853453615, 5525.917111243334, 5541.861453463695, 5127.512886275797, 5135.435102138762, 5139.665921715076, 5154.226865970059, 5185.818496352609, 4641.582257596832, 4689.085628302449, 4702.717836929795, 4733.313669517901, 4797.520247975174, 5679.858003549862, 5705.258316418839, 5705.71471426427, 5708.343540492813, 5749.367569567345, 5485.040117979417, 5491.258680078298, 5493.423190565093, 5496.4503549646315, 5510.118381059011, 5693.259876216231, 5700.173474846207, 5739.253896993364, 5798.391168927202, 5810.477057064884, 5439.537639300704, 5444.3194600674915, 5445.319335083114, 5445.972770136124, 5453.2365468833605, 5503.284573005483, 5509.3664228614225, 5517.834464966058, 5520.199571062254, 5572.219889215594, 5325.547328477122, 5424.1321388577635, 5463.672179669074, 5468.179773034077, 5513.972430137824, 5349.759260833194, 5361.303030605996, 5370.838874833761, 5374.6506477078865, 5383.703896285742, 5159.0, 5294.708791016531, 5306.814261500829, 5309.601779866603, 5351.785928562814, 5362.356517217959, 5363.678179309254, 5406.972965135306, 5430.592705547021, 5457.072297709319, 5386.48828361305, 5393.0, 5400.513953744182, 5400.810971616132, 5401.972990135024], "unit": "score", "name": "dojo.html", "value": 5095.749630091755}, {"lowerIsBetter": false, "replicates": [524.9973750131248, 540.8242321245594, 549.4587830986475, 555.6499405374616, 585.5432762445291, 34708.479372809394, 35206.119847003836, 35267.823660881695, 35309.11727206821, 35316.823415882915, 35851.0, 36468.270634587294, 36500.45249321256, 36535.26929461409, 36552.81723591385, 7482.438817088713, 7577.090749110114, 8175.795605109875, 9853.852192217122, 10029.448380339078, 9893.950530247339, 10034.69895903124, 10035.69892903214, 10038.698839034842, 10040.799184016316, 7551.622418879061, 10005.949970250138, 10109.342892711988, 10111.494425278706, 10112.94943525285, 10270.33242839213, 10533.73665658361, 10534.209934254885, 10540.051395374454, 10544.209184311207, 9743.951280243624, 10000.649977250834, 10004.049615286536, 10004.399736015863, 10007.099361057468, 35842.82078589616, 35940.0, 36114.81942590296, 36121.63878361209, 36152.81923590392, 3196.105090574643, 3325.1354647791504, 3367.8821241256683, 3543.167355671415, 3730.8880733578035, 29032.8548357259, 29321.560176597155, 29357.0, 29814.701852981627, 30467.69532304693, 3929.5873933236885, 3974.880753577397, 4016.819243134066, 4050.655694265991, 4136.110736191733, 273976.0, 274049.0, 274366.0, 275750.0, 275781.0, 55210.0, 56338.43661563414, 56342.436575634536, 56467.15299270432, 56474.0, 60064.69967650134, 63736.0, 65164.34835651678, 65278.0, 65285.67357163279, 15182.240887955559, 15306.540803775904, 15318.387264509518, 15352.616184595474, 15374.615634609001, 12096.697582560506, 12185.817212741817, 12221.938890305491, 12241.755164896653, 12251.938740306241, 19656.90171549133, 19685.901570492057, 20657.17371305131, 20671.79587163992, 20708.0, 6557.278699343068, 7845.136525168273, 7851.136374998746, 7862.764117076496, 7977.122516523178, 911.5806728904646, 922.5110691333604, 962.2542529539522, 1049.7270709615555, 1059.750958524746, 25557.48885022289, 25914.352141196243, 26063.08779192719, 26082.217533474028, 26166.6075008875, 989.8762654668167, 997.5211898288862, 1025.195221750922, 1089.493385575711, 1152.004787552374, 14194.290285485684, 14576.936327007585, 14647.680403416674, 14819.851801482062, 14862.479813206486, 302250.0, 305672.0, 306032.0, 308249.0, 308734.0, 51069.48930510647, 51381.48618513842, 51705.7414712924, 51826.740866295426, 51892.22161667578, 1165.4871856383165, 1254.0, 1321.623337348851, 1341.0478560222157, 1350.0751984890383, 25953.74046259513, 27855.108668498626, 28166.0, 28441.146765597066, 28667.28331791722, 44739.55260447354, 45133.548664512935, 45327.320090198016, 45408.54591454043, 45516.54483455256, 262612.0, 267888.0, 269117.0, 269483.0, 270490.0, 29198.124056278346, 29392.26519337034, 30957.8452107738, 31452.528212077294, 31594.0, 38494.615053849106, 38580.228395431375, 38962.220755585295, 39109.2178156441, 39734.60265397309, 32845.0, 32917.835410822794, 33230.33539329248, 33455.33089338248, 33546.66453335436, 34536.0, 34767.4784878222, 35312.47031294481, 35362.64637353696, 35760.28479430345, 35963.0, 36120.0, 36365.27269454649, 36714.26571468609, 37465.0, 28305.57541636918, 29554.704452955197, 29809.552856706734, 30273.394532109676, 30336.089917302517, 24457.633135503336, 24838.0, 24866.50266994686, 24999.250022499353, 25016.874915626035], "unit": "score", "name": "ext.html", "value": 18253.432975704847}, {"lowerIsBetter": false, "replicates": [337.85472246933807, 352.1442893768143, 357.23729836798447, 360.43411843405846, 364.79753736676133, 13911.582652520441, 16864.91567542162, 16910.74633880491, 17141.74287385687, 17687.55781105473, 16035.438759643415, 16248.75626865598, 16411.753823692623, 16477.423290184845, 16497.0, 5151.0728068947665, 5385.973070134643, 5406.756695948692, 5417.0, 5430.67415955042, 4885.9511404886025, 5380.789322402447, 5411.242426060355, 5421.105517589613, 5424.810131645393, 5365.624406291561, 5368.3021207243, 5374.758135883875, 5376.327959005124, 5376.892462150755, 4872.853814385574, 5055.747212639353, 5057.4689657585795, 5057.4689657585795, 5352.357717073937, 4838.032393521275, 4847.466778654345, 4852.2721591761165, 4869.9269510957365, 4913.803447862081, 12221.633350999484, 12375.876241237653, 12577.937110314482, 12579.0, 12587.622371328875, 2140.8501404901663, 2259.423846919025, 2375.9524809503714, 2497.5379554782244, 2927.5315949447986, 8888.644454221823, 9157.267418606496, 9158.450492970444, 9448.90551094494, 9488.28837837165, 1737.1227530097347, 1894.6779047561947, 1947.1821834829407, 2003.1086166655843, 2037.8777273363646, 63930.04104938383, 64376.034359485115, 65854.0, 65994.67002665004, 66118.66940665265, 9709.514524273758, 9760.170385517311, 9822.26333025026, 9885.022995400948, 9887.406755594688, 12377.504899804087, 12639.43122559487, 12655.43050562727, 12658.050646201387, 13324.733505330032, 7679.846403071907, 7694.730684426018, 7914.643841027052, 7953.562554059582, 8037.919620803834, 7700.0, 7729.149793522708, 7791.532508049422, 7809.0629124504285, 7826.2173782621285, 4320.978395108004, 4346.6088052075465, 4506.887327816831, 4513.977430112828, 4566.589006989387, 1780.7328900665004, 1815.2285278756476, 1820.4356649438453, 1829.652366050446, 1850.898200598953, 874.9431286966327, 903.1690844423147, 926.129438327983, 943.8112377524523, 978.320067553058, 15798.21008949548, 16483.258253378626, 16672.333106675596, 17013.829861701473, 17061.914690426467, 891.064382398479, 920.5305294299956, 925.8981512033671, 931.2736065868634, 969.5685419988179, 6888.862222755617, 9421.90578094224, 9609.135177834029, 9680.903190968142, 9838.60645574169, 404235.0, 419060.0, 419832.0, 420067.0, 420153.0, 72626.0, 72643.63678181576, 73726.0, 74193.62903185449, 74887.25112748802, 1003.4932359158724, 1008.7982403519326, 1012.9189664826944, 1024.3137098144111, 1028.9382637041801, 14087.366068527146, 15156.393744250106, 15434.0, 15732.68534629324, 15860.76208856845, 32788.0, 34394.82802586071, 34741.47887781635, 35476.113097172776, 35602.287954241285, 43370.349444757725, 44618.77690611656, 45046.324305134796, 45486.317705233785, 45769.54230457786, 7569.3566046886635, 7777.0, 7867.449278550446, 7873.566953817366, 7920.722774702857, 8807.691730789391, 11861.288322700666, 11974.161808673309, 12113.576024839089, 12672.0, 10445.268831181744, 10677.46612669379, 10833.945830270799, 10929.836052459379, 11203.88796112061, 10256.38461692301, 10794.31355005474, 11219.214654974074, 11228.606998755004, 11552.191346605658, 10539.0, 11023.83464248021, 11085.113190944867, 11357.37534435614, 11635.185537012328, 7775.144734079134, 8030.919690803017, 8115.594220288844, 8115.715949941724, 8210.425270231266, 10621.628243011457, 11056.889431105586, 11071.612493562687, 11108.222424430212, 11119.83320250213], "unit": "score", "name": "jquery.html", "value": 8201.106815804398}, {"lowerIsBetter": false, "replicates": [1375.9105658132228, 1456.4392708807109, 1463.7511623024084, 1638.967220655587, 1789.6420715856823, 7579.621018949051, 7740.225977402271, 7753.9919810424635, 7776.96111519443, 7795.649195786189, 7536.35940945019, 7707.537547747125, 7720.806979825507, 7726.072871255457, 7732.574708391036, 1973.2501649373219, 2179.40066481718, 2234.899429525667, 2238.0935721033006, 2266.5353602511445, 2210.613142700021, 2220.4892874638845, 2222.977770222293, 2223.132978138527, 2223.266322113707, 2163.9026243819067, 2208.7680793516693, 2211.524522227721, 2211.9557608847813, 2214.025828635395, 2183.3449965010514, 2187.4750059985568, 2187.9453013674624, 2235.8434909556336, 2239.1603148819195, 2172.1420039084474, 2191.386411804697, 2197.3298144066052, 2198.230619283254, 2242.843000989931, 7884.250996155356, 7919.683212671486, 7926.365890728785, 7928.682852685885, 7940.761777146637, 4617.468991066037, 4669.976650116761, 4681.250999840009, 4697.647676424248, 4706.176419126673, 3014.427258820839, 3038.635363756341, 3107.1300035989957, 3119.266972261517, 3172.9682703172903, 938.2822141062093, 943.6980166346772, 954.1031430455349, 963.9614415423445, 981.788915383196, 10665.573377064908, 10717.410542420243, 10723.249372543925, 10725.624603138853, 10753.354798712102, 3938.6455219030427, 4079.571644977294, 4085.754854708727, 4160.875173744793, 4165.208610364021, 8531.402801803813, 8721.781955451164, 8783.648654053766, 8832.337574681924, 8834.0, 4121.216968775923, 4719.079779442975, 4728.929066064012, 4754.881127971759, 4762.78567464465, 4235.534091250021, 4272.230998420314, 4273.18809426208, 4301.419308393327, 4327.8485253016, 3411.0619579615804, 3465.4801779733243, 3491.650834916488, 3510.368133735952, 3528.4883691864534, 957.4207604399378, 974.9122578967927, 978.8727465429448, 983.7343917142474, 1000.6247657128577, 1255.121415009497, 1267.9809802852965, 1291.5479582146174, 1319.0964189530202, 1342.4093398904452, 7515.511491753018, 7616.961915190499, 7672.0, 7683.577403242875, 7691.5769632670745, 450.86474057782533, 456.24035980093436, 459.3224993135099, 468.1526437148772, 469.31011413222507, 5879.441453061952, 5908.350081491032, 5919.852003699856, 5922.407759224129, 5955.047192449188, 8962.820743585222, 9172.44965302084, 9182.908170918205, 9190.862137067948, 9240.537973101318, 9075.273978081737, 9138.497382643885, 9187.862182067274, 9188.173064424234, 9197.908020919838, 7198.640067996579, 7300.269973002763, 7331.0, 7357.52176108562, 7437.925620743831, 7308.196098429062, 7326.194118647051, 7336.926630733625, 7341.045664063638, 7356.77929662111, 8463.28062114727, 8465.83068338642, 8745.125487451203, 8752.34357423183, 8776.254018408506, 8612.48325100496, 8877.33419993516, 8926.553672316228, 8945.59744811498, 9010.189082982562, 6165.753369865155, 6309.936900630935, 6317.7157027932935, 6956.582605043714, 7072.151341839012, 7303.890441643273, 7420.146683131509, 7428.6285685716575, 7429.257074292744, 7453.366463850633, 6557.475401967927, 6690.397864192246, 6757.425618822455, 6782.898256526255, 6879.1744990599445, 6577.80266592003, 6587.077809106825, 6588.802335929738, 6622.801315960529, 6685.364890335411, 6929.965350173217, 6972.79081627552, 6975.407090397373, 7058.858822823412, 7176.138863336433, 6398.712057957497, 6444.613323200623, 6447.258565265054, 6461.8061458156335, 6464.903026454701, 6519.185101862267, 6573.80278591643, 6602.702878370389, 6609.239937407259, 6611.041398997215], "unit": "score", "name": "mootools.html", "value": 4328.152355096121}, {"lowerIsBetter": false, "replicates": [305.49135689077684, 317.9777415580909, 318.7545589895782, 324.1248628702503, 329.44817430803397, 5765.567582431314, 5900.468957793798, 5964.821055368335, 5968.373320801318, 6035.0, 5799.623024503404, 5881.323647780507, 5905.084711869667, 5913.85215369616, 5916.940830591693, 4312.202242585116, 4382.145481631083, 4499.077689073749, 4500.729956202622, 4506.864794056183, 4530.773461326937, 4536.500984891659, 4537.137943790685, 4538.591526762591, 4553.726776393427, 4449.911001779962, 4490.483594386638, 4491.842785502508, 4492.730436173823, 4502.842400515966, 4220.134872351161, 4276.144771045803, 4277.337012763027, 4376.168527979674, 4491.191585514606, 3874.2057878134915, 3887.961120388788, 3890.1247219375414, 3893.1824316893203, 3902.8829135125993, 5594.916076258859, 5609.831705048814, 5610.158476228598, 5614.3543492498475, 5618.297712785902, 5160.0, 5165.9225111623355, 5167.224916262553, 5174.689518628894, 5175.663581867204, 6191.380861913818, 6202.255729312466, 6202.4417802398, 6203.844903877394, 6205.441510264098, 4177.4778152730905, 4256.553061928484, 4286.314189729659, 4297.871063868089, 4297.97851010746, 6425.325340839191, 6447.484201263935, 6484.870302593922, 6488.156539649863, 6502.5448218624715, 4318.935215971763, 4325.394444777734, 4331.263685173465, 4333.804978775963, 4339.132173565299, 4370.737755734666, 4379.671524635665, 4386.298192289219, 4387.473503179575, 4388.319810429389, 5117.053345131163, 5118.667286626357, 5125.8718532037, 5128.410232823198, 5128.692278463304, 6237.064440333896, 6251.343608921089, 6252.437280644673, 6260.7495700171485, 6263.530235232376, 1478.9556313310618, 1540.3222582063856, 1549.9767503487458, 1562.5312406278072, 1562.7733978573044, 989.8960609136082, 1000.2148313573955, 1001.6293971230546, 1009.4145395670494, 1027.4605831938293, 5775.942240577624, 5829.038208695602, 5841.9415805842245, 5903.409659034062, 5907.793227237026, 6472.579282346633, 6491.967540162364, 6500.382463665944, 6500.512461565401, 6503.642299673469, 5985.012472941916, 5985.760569577168, 5986.0, 5988.850278743066, 5992.850178745479, 3453.32660131277, 3492.4935884296633, 3495.143689795965, 3496.4755286707195, 3499.177693242086, 6601.174853143357, 6742.426893713991, 6783.491238157158, 6786.1856577210065, 6787.457003439713, 6611.966940165268, 6619.106420633153, 6631.303713110054, 6643.169603799525, 6694.698738556776, 6749.763758268437, 6770.255271920085, 6771.187457505131, 6776.119104516282, 6776.119104516381, 6464.676766161767, 6466.547341686037, 6472.223333199858, 6473.352664733489, 6487.1566696331065, 6256.874862502634, 6412.487001039813, 6419.261784894797, 6420.454261387647, 6422.389872962061, 6767.89848152288, 6791.252962174058, 6803.625800581016, 6804.4556435484055, 6810.761623343159, 4227.091175397304, 4227.450431443893, 4230.027093768389, 4232.217039847638, 4232.513260975027, 6375.203099612549, 6400.679966001774, 6433.517486188648, 6451.387118223761, 6458.67706614658, 6269.561130720988, 6283.3402492737605, 6283.403076707706, 6286.842828929313, 6292.244930608356, 6081.847953801191, 6282.560220784501, 6330.240371155491, 6336.904946425715, 6342.175517182736, 6167.5682702210415, 6197.907031394442, 6201.131841542097, 6213.316535181036, 6219.284782249918, 6328.905066423915, 6334.986402175814, 6338.778142764981, 6341.682915854281, 6347.0, 5960.0761881908375, 6184.845378865564, 6200.193974783249, 6220.657863817352, 6221.9377806223165], "unit": "score", "name": "prototype.html", "value": 4684.032220448844}, {"lowerIsBetter": false, "replicates": [597.0834768630151, 612.9356417576155, 652.6964961292999, 698.3261152987372, 764.9711138518692, 12413.689657758561, 12461.37693115344, 12497.625071247854, 12561.057920655941, 12637.55768548101, 12254.448549815257, 12596.0, 12664.303463309538, 12744.808827867566, 12770.0, 688.5077169823575, 817.6647574494458, 825.4304529874397, 842.810367667273, 845.8984921809391, 824.0729179672868, 828.4283844147519, 828.4615000249826, 829.5022986208257, 829.7925518620345, 872.7032808844991, 882.496976723268, 883.1257055515026, 883.218351758695, 884.2660591708866, 715.4097869257857, 856.3149480415642, 867.8524650809314, 868.7958329792493, 870.4646642314931, 640.1837656987332, 641.8010416770816, 644.7131026693123, 644.9645269510175, 645.403002222942, 12436.502539898393, 12893.033022523254, 12936.805947910789, 12949.805752913713, 12967.935160324232, 13138.671533211746, 13436.529721459701, 13487.460501579924, 13756.380962856696, 13878.861211387857, 9843.852342214872, 9972.95013524935, 10052.195824334036, 10067.597296108146, 10202.387856728546, 4202.768847713374, 4328.091100868822, 4338.240807858644, 4447.688661793643, 4451.1765323415275, 46067.308990364836, 46155.53844461546, 46227.0, 46269.53730462686, 46304.768476157406, 9744.75638109053, 9875.111239988435, 9995.950020249998, 10397.740056498496, 10496.632617858491, 17760.0, 17779.288828446977, 17843.73234401485, 17860.821391786176, 17866.01736904483, 7462.365698915544, 7851.332636725942, 8187.79530511742, 8202.26179643835, 8267.793305167419, 4353.782310884443, 4495.842645507457, 4495.88760280989, 4588.977055114703, 4611.077784443058, 3107.2231942014496, 3141.9214519637194, 3146.889858854929, 3146.9527957080663, 3147.134538002022, 497.1101727907078, 540.2328693255587, 558.7820749907539, 580.3442110415203, 585.4204337705726, 613.7575657615217, 682.2393031769641, 687.6495563471339, 692.2385376086365, 699.9685014174374, 8151.429399942066, 8361.790955226168, 8366.205210504992, 8618.956905215433, 8699.347548933856, 531.388902761827, 538.8275751759478, 577.6678409914232, 594.6818452128091, 599.8980173370537, 3850.6726928210855, 3881.7670939743707, 3951.249262640089, 4091.6112969267874, 4108.239975604522, 55688.443115569135, 56502.71748641231, 56571.0, 56910.430895691345, 57407.138892915806, 48981.75509122432, 49914.0, 50570.49429505658, 50851.237231441555, 51159.23261151086, 45226.77386613046, 46327.0, 46475.83810404699, 46962.76518617385, 47494.28758568555, 7852.528848269122, 7938.206179382016, 8099.473534220257, 8125.752361353113, 8230.259276665129, 33963.66036339605, 34237.315253695284, 34510.654893450745, 34954.12614684653, 36103.27793444169, 40714.0, 44152.55847441613, 44504.77747611241, 44682.3297650529, 45462.318065228385, 10951.123910087015, 10964.28732132409, 11062.557497700001, 11303.996367392645, 11403.144764142888, 12452.875471245172, 12514.374281285716, 12617.68455788576, 12681.492740290285, 12723.681907952376, 11743.94304512598, 11808.822867657163, 11995.1003674723, 12284.754304914031, 12301.75396492083, 11139.498722557666, 11247.493862776031, 11284.492197851281, 11565.074794016291, 11819.82270265964, 11076.169287303323, 11512.136589755635, 11631.302121872377, 11852.288862668267, 12030.63908082759, 10209.74475638115, 10266.538005789907, 10370.0, 10428.739281518023, 10555.89444105549, 8866.290696744116, 9222.538873056454, 9603.759906002126, 9618.278629102706, 9958.352707074017], "unit": "score", "name": "yui.html", "value": 6302.4255428054985}], "name": "dromaeo_css", "value": 6783.948016069684}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 115.0, 109.0, 99.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 154.0, 182.0, 127.0, 157.0, 163.0, 129.0, 180.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 161.0, 162.0, 160.0, 160.0, 163.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 93.0, 98.0, 76.0, 76.0, 75.0, 116.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 149.0, 92.0, 94.0, 94.0, 146.0, 92.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 116.0, 118.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 55.0, 59.0, 56.0, 57.0, 69.0, 53.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 83.0, 89.0, 82.0, 83.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [125.0, 118.0, 116.0, 127.0, 117.0, 117.0, 119.0, 123.0, 120.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [154.0, 142.0, 159.0, 150.0, 142.0, 150.0, 153.0, 159.0, 143.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 70.0, 68.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1522.3}]} 22:19:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1522.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6783.95"}}} 22:19:57 INFO - Return code: 0 22:19:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:19:57 INFO - # TBPL SUCCESS # 22:19:57 INFO - Running post-action listener: _resource_record_post_action 22:19:57 INFO - Running post-run listener: _resource_record_post_run 22:19:58 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 541622272; Read time: 0; Write time: 439272 22:19:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240885760; Read time: 0; Write time: 245392 22:19:58 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 300736512; Read time: 0; Write time: 193880 22:19:58 INFO - Running post-run listener: _upload_blobber_files 22:19:58 INFO - Blob upload gear active. 22:19:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:19:58 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 22:19:58 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:19:58 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:19:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:59 INFO - (blobuploader) - INFO - Done attempting. 22:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:00 INFO - (blobuploader) - INFO - Done attempting. 22:20:00 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:00 INFO - Return code: 0 22:20:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:20:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b85147dde6cdb876d07ccec53e98ca81db11e00fc39ed89dc1daf2c80bd3d990e4a0efcc03a392914507c6d8f2c78eacc427f5c84adb7bae453d7b5fd3101ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8661883407bc11e0a6102860ecee4018d2c0a3062a3b428be50aa5147104b0a6c8cb7339fad406a09745b6b6dee7e46412b3a4321e617ec1b8838659f314f072"} 22:20:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:20:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:20:00 INFO - Contents: 22:20:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b85147dde6cdb876d07ccec53e98ca81db11e00fc39ed89dc1daf2c80bd3d990e4a0efcc03a392914507c6d8f2c78eacc427f5c84adb7bae453d7b5fd3101ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8661883407bc11e0a6102860ecee4018d2c0a3062a3b428be50aa5147104b0a6c8cb7339fad406a09745b6b6dee7e46412b3a4321e617ec1b8838659f314f072"} 22:20:00 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:00 INFO - Copying logs to upload dir... 22:20:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:20:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.956600 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-29 22:19:59.731427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 22:19:59.735165) ========= 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b85147dde6cdb876d07ccec53e98ca81db11e00fc39ed89dc1daf2c80bd3d990e4a0efcc03a392914507c6d8f2c78eacc427f5c84adb7bae453d7b5fd3101ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8661883407bc11e0a6102860ecee4018d2c0a3062a3b428be50aa5147104b0a6c8cb7339fad406a09745b6b6dee7e46412b3a4321e617ec1b8838659f314f072"} build_url:https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/S0n5M6KAQIOhG0DQr9MOdg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b85147dde6cdb876d07ccec53e98ca81db11e00fc39ed89dc1daf2c80bd3d990e4a0efcc03a392914507c6d8f2c78eacc427f5c84adb7bae453d7b5fd3101ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8661883407bc11e0a6102860ecee4018d2c0a3062a3b428be50aa5147104b0a6c8cb7339fad406a09745b6b6dee7e46412b3a4321e617ec1b8838659f314f072"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 22:19:59.760297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:19:59.760669) ========= 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=0274524eba3bdaad075c2247000001d4-1456807003.879271-1419526910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 22:19:59.844754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 22:19:59.845100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 22:19:59.845423) ========= ========= Total master_lag: 0.33 =========