builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1458821746.78 results: success (0) buildid: 20160324024342 builduid: 6491b3bfbba64b6e853ad02b7abb58a2 revision: 3d3834cc0e36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.779226) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.779691) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.779978) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006406 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.885835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.886117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.949695) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.949971) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.999151) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.999431) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:46.999810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:47.000078) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 05:15:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-03-24 05:15:47 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140707 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:47.370493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:47.370813) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:47.420247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:47.420589) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3d3834cc0e36 --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 3d3834cc0e36 --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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 05:15:47,432 Setting DEBUG logging. 2016-03-24 05:15:47,433 attempt 1/10 2016-03-24 05:15:47,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3d3834cc0e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 05:15:47,672 unpacking tar archive at: mozilla-inbound-3d3834cc0e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:48.027790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:48.028094) ========= echo 3d3834cc0e36 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3d3834cc0e36'] 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3d3834cc0e36 program finished with exit code 0 elapsedTime=0.004657 script_repo_revision: '3d3834cc0e36' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:48.079347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:48.079676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 05:15:48.091537) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-24 05:15:48.091930) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:48 INFO - MultiFileLogger online at 20160324 05:15:48 in /builds/slave/test-pgo 05:15:48 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 05:15:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:15:48 INFO - {'append_to_log': False, 05:15:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:15:48 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:15:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:15:48 INFO - 'branch': 'Mozilla-Inbound', 05:15:48 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:48 INFO - 'config_files': ('talos/linux_config.py',), 05:15:48 INFO - 'default_actions': ('clobber', 05:15:48 INFO - 'read-buildbot-config', 05:15:48 INFO - 'download-and-extract', 05:15:48 INFO - 'populate-webroot', 05:15:48 INFO - 'create-virtualenv', 05:15:48 INFO - 'install', 05:15:48 INFO - 'run-tests'), 05:15:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:48 INFO - 'download_minidump_stackwalk': True, 05:15:48 INFO - 'download_symbols': 'ondemand', 05:15:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:48 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:48 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:48 INFO - 'installer_path': 'installer.exe', 05:15:48 INFO - 'log_level': 'info', 05:15:48 INFO - 'log_name': 'talos', 05:15:48 INFO - 'log_to_console': True, 05:15:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:48 INFO - 'opt_config_files': (), 05:15:48 INFO - 'pip_index': False, 05:15:48 INFO - 'sps_profile': False, 05:15:48 INFO - 'sps_profile_interval': 0, 05:15:48 INFO - 'suite': 'dromaeojs', 05:15:48 INFO - 'system_bits': '32', 05:15:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:48 INFO - 'title': 'talos-linux64-ix-033', 05:15:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:48 INFO - 'use_talos_json': True, 05:15:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:15:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:48 INFO - 'work_dir': 'build'} 05:15:48 INFO - ##### 05:15:48 INFO - ##### Running clobber step. 05:15:48 INFO - ##### 05:15:48 INFO - Running pre-action listener: _resource_record_pre_action 05:15:48 INFO - Running main action method: clobber 05:15:48 INFO - rmtree: /builds/slave/test-pgo/build 05:15:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:15:48 INFO - Running post-action listener: _resource_record_post_action 05:15:48 INFO - ##### 05:15:48 INFO - ##### Running read-buildbot-config step. 05:15:48 INFO - ##### 05:15:48 INFO - Running pre-action listener: _resource_record_pre_action 05:15:48 INFO - Running main action method: read_buildbot_config 05:15:48 INFO - Using buildbot properties: 05:15:48 INFO - { 05:15:48 INFO - "project": "", 05:15:48 INFO - "product": "firefox", 05:15:48 INFO - "script_repo_revision": "production", 05:15:48 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 05:15:48 INFO - "repository": "", 05:15:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 05:15:48 INFO - "buildid": "20160324024342", 05:15:48 INFO - "pgo_build": "True", 05:15:48 INFO - "basedir": "/builds/slave/test-pgo", 05:15:48 INFO - "buildnumber": 1621, 05:15:48 INFO - "slavename": "talos-linux64-ix-033", 05:15:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:48 INFO - "platform": "ubuntu64_hw", 05:15:48 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 05:15:48 INFO - "branch": "mozilla-inbound", 05:15:48 INFO - "repo_path": "integration/mozilla-inbound", 05:15:48 INFO - "revision": "3d3834cc0e36", 05:15:48 INFO - "stage_platform": "linux64-pgo", 05:15:48 INFO - "builduid": "6491b3bfbba64b6e853ad02b7abb58a2", 05:15:48 INFO - "slavebuilddir": "test" 05:15:48 INFO - } 05:15:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:15:48 INFO - Running post-action listener: _resource_record_post_action 05:15:48 INFO - ##### 05:15:48 INFO - ##### Running download-and-extract step. 05:15:48 INFO - ##### 05:15:48 INFO - Running pre-action listener: _resource_record_pre_action 05:15:48 INFO - Running main action method: download_and_extract 05:15:48 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:15: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')]} 05:15:48 INFO - https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:15:58 INFO - Downloaded 1361 bytes. 05:15:58 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:15:58 INFO - Using the following test package requirements: 05:15:58 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:15:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:15:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'jsshell-linux-x86_64.zip'], 05:15:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:15:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:15:58 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:15:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:15:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:15:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:58 INFO - https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:16 INFO - Downloaded 23636288 bytes. 05:16:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:16:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:16:17 INFO - Return code: 0 05:16:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:17 INFO - https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:24 INFO - Downloaded 23636288 bytes. 05:16:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:16:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:16:25 INFO - Return code: 0 05:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:25 INFO - https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:16:28 INFO - Downloaded 10846780 bytes. 05:16:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:16:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:16:29 INFO - Return code: 0 05:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:29 INFO - https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:16:42 INFO - Downloaded 57830055 bytes. 05:16:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:42 INFO - mkdir: /builds/slave/test-pgo/properties 05:16:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:16:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:16:42 INFO - Contents: 05:16:42 INFO - build_url:https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:43 INFO - Running post-action listener: _resource_record_post_action 05:16:43 INFO - Running post-action listener: set_extra_try_arguments 05:16:43 INFO - ##### 05:16:43 INFO - ##### Running populate-webroot step. 05:16:43 INFO - ##### 05:16:43 INFO - Running pre-action listener: _resource_record_pre_action 05:16:43 INFO - Running main action method: populate_webroot 05:16:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:43 INFO - '--tppagecycles', 05:16:43 INFO - '7'], 05:16:43 INFO - 'tests': ['tsvgm']}}, 05:16:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:16:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'tests': ['damp', 'tps']}, 05:16:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['damp', 'tps']}, 05:16:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:43 INFO - 'other': {'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other_l64': {'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'svgr': {'tests': ['tsvgx', 05:16:43 INFO - 'tsvgr_opacity', 05:16:43 INFO - 'tart', 05:16:43 INFO - 'tscrollx', 05:16:43 INFO - 'cart']}, 05:16:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tsvgx', 05:16:43 INFO - 'tsvgr_opacity', 05:16:43 INFO - 'tart', 05:16:43 INFO - 'tscrollx', 05:16:43 INFO - 'cart']}, 05:16:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'tests': ['tp5o']}, 05:16:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tp5o']}, 05:16:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--xperf_path', 05:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:43 INFO - 'tests': ['tp5n']}, 05:16:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s', 05:16:43 INFO - '--xperf_path', 05:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:43 INFO - 'tests': ['tp5n']}}, 05:16:43 INFO - 'talos.zip': {'path': '', 05:16:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:43 INFO - Running post-action listener: _resource_record_post_action 05:16:43 INFO - ##### 05:16:43 INFO - ##### Running create-virtualenv step. 05:16:43 INFO - ##### 05:16:43 INFO - Running pre-action listener: _resource_record_pre_action 05:16:43 INFO - Running main action method: create_virtualenv 05:16:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:16:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:16:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:16:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:43 INFO - Using real prefix '/usr' 05:16:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:16:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:46 INFO - Installing pip.................done. 05:16:46 INFO - Return code: 0 05:16:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:46 INFO - Using env: {'DISPLAY': ':0', 05:16:46 INFO - 'HOME': '/home/cltbld', 05:16:46 INFO - 'LANG': 'en_US.UTF-8', 05:16:46 INFO - 'LANGUAGE': 'en_US:en', 05:16:46 INFO - 'LOGNAME': 'cltbld', 05:16:46 INFO - 'MAIL': '/var/mail/cltbld', 05:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:46 INFO - 'MOZ_NO_REMOTE': '1', 05:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:46 INFO - 'NO_EM_RESTART': '1', 05:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:16:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:16:46 INFO - 'SHELL': '/bin/bash', 05:16:46 INFO - 'SHLVL': '1', 05:16:46 INFO - 'TERM': 'linux', 05:16:46 INFO - 'TMOUT': '86400', 05:16:46 INFO - 'USER': 'cltbld', 05:16:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:46 INFO - '_': '/tools/buildbot/bin/python'} 05:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:46 INFO - Cleaning up... 05:16:46 INFO - Return code: 0 05:16:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:16:46 INFO - Using env: {'DISPLAY': ':0', 05:16:46 INFO - 'HOME': '/home/cltbld', 05:16:46 INFO - 'LANG': 'en_US.UTF-8', 05:16:46 INFO - 'LANGUAGE': 'en_US:en', 05:16:46 INFO - 'LOGNAME': 'cltbld', 05:16:46 INFO - 'MAIL': '/var/mail/cltbld', 05:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:46 INFO - 'MOZ_NO_REMOTE': '1', 05:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:46 INFO - 'NO_EM_RESTART': '1', 05:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:16:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:16:46 INFO - 'SHELL': '/bin/bash', 05:16:46 INFO - 'SHLVL': '1', 05:16:46 INFO - 'TERM': 'linux', 05:16:46 INFO - 'TMOUT': '86400', 05:16:46 INFO - 'USER': 'cltbld', 05:16:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:46 INFO - '_': '/tools/buildbot/bin/python'} 05:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:46 INFO - Downloading/unpacking psutil>=0.7.1 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:49 INFO - Installing collected packages: psutil 05:16:49 INFO - Running setup.py install for psutil 05:16:49 INFO - building 'psutil._psutil_linux' extension 05:16:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:16:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:16:49 INFO - building 'psutil._psutil_posix' extension 05:16:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:16:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:50 INFO - Successfully installed psutil 05:16:50 INFO - Cleaning up... 05:16:50 INFO - Return code: 0 05:16:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:16: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')]} 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', '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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:16: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 mozsystemmonitor==0.0.0 05:16:50 INFO - Using env: {'DISPLAY': ':0', 05:16:50 INFO - 'HOME': '/home/cltbld', 05:16:50 INFO - 'LANG': 'en_US.UTF-8', 05:16:50 INFO - 'LANGUAGE': 'en_US:en', 05:16:50 INFO - 'LOGNAME': 'cltbld', 05:16:50 INFO - 'MAIL': '/var/mail/cltbld', 05:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:50 INFO - 'MOZ_NO_REMOTE': '1', 05:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:50 INFO - 'NO_EM_RESTART': '1', 05:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:16:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:16:50 INFO - 'SHELL': '/bin/bash', 05:16:50 INFO - 'SHLVL': '1', 05:16:50 INFO - 'TERM': 'linux', 05:16:50 INFO - 'TMOUT': '86400', 05:16:50 INFO - 'USER': 'cltbld', 05:16:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:50 INFO - '_': '/tools/buildbot/bin/python'} 05:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:53 INFO - Installing collected packages: mozsystemmonitor 05:16:53 INFO - Running setup.py install for mozsystemmonitor 05:16:53 INFO - Successfully installed mozsystemmonitor 05:16:53 INFO - Cleaning up... 05:16:53 INFO - Return code: 0 05:16:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:16:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:53 INFO - Using env: {'DISPLAY': ':0', 05:16:53 INFO - 'HOME': '/home/cltbld', 05:16:53 INFO - 'LANG': 'en_US.UTF-8', 05:16:53 INFO - 'LANGUAGE': 'en_US:en', 05:16:53 INFO - 'LOGNAME': 'cltbld', 05:16:53 INFO - 'MAIL': '/var/mail/cltbld', 05:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:53 INFO - 'MOZ_NO_REMOTE': '1', 05:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:53 INFO - 'NO_EM_RESTART': '1', 05:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:16:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:16:53 INFO - 'SHELL': '/bin/bash', 05:16:53 INFO - 'SHLVL': '1', 05:16:53 INFO - 'TERM': 'linux', 05:16:53 INFO - 'TMOUT': '86400', 05:16:53 INFO - 'USER': 'cltbld', 05:16:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:53 INFO - '_': '/tools/buildbot/bin/python'} 05:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:57 INFO - Downloading docopt-0.6.1.tar.gz 05:16:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:57 INFO - Running setup.py install for blobuploader 05:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:16:57 INFO - Running setup.py install for requests 05:16:58 INFO - Running setup.py install for docopt 05:16:58 INFO - Successfully installed blobuploader requests docopt 05:16:58 INFO - Cleaning up... 05:16:58 INFO - Return code: 0 05:16:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:16:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:16:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:58 INFO - Using env: {'DISPLAY': ':0', 05:16:58 INFO - 'HOME': '/home/cltbld', 05:16:58 INFO - 'LANG': 'en_US.UTF-8', 05:16:58 INFO - 'LANGUAGE': 'en_US:en', 05:16:58 INFO - 'LOGNAME': 'cltbld', 05:16:58 INFO - 'MAIL': '/var/mail/cltbld', 05:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:58 INFO - 'MOZ_NO_REMOTE': '1', 05:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:58 INFO - 'NO_EM_RESTART': '1', 05:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:16:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:16:58 INFO - 'SHELL': '/bin/bash', 05:16:58 INFO - 'SHLVL': '1', 05:16:58 INFO - 'TERM': 'linux', 05:16:58 INFO - 'TMOUT': '86400', 05:16:58 INFO - 'USER': 'cltbld', 05:16:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:58 INFO - '_': '/tools/buildbot/bin/python'} 05:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:16:58 INFO - Running setup.py (path:/tmp/pip-wScikw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:16:58 INFO - Running setup.py (path:/tmp/pip-oqDPOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:16:58 INFO - Running setup.py (path:/tmp/pip-45nVcD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:16:58 INFO - Running setup.py (path:/tmp/pip-PsXR4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:16:59 INFO - Running setup.py (path:/tmp/pip-rZzaAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:16:59 INFO - Running setup.py (path:/tmp/pip-bQlaLc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:16:59 INFO - Running setup.py (path:/tmp/pip-M0uWiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:16:59 INFO - Running setup.py (path:/tmp/pip-aAiNBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:16:59 INFO - Running setup.py (path:/tmp/pip-FleC1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:16:59 INFO - Running setup.py (path:/tmp/pip-GR7yXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:16:59 INFO - Running setup.py (path:/tmp/pip-Pvr_tM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:16:59 INFO - Running setup.py (path:/tmp/pip-MhIMFQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:16:59 INFO - Running setup.py (path:/tmp/pip-b6M18G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:16:59 INFO - Running setup.py (path:/tmp/pip-CYM8Qh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:16:59 INFO - Running setup.py (path:/tmp/pip-o5Uq3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:16:59 INFO - Running setup.py (path:/tmp/pip-DDDsCJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:16:59 INFO - Running setup.py (path:/tmp/pip-NaWrFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:59 INFO - Running setup.py install for manifestparser 05:17:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Running setup.py install for mozcrash 05:17:00 INFO - Running setup.py install for mozdebug 05:17:00 INFO - Running setup.py install for mozdevice 05:17:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Running setup.py install for mozfile 05:17:00 INFO - Running setup.py install for mozhttpd 05:17:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Running setup.py install for mozinfo 05:17:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Running setup.py install for mozInstall 05:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Running setup.py install for mozleak 05:17:00 INFO - Running setup.py install for mozlog 05:17:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:17:00 INFO - Running setup.py install for moznetwork 05:17:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:17:01 INFO - Running setup.py install for mozprocess 05:17:01 INFO - Running setup.py install for mozprofile 05:17:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:17:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:17:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:17:01 INFO - Running setup.py install for mozrunner 05:17:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:17:01 INFO - Running setup.py install for mozscreenshot 05:17:01 INFO - Running setup.py install for moztest 05:17:01 INFO - Running setup.py install for mozversion 05:17:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:01 INFO - Cleaning up... 05:17:01 INFO - Return code: 0 05:17:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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/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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:17:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:01 INFO - Using env: {'DISPLAY': ':0', 05:17:01 INFO - 'HOME': '/home/cltbld', 05:17:01 INFO - 'LANG': 'en_US.UTF-8', 05:17:01 INFO - 'LANGUAGE': 'en_US:en', 05:17:01 INFO - 'LOGNAME': 'cltbld', 05:17:01 INFO - 'MAIL': '/var/mail/cltbld', 05:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:01 INFO - 'MOZ_NO_REMOTE': '1', 05:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:01 INFO - 'NO_EM_RESTART': '1', 05:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:01 INFO - 'SHELL': '/bin/bash', 05:17:01 INFO - 'SHLVL': '1', 05:17:01 INFO - 'TERM': 'linux', 05:17:01 INFO - 'TMOUT': '86400', 05:17:01 INFO - 'USER': 'cltbld', 05:17:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:01 INFO - '_': '/tools/buildbot/bin/python'} 05:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:17:02 INFO - Running setup.py (path:/tmp/pip-UXtAqz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:17:02 INFO - Running setup.py (path:/tmp/pip-5Qcj9t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:17:02 INFO - Running setup.py (path:/tmp/pip-n_cO4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:17:02 INFO - Running setup.py (path:/tmp/pip-YFEMef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:17:02 INFO - Running setup.py (path:/tmp/pip-Z7lgT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:17:02 INFO - Running setup.py (path:/tmp/pip-qqIQcB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:17:02 INFO - Running setup.py (path:/tmp/pip-2xae4h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:17:02 INFO - Running setup.py (path:/tmp/pip-ekQ_jL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:17:02 INFO - Running setup.py (path:/tmp/pip-YdoSTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:17:02 INFO - Running setup.py (path:/tmp/pip-NMOC9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:17:02 INFO - Running setup.py (path:/tmp/pip-KnLLpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:17:02 INFO - Running setup.py (path:/tmp/pip-d1dIjX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:17:02 INFO - Running setup.py (path:/tmp/pip-ApE0kK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:17:03 INFO - Running setup.py (path:/tmp/pip-ljwK_7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:17:03 INFO - Running setup.py (path:/tmp/pip-fYZkmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:17:03 INFO - Running setup.py (path:/tmp/pip-BEyrym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:17:03 INFO - Running setup.py (path:/tmp/pip-Uz0M4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:05 INFO - Downloading blessings-1.6.tar.gz 05:17:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:05 INFO - Installing collected packages: blessings 05:17:05 INFO - Running setup.py install for blessings 05:17:05 INFO - Successfully installed blessings 05:17:05 INFO - Cleaning up... 05:17:05 INFO - Return code: 0 05:17:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:17:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:17:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:17:06 INFO - Reading from file tmpfile_stdout 05:17:06 INFO - Current package versions: 05:17:06 INFO - argparse == 1.2.1 05:17:06 INFO - blessings == 1.6 05:17:06 INFO - blobuploader == 1.2.4 05:17:06 INFO - docopt == 0.6.1 05:17:06 INFO - manifestparser == 1.1 05:17:06 INFO - mozInstall == 1.12 05:17:06 INFO - mozcrash == 0.17 05:17:06 INFO - mozdebug == 0.1 05:17:06 INFO - mozdevice == 0.48 05:17:06 INFO - mozfile == 1.2 05:17:06 INFO - mozhttpd == 0.7 05:17:06 INFO - mozinfo == 0.9 05:17:06 INFO - mozleak == 0.1 05:17:06 INFO - mozlog == 3.1 05:17:06 INFO - moznetwork == 0.27 05:17:06 INFO - mozprocess == 0.22 05:17:06 INFO - mozprofile == 0.28 05:17:06 INFO - mozrunner == 6.11 05:17:06 INFO - mozscreenshot == 0.1 05:17:06 INFO - mozsystemmonitor == 0.0 05:17:06 INFO - moztest == 0.7 05:17:06 INFO - mozversion == 1.4 05:17:06 INFO - psutil == 3.1.1 05:17:06 INFO - requests == 1.2.3 05:17:06 INFO - wsgiref == 0.1.2 05:17:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:06 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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:17:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:06 INFO - Using env: {'DISPLAY': ':0', 05:17:06 INFO - 'HOME': '/home/cltbld', 05:17:06 INFO - 'LANG': 'en_US.UTF-8', 05:17:06 INFO - 'LANGUAGE': 'en_US:en', 05:17:06 INFO - 'LOGNAME': 'cltbld', 05:17:06 INFO - 'MAIL': '/var/mail/cltbld', 05:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:06 INFO - 'MOZ_NO_REMOTE': '1', 05:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:06 INFO - 'NO_EM_RESTART': '1', 05:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:06 INFO - 'SHELL': '/bin/bash', 05:17:06 INFO - 'SHLVL': '1', 05:17:06 INFO - 'TERM': 'linux', 05:17:06 INFO - 'TMOUT': '86400', 05:17:06 INFO - 'USER': 'cltbld', 05:17:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:06 INFO - '_': '/tools/buildbot/bin/python'} 05:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:17:06 INFO - Cleaning up... 05:17:06 INFO - Return code: 0 05:17:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:06 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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:17:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:06 INFO - Using env: {'DISPLAY': ':0', 05:17:06 INFO - 'HOME': '/home/cltbld', 05:17:06 INFO - 'LANG': 'en_US.UTF-8', 05:17:06 INFO - 'LANGUAGE': 'en_US:en', 05:17:06 INFO - 'LOGNAME': 'cltbld', 05:17:06 INFO - 'MAIL': '/var/mail/cltbld', 05:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:06 INFO - 'MOZ_NO_REMOTE': '1', 05:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:06 INFO - 'NO_EM_RESTART': '1', 05:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:06 INFO - 'SHELL': '/bin/bash', 05:17:06 INFO - 'SHLVL': '1', 05:17:06 INFO - 'TERM': 'linux', 05:17:06 INFO - 'TMOUT': '86400', 05:17:06 INFO - 'USER': 'cltbld', 05:17:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:06 INFO - '_': '/tools/buildbot/bin/python'} 05:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:06 INFO - Downloading/unpacking jsonschema 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:08 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:09 INFO - warning: no files found matching '*.txt' 05:17:09 INFO - no previously-included directories found matching 'build' 05:17:09 INFO - no previously-included directories found matching 'dist' 05:17:09 INFO - no previously-included directories found matching '.git*' 05:17:09 INFO - Installing collected packages: jsonschema, functools32 05:17:09 INFO - Running setup.py install for functools32 05:17:09 INFO - warning: no files found matching '*.txt' 05:17:09 INFO - no previously-included directories found matching 'build' 05:17:09 INFO - no previously-included directories found matching 'dist' 05:17:09 INFO - no previously-included directories found matching '.git*' 05:17:09 INFO - Successfully installed jsonschema functools32 05:17:09 INFO - Cleaning up... 05:17:09 INFO - Return code: 0 05:17:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 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 0x7f5d7e1b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:17:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:17:09 INFO - Using env: {'DISPLAY': ':0', 05:17:09 INFO - 'HOME': '/home/cltbld', 05:17:09 INFO - 'LANG': 'en_US.UTF-8', 05:17:09 INFO - 'LANGUAGE': 'en_US:en', 05:17:09 INFO - 'LOGNAME': 'cltbld', 05:17:09 INFO - 'MAIL': '/var/mail/cltbld', 05:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:09 INFO - 'MOZ_NO_REMOTE': '1', 05:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:09 INFO - 'NO_EM_RESTART': '1', 05:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:09 INFO - 'SHELL': '/bin/bash', 05:17:09 INFO - 'SHLVL': '1', 05:17:09 INFO - 'TERM': 'linux', 05:17:09 INFO - 'TMOUT': '86400', 05:17:09 INFO - 'USER': 'cltbld', 05:17:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:09 INFO - '_': '/tools/buildbot/bin/python'} 05:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:09 INFO - Downloading/unpacking flake8 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:12 INFO - no previously-included directories found matching 'docs/_build' 05:17:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:12 INFO - Running setup.py install for pep8 05:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:12 INFO - no previously-included directories found matching 'docs/_build' 05:17:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:17:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Running post-action listener: _resource_record_post_action 05:17:12 INFO - Running post-action listener: _start_resource_monitoring 05:17:12 INFO - Starting resource monitoring. 05:17:12 INFO - ##### 05:17:12 INFO - ##### Running install step. 05:17:12 INFO - ##### 05:17:12 INFO - Running pre-action listener: _resource_record_pre_action 05:17:12 INFO - Running main action method: install 05:17:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Output received: 05:17:12 INFO - Usage: mozinstall [options] installer 05:17:12 INFO - Options: 05:17:12 INFO - -h, --help show this help message and exit 05:17:12 INFO - -d DEST, --destination=DEST 05:17:12 INFO - Directory to install application into. [default: 05:17:12 INFO - "/builds/slave/test-pgo"] 05:17:12 INFO - --app=APP Application being installed. [default: firefox] 05:17:12 INFO - mkdir: /builds/slave/test-pgo/build/application 05:17:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:17:29 INFO - Reading from file tmpfile_stdout 05:17:29 INFO - Output received: 05:17:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:17:29 INFO - Running post-action listener: _resource_record_post_action 05:17:29 INFO - ##### 05:17:29 INFO - ##### Running run-tests step. 05:17:29 INFO - ##### 05:17:29 INFO - Running pre-action listener: _resource_record_pre_action 05:17:29 INFO - Running main action method: run_tests 05:17:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:17:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:17:29 INFO - Python 2.7.3 05:17:29 INFO - Return code: 0 05:17:29 INFO - grabbing minidump binary from tooltool 05:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:29 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 0x19668b0>, '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 0x19677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:17:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:17:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:17:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:29 INFO - Return code: 0 05:17:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:17:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:17:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:17:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:17:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:17:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:17:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:17:30 INFO - Return code: 0 05:17:30 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/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 05:17:30 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/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 05:17:30 INFO - Using env: {'DISPLAY': ':0', 05:17:30 INFO - 'HOME': '/home/cltbld', 05:17:30 INFO - 'LANG': 'en_US.UTF-8', 05:17:30 INFO - 'LANGUAGE': 'en_US:en', 05:17:30 INFO - 'LOGNAME': 'cltbld', 05:17:30 INFO - 'MAIL': '/var/mail/cltbld', 05:17:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:17:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:30 INFO - 'MOZ_NO_REMOTE': '1', 05:17:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:30 INFO - 'NO_EM_RESTART': '1', 05:17:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:17:30 INFO - 'SHELL': '/bin/bash', 05:17:30 INFO - 'SHLVL': '1', 05:17:30 INFO - 'TERM': 'linux', 05:17:30 INFO - 'TMOUT': '86400', 05:17:30 INFO - 'USER': 'cltbld', 05:17:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313', 05:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:30 INFO - '_': '/tools/buildbot/bin/python'} 05:17:30 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/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 05:17:30 INFO - mozversion application_buildid: 20160324024342 05:17:30 INFO - mozversion application_changeset: 3d3834cc0e364737f56ba4f8c575d25c48800f2c 05:17:30 INFO - mozversion application_display_name: Nightly 05:17:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:30 INFO - mozversion application_name: Firefox 05:17:30 INFO - mozversion application_remotingname: firefox 05:17:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:17:30 INFO - mozversion application_vendor: Mozilla 05:17:30 INFO - mozversion application_version: 48.0a1 05:17:30 INFO - mozversion platform_buildid: 20160324024342 05:17:30 INFO - mozversion platform_changeset: 3d3834cc0e364737f56ba4f8c575d25c48800f2c 05:17:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:17:30 INFO - mozversion platform_version: 48.0a1 05:17:30 INFO - using testdate: 1458821850 05:17:30 INFO - actual date: 1458821850 05:17:30 INFO - starting webserver on 'localhost:46333' 05:17:30 INFO - SUITE-START | Running 2 tests 05:17:30 INFO - TEST-START | dromaeo_css 05:17:30 INFO - operating with platform_type : linux_ 05:17:30 INFO - Initialising browser for dromaeo_css test... 05:17:30 INFO - TEST-INFO | started process 12726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaDoB2R/profile http://localhost:46333/getInfo.html) 05:17:35 INFO - PROCESS | 12726 | __metrics Screen width/height:1600/1200 05:17:35 INFO - PROCESS | 12726 | colorDepth:24 05:17:35 INFO - PROCESS | 12726 | Browser inner width/height: 1024/697 05:17:35 INFO - PROCESS | 12726 | __metrics 05:17:36 ERROR - PROCESS | 12726 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:37 INFO - TEST-INFO | 12726: exit 0 05:17:37 INFO - Browser initialized. 05:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:37 INFO - TEST-INFO | started process 12823 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaDoB2R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:49 INFO - PROCESS | 12823 | RSS: Main: 152907776 05:17:49 INFO - PROCESS | 12823 | 05:18:40 INFO - PROCESS | 12823 | 1458821920290 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:20:48 INFO - PROCESS | 12823 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46333/tests/dromaeo/cssquery-ext.html) 05:20:49 INFO - PROCESS | 12823 | RSS: Main: 250499072 05:20:49 INFO - PROCESS | 12823 | 05:23:51 INFO - PROCESS | 12823 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-ext.html (next: http://localhost:46333/tests/dromaeo/cssquery-jquery.html) 05:23:51 INFO - PROCESS | 12823 | RSS: Main: 235712512 05:23:51 INFO - PROCESS | 12823 | 05:26:53 INFO - PROCESS | 12823 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46333/tests/dromaeo/cssquery-mootools.html) 05:26:54 INFO - PROCESS | 12823 | RSS: Main: 225435648 05:26:54 INFO - PROCESS | 12823 | 05:29:56 INFO - PROCESS | 12823 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46333/tests/dromaeo/cssquery-prototype.html) 05:29:56 INFO - PROCESS | 12823 | RSS: Main: 212455424 05:29:56 INFO - PROCESS | 12823 | 05:32:59 INFO - PROCESS | 12823 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46333/tests/dromaeo/cssquery-yui.html) 05:32:59 INFO - PROCESS | 12823 | RSS: Main: 221564928 05:32:59 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-yui.html (next: http://localhost:46333/tests/dromaeo/cssquery-dojo.html) 05:36:02 INFO - PROCESS | 12823 | RSS: Main: 264691712 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | __start_tp_report 05:36:02 INFO - PROCESS | 12823 | _x_x_mozilla_page_load 05:36:02 INFO - PROCESS | 12823 | _x_x_mozilla_page_load_details 05:36:02 INFO - PROCESS | 12823 | |i|pagename|runs| 05:36:02 INFO - PROCESS | 12823 | |0;dojo.html;2962.392709494553;3032.711892370227;3068;3073.8616762245683;3099.225193701574;5125.794968201277;5128.102582048141;5173.870653233671;5179.093658609747;5204.271402003723;5171.948280517194;5188.766505507252;5209.687418754868;5283.313169287997;5320.813771517997;4709.858704238878;4717.504662010482;4762.809487620491;4764.857054288377;4963.1810751226185;4887.120318342697;4896.657233993622;4921.581665558414;4930.630202734809;4931.038447502739;4722.244440889458;4747.833825816115;4825.806967721287;4856.15017371962;4876.171050921352;4788.545088216614;4808.35087263222;4809.422869255712;4811.422629284473;4842.2736589511505;4734.526547345273;4773.236282194832;4783.449903261135;4785.353977213066;4791.161546729343;5040.621953353513;5146.794128234867;5201.141811601081;5220.947790522122;5229.2417599448245;5533.391326954032;5546.805861794818;5561.5272701820395;5562.137868630369;5565.193047008162;5425.6202065855405;5525.4474552544425;5531.2809334786625;5532.723363831792;5534.557235421156;5185.196294574347;5216.347956505437;5224.085784987612;5265.815696450606;5279.049771041211;5658.91511627326;5661.405552417019;5668.57485688575;5668.914966275509;5711.771529138871;5225.608079394061;5387.057264978613;5442.428545002796;5451.972740136353;5460.91808622863;5483.75323110461;5518.889622207534;5537.307836520435;5540.612157149041;5573.749181286852;5492.642978206404;5504.669719816744;5507.256520369779;5507.834764957058;5516.724163791794;5420.430854760272;5483.396826349099;5509.559235261169;5539.362973258047;5571.721413929368;4230.915381692349;4235.851745188966;4241.87274381769;4271.978640106841;4273.508546517191;3775.112848480605;3793.8292776824555;3801.334766415866;3821.063839359319;3832.137769001952;5192.428832828386;5206.349206349207;5244.895102097937;5251.186066159751;5285.867853303621;5586.91619625706;5593.049181639131;5607.046802043662;5623.10030395143;5623.212750214973;5276.445973172838;5277.656952298088;5308.734563271821;5310.522053015247;5359.410464848864;4635.3278774578175;4774.641901857374;4805.9759701201965;4815.494373090845;4843.297721830385;5635.098384258499;5680.488756011979;5683.772649094072;5695.7152142392715;5698;5472.835814925558;5478.506934375925;5498.505134537831;5499.532539734168;5543.8891222174525;5763.3084029915;5764.164196191613;5773.3072031356505;5812;5829.854253643693;5302.231176479466;5303.549198318186;5305.098133317269;5331.067063263836;5349.57203423733;5377.8117765878005;5384.353877534721;5399;5425.213344065168;5497.670139791625;5440.129579267298;5443.210734443563;5452.345718513804;5464.644798088111;5492.038893193595;5399.460053994726;5403.648762830403;5404.918926216032;5405.081136206775;5459.535939445192;5232.450592687713;5280.577553795611;5322.893542129058;5324.520793128637;5363.490468405651;5376.301080859464;5396.757145928521;5410.97294513525;5412.945870541244;5413.485718856702;5278.445763194809;5297.205419187153;5297.841064768063;5302.443243459381;5305.230741542532 05:36:02 INFO - PROCESS | 12823 | |1;ext.html;547.3049227481099;550.545799715235;552.3289203617605;569.8945695046417;591.3258884871245;28967.855160724193;38618.806905965466;39006;39093.804530977344;39134;40642.59357406425;40979;41138.79430602843;41140;41153.79423102888;7422;8515.872261916093;8708.042115367305;8708.651653933866;8708.869366959469;10226.284160108795;10395.896041039607;10457.790844183111;10462.110720588758;10466.4766761662;10245.28283020189;10328.380297182155;10368.326058806191;10370.844437333408;10378;10155.89844101557;10235.539400726948;10257.794844103151;10259.487025648725;10264.486775661187;10086.546105425201;10201.285909986304;10219.795604087876;10225.897741022569;10229;41086.58913410857;41553.37669934954;41652.37521437181;41664.58335416668;41678.79160604178;3410.38613049651;3539.415996360623;3621.692156166729;3913.5303763548554;3997.540282867449;30746.846265768752;31315;31356.21609459759;31479.213019674462;31737.84131079353;4242;4245.745255284693;4271.786410679485;4315.244832154361;4351.129774045172;321178;321320;321753;322127;322722.3863880689;44081.77959110184;58260;58964.41035589589;59054;59060;43897;43915.78042109769;44020.37786032484;44101.33847992283;44153;12755.170913890568;12788.488460461478;12797.168184068007;12801.29592872401;12858.807117893239;9773.755656108511;9921;9921;9955.552000159865;9981.201503879673;14539.27303634814;14622.780658290134;15040.849591503946;15045.699086018438;15204.087754734752;5732.6847023413275;5818.709064546756;5853.7365818538265;5989.31122920861;6022.759089636365;1066.983995240072;1071.6838532632892;1118.4072441605963;1142.994285028586;1153.3368313219933;30066.69933300683;30635;30673.233169170948;30883.69116308853;30927.226819329248;1162.3607016141088;1173.501261963662;1175.2243519277406;1189.7025743564109;1240.466599362283;15628.374865005273;15945.760813587573;16017.919910400606;16193;16262.18689065542;386091;390782;391239;391670;392426;52333.7383313081;52866.207006894925;52915.47084529183;52973.205401919;53067.734661326445;1228.7235372041398;1320.9075364724376;1344.9798253026213;1366.5763613279914;1369.8287714035746;27271;28008.71991280061;29481.32852518552;29726.405471890874;29780;44418.77790611026;44801.10397792091;44834.327485087095;44860.102797943204;44864.77567612141;261835;263310;263472;263578;264071;29314.70685293205;33543;33557.16107097342;33658;33806.830965846;38764.22471550497;39077.80461097676;39200.411993820686;40095.79952100338;40180;34163.31673366469;34338.48492272668;34463.827680862436;34473.31053378868;34560.308793824486;35759.46360804642;35780.4632930501;35879;36337.454938176474;36528.634713653584;33704.83147584246;33837.3232535343;35002.474962875065;37288.254234915694;37550.86940436604;31712.207194820316;33142.337153257286;33210.33579328351;33326.83414573178;33327.33345333031;25626;25926;26134.607980880683;26238.212853614423;26520.204393868215 05:36:02 INFO - PROCESS | 12823 | |2;jquery.html;348.51705991008265;351.05741085186276;355.68042562094627;356.306982918224;360.38374379810523;17613;17704.734428983575;19052.523686907833;19063.90468047661;19077.332293369735;17721;18620.255189792428;18625.348112816053;18760.24959001638;18865.811341886576;5459.235707001023;5691.288588926384;5729.570282228829;5731.226284451608;5732.2548068751;4059.330210515276;5623.9437605623825;6041.214642096521;6270.7178176981915;6301.6849157542165;6215.223097112861;6236.469900058501;6259.593126446766;6267.498600112003;6273.905891411609;5917.852053698649;6178.783742569011;6182.783602573933;6183.96908015457;6193.7832175873855;3706.9258614827822;5168;5379.031774280628;5383.084875571162;5449.863753406157;20156.49608759778;20250.392488225378;20298.18807247708;20466.488337791525;20472.897635511876;2217.2350539063996;2429.878506074689;2543.7201907790127;2788.9262633885896;3048.17699221209;13232.735345293137;13514.189148651112;13544.119632223874;13713.520026799113;13878.306084695825;1855.276442187548;1860.4604664647236;1913.2920819296949;1987.3044434447827;1988.30409356724;67055;68019.00166637631;68346;68488;69014.65492672555;9269.490178040138;9699.466529340954;9784.853227201598;9922.40465572068;9982.402815549478;13619.114757540729;13748.312584370742;13872;13880.4447822088;13886.930565347311;6991.3358230969;7107.715691372287;7123.43012558994;7137.500374973702;7218.927810721825;6745.696443659949;6772.255051944282;6834.931650683429;6879.793606191823;6918.827029324207;5948.672822994777;6057.182280392179;6073.240844894388;6076.118962750465;6153.246324797501;1660.6346603747156;1701.6936951348628;1720.423658074534;1723.1125970125395;1778.9466316010542;1030.2324768047702;1032.808930347888;1086.0225796782959;1094.9069329106956;1128.2215271462665;17971.281148754166;18450.446486605422;18606.906965465085;18659.626807463774;19085;1014.6803756816579;1034.9327293725885;1039.8284283093205;1082.3614067700096;1085.777415629794;10698.62554810578;10945.631796025496;10963.50664220112;10965.61620343284;11106.500207490682;480829;489436;501029;506110;506220;67255.66372168205;71682.2831771686;71919;72966;73069;1061.9150467962545;1064.7657515346611;1075.4837677914488;1080.400377790318;1090.432974853072;16343.673126537165;16345.918270408572;16409;16443.506694799176;16848.57878553046;22881.88559057194;33344.49983250205;34372.31255374929;34795.478067828495;35281.647183527835;46741.76629116833;46801.297980531;46986.530134698216;47263;47277.52722472731;7949.125596184531;8087.595620219083;8272.04871439792;8367.456115352483;8419.873701894354;12286.385680716106;12365.629031129081;12396.318202498589;12455.626331210078;12466.875331246934;10720.839187412352;11435.714107147387;11577.247478913843;11731.88268117308;11804.3507607079;10749.838752418877;11018.889811102106;11274.267172633752;11275.830862537232;11357.602483913024;11190.66428007161;11789.351585662871;11868.347240901834;11968.102392320785;12018.939905300767;7794.766157015299;7863.764087077397;8212.589370531568;8289.95855020721;8356.916430835858;10886.38630937906;10967.50646220906;11040.33757974524;11247.88752112501;11429.085673146295 05:36:02 INFO - PROCESS | 12823 | |3;mootools.html;1314.1129737427234;1420.3821337718093;1466.1423067505511;1561.5393458929614;1727.2745446912295;7339.963300183498;7485.663145158467;7571.280728330807;7609.315161635452;7610.16288208298;7359.227281135484;7495.36289415399;7502.849943001137;7506.136794268661;7517.398608111352;1977.377126205248;2250.3586477853814;2254.3349711834967;2290.816734661223;2321.698179236697;2319.257837492003;2320.628699408095;2325.7209134903837;2331.8367714260007;2333.2533589251448;2268.0587556164173;2325.3953971967326;2328.080408238745;2329.4060014696315;2329.697139371879;2256.3343813575034;2313.9190128345513;2315.0392587076344;2316.3630001749484;2318.07277089164;2304.6312589985523;2308.5036717105904;2309.203324852923;2319.9188028419094;2342.02805835578;7790.298873101448;7830.530168189927;7833.255840695125;7851.254130857559;7860.68557257709;4811.879703007417;4928.26076088586;4928.654994150411;4941.184704523749;4946;3294.8352582370785;3381.1378098584705;3407.71034462071;3449.189440481485;3477.4783782432582;1104.7017305327518;1130.5703832543581;1131.332513816852;1148.827675848621;1153.9711507212303;10610.946945265225;10750.462476876124;10758.139348852073;10762.73093172677;10796.2442629016;4303.139372125587;4328.220920234325;4373.737575745466;4407.360932664746;4414.940414300545;8967.551622418983;8971.102889710977;8973.057828927998;8997.64009439615;9017.458952462874;4330.35044743291;4933.260010998307;4953.2570114483115;4982.501749824988;4986.650934434628;3964.28642844285;4006.9198616027516;4011.3180759270995;4401.185780630593;4547.1587756264535;3666.7433279670167;3722.8883133506038;3759.1353988582778;3770.472133901256;3774.226283611908;1194.2535915053093;1204.4519743516853;1215.4166000319897;1219.0613227814533;1240.1876770715196;1285.2288626823831;1318.7824009038593;1319.445832750228;1394.8953828462907;1399.5731301953;7148.39238664709;7344.375728063174;7367.705291788268;7371.299726525972;7452.21751716062;1139.6467095200514;1147.1396452660504;1166.6616681162538;1167.4746364136172;1170.4791367841228;5887.2052272943465;5894.852628684317;5919.289685237713;5938.673372964442;5975.282966044016;8795.208431241219;9212.124848139416;9235.307351948497;9307.76730581741;9434.198093162158;9316.369635313793;9472.336936414385;9481;9484.90515094854;9494.667686631074;7074;7201.639918004079;7248.166460856964;7276.781696549112;7391.33477986973;6843.315668433117;6866.244713081457;6870.27862074475;6886;6889.138857642794;8323.209295116954;8501.872471912802;8573.442726222776;8603.139686031596;8623.223909848144;8670.30637548982;8791.560421978747;8811.515366654896;8953.462792232487;8965.237954773916;6099.176611157614;6513.348665133449;6659.167604049494;6668.266490685924;6778.017187507882;7318.231585683639;7328.560286382834;7368.926310736824;7370.5946172961;7381.889271661037;6503.642299673564;6675.9666201670625;6692.263850976291;6819.147606549182;6844.041834143323;6479.838004049937;6580.605163690194;6615.768448104293;6639.468842492685;6677;6962.443004559522;6993.965030174817;7004.264552221944;7089.82275443118;7153.2131465537705;6303.275123360689;6356.046593011085;6371.044343348535;6417.679116044273;6425.357464253537;6420.743170273324;6441.5490915635455;6492.837679058061;6509.73961041572;6509.837254068497 05:36:02 INFO - PROCESS | 12823 | |4;prototype.html;325.3752794634302;332.48464879436875;334.0912717408648;336.2535171918342;340.4807668305835;6071.605345652535;6083.7262323195455;6112.633242005477;6119.510439164867;6132.325444201134;6066.272047354312;6067.7572897084065;6077.513798896089;6081.695915204233;6085.939140608592;4389.714668546534;4483.820647174109;4555.863324100283;4613.400257966459;4629.351890735291;4620.353150558924;4631.884202894921;4636.698614590057;4643.744594047326;4654.627629789608;4582.060677561109;4588.151192029469;4589.426321709786;4605.815767369301;4607.424071991001;4377.6935614507;4484.394606728115;4553.817847286105;4600.861974140747;4612.746298953556;4016.5380981187245;4028.4762980812307;4037.394390841368;4040.7575545467366;4043.3732771420478;5774.769009239625;5822.563307751935;5824.796132135355;5825.475707186331;5836.766529338822;5321.255024296602;5332.760025798849;5341.0653135701095;5344.091504444254;5348.5186333230195;6343.777967771152;6345.016522439029;6363.681815909186;6372.681365931685;6373.585716928431;4197.412362269285;4329.982454123278;4342;4348.5216626171095;4435.2238358287495;6626.304238054983;6692.765753198663;6698.531102822755;6706.859833828261;6709.865802683919;4403.163398954252;4408.801603927831;4430.867073987785;4441.444819397575;4451.132029254264;4494.0337827367275;4498.370228168059;4498.955010449919;4499.910001799945;4501.729896206238;5252.264682944391;5257.5005374489365;5259.579233661298;5261.289725887033;5267.473252674702;6232.688365581703;6454.4513716333695;6461.418472337512;6480.189976252968;6481.546291759626;1557.7196104701036;1568.647054412748;1576.0622429654338;1578.0925967568464;1583.3745670460103;963.3208587945621;1000.9599616015278;1011.4234886114991;1013.3615822032073;1017.2523195451338;6066.241719785027;6084.665343406155;6168.784092556739;6173.506119510518;6173.536984726164;6563.803085907431;6573.80278591643;6584.6378449184795;6593.3736295051895;6598.43913267368;6071.2714474263375;6073.362296958756;6074.362191969868;6075.787347442907;6079.908801367983;3510.9297814043575;3521.454174602941;3535.133892196377;3538.080099174233;3548.361294966931;6677.966610166918;6843.486738494633;6855;6855.794326170223;6860.0738900247825;6703.128593282842;6716.5634233774645;6717.193936727624;6724.125863637696;6746.595204287759;6792.490563207681;6846;6858.862822743617;6872.62200578963;6879.621620810904;6511.446527045254;6553.377429144223;6559.868802624016;6566.8358291043105;6568.7372505099265;6327.588706734047;6453.322401148;6488.448481879093;6493.448056915215;6496.902546461902;6821.237398853472;6827.249002609609;6832.624205668537;6835.555688880207;6850.931490685229;4428.269335559597;4431;4431.977840110779;4440.866773996656;4446.199684056772;6539.378759017885;6542.476601871744;6570.8357291066195;6575.309592492719;6579.309172537006;6246.437820596168;6382.393672601095;6390.169277993831;6394.136791533084;6411.903821442589;6280.874382512233;6282.465990390868;6348.333424990309;6354;6358.0780786784735;6197.938020619736;6215.502759779117;6237.656928868956;6314.494840412848;6321.52588555851;6375.458086062737;6377.521685873486;6378;6380.904286435614;6386.329435409401;6047.213862197887;6181.783637572664;6205.193324867739;6222.875542489215;6236.469900058546 05:36:02 INFO - PROCESS | 12823 | |5;yui.html;736.3924762071292;741.6365980669472;743.2344684974478;747.9364254038406;794.8767940969149;14778.334974926127;15050.924745376286;15056.924715376408;15081.698366032686;15089.849101508982;13736.313184340768;13828.792568111487;13846.930765346184;13848.09987350824;14771.852281477182;813.8168911994799;817.0726225733805;822.6627082896014;824.6495239523209;826.9173082691713;819.4223072733708;825.1789469477848;828.8383765165795;832.6419639554989;832.8958880139983;861.0958493581745;869.4870026684255;870.4951128345544;870.6430363550945;871.2768402226137;858.9269912057482;861.1388611388611;866.7356456280831;868.0494858130337;868.7741187291286;621.7295476467751;626.7962912053555;628.5725706519565;629.3360504667573;629.3894921925724;13602.31988400576;13607.251601161932;13619.659508512268;13623.04638675293;13643.658908527266;13275.137116087424;13539.458421663121;13683.452661893512;13705.657358566015;13812.654683632889;11394.829077563843;11588.362640054793;11838.940805295919;11910.940445297805;12034.037277017906;3821.617838216184;3895.2793733159456;3905.7070719695853;4009.67922566194;4016.0562267867026;51947.22079168815;52726.736366318306;52727.47272527302;53156;53611.19583206255;10183.43991080483;10368.844467332996;10826.729331766612;10934.835977460345;11292.209545331913;17940.19269132892;18030.2787888483;18300.450986470427;18379.72430413545;18823;8293.543855087908;8360.205780450848;8404.327653787683;8421.115782842835;8590.484570925764;4596.862094137181;4737.715737055719;4836.450563972128;4945.332380128709;4957.553820156203;3180.7773455858332;3183.793053451518;3191.441497737933;3200.9679903201136;3202.2634793997513;593.2673148661399;604.5737754882797;609.326694003129;617.6911544227886;618.653554009756;673.9654630142708;731.5208538407352;744.7356188553094;770.2720928722416;784.5606460382204;9398.577064032135;9541.634225709142;9627.56675949584;9716;9772.902270977342;713.0231582731691;734.1850545894054;752.1500704204324;764.1545667213728;769.6036541181296;4402.911941761146;4453.242948698729;4477.843275485342;4488.685791994529;4604.654650901196;60405;60595.39404605985;60904.390956090756;60910.69544652337;60999;50603.24095138576;50671.746641267295;50728;52310.738446308285;53022.469775302525;46911.999999999316;47224.5277547227;47578.5242147581;48114.51885481171;48232.758836206296;9754.609815607297;9895.950520247352;9919.801603967735;9976.187990594377;10026.240707453375;37111.6288837119;37341.4398784013;38065.4290185653;38288.042798929135;38979;45502.67724566161;48356.51643483661;48707.512924870294;48768.756156218995;49446.752766235935;11599.130065244972;12517.436715347649;12528.561500347809;12573.74852502963;12940.352982350656;12958.157719748186;13040.478380864659;13060.738785224432;13080.215187088805;13163.078584499377;11913;12266.141370104007;12526.311052892179;12553;12785.296808675612;12501;12659.303738294482;12662.620121396372;12665.430055647334;13037.217766934014;12513.061520385825;12513.311767852856;12676.429560669976;12697.80953285683;13130.606081817561;10397.42814145199;10629.202809789142;10633.468326583485;10787;11103.389313587508;10622.8406573903;10638.202134839763;10709.732256693645;10714.839277411002;10837.187210959051 05:36:02 INFO - PROCESS | 12823 | __end_tp_report 05:36:02 INFO - PROCESS | 12823 | __start_cc_report 05:36:02 INFO - PROCESS | 12823 | _x_x_mozilla_cycle_collect,785 05:36:02 INFO - PROCESS | 12823 | __end_cc_report 05:36:02 INFO - PROCESS | 12823 | __startTimestamp1458822962514__endTimestamp 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | ------- Summary: start ------- 05:36:02 INFO - PROCESS | 12823 | Number of tests: 6 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | [#0] dojo.html Cycles:165 Average:5156.49 Median:5308.73 stddev:559.30 (10.5%) stddev-sans-first:533.88 05:36:02 INFO - PROCESS | 12823 | Values: 2962.4 3032.7 3068.0 3073.9 3099.2 5125.8 5128.1 5173.9 5179.1 5204.3 5171.9 5188.8 5209.7 5283.3 5320.8 4709.9 4717.5 4762.8 4764.9 4963.2 4887.1 4896.7 4921.6 4930.6 4931.0 4722.2 4747.8 4825.8 4856.2 4876.2 4788.5 4808.4 4809.4 4811.4 4842.3 4734.5 4773.2 4783.4 4785.4 4791.2 5040.6 5146.8 5201.1 5220.9 5229.2 5533.4 5546.8 5561.5 5562.1 5565.2 5425.6 5525.4 5531.3 5532.7 5534.6 5185.2 5216.3 5224.1 5265.8 5279.0 5658.9 5661.4 5668.6 5668.9 5711.8 5225.6 5387.1 5442.4 5452.0 5460.9 5483.8 5518.9 5537.3 5540.6 5573.7 5492.6 5504.7 5507.3 5507.8 5516.7 5420.4 5483.4 5509.6 5539.4 5571.7 4230.9 4235.9 4241.9 4272.0 4273.5 3775.1 3793.8 3801.3 3821.1 3832.1 5192.4 5206.3 5244.9 5251.2 5285.9 5586.9 5593.0 5607.0 5623.1 5623.2 5276.4 5277.7 5308.7 5310.5 5359.4 4635.3 4774.6 4806.0 4815.5 4843.3 5635.1 5680.5 5683.8 5695.7 5698.0 5472.8 5478.5 5498.5 5499.5 5543.9 5763.3 5764.2 5773.3 5812.0 5829.9 5302.2 5303.5 5305.1 5331.1 5349.6 5377.8 5384.4 5399.0 5425.2 5497.7 5440.1 5443.2 5452.3 5464.6 5492.0 5399.5 5403.6 5404.9 5405.1 5459.5 5232.5 5280.6 5322.9 5324.5 5363.5 5376.3 5396.8 5411.0 5412.9 5413.5 5278.4 5297.2 5297.8 5302.4 5305.2 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | [#1] ext.html Cycles:180 Average:48382.56 Median:33755.83 stddev:86511.32 (256.3%) stddev-sans-first:86679.46 05:36:02 INFO - PROCESS | 12823 | Values: 547.3 550.5 552.3 569.9 591.3 28967.9 38618.8 39006.0 39093.8 39134.0 40642.6 40979.0 41138.8 41140.0 41153.8 7422.0 8515.9 8708.0 8708.7 8708.9 10226.3 10395.9 10457.8 10462.1 10466.5 10245.3 10328.4 10368.3 10370.8 10378.0 10155.9 10235.5 10257.8 10259.5 10264.5 10086.5 10201.3 10219.8 10225.9 10229.0 41086.6 41553.4 41652.4 41664.6 41678.8 3410.4 3539.4 3621.7 3913.5 3997.5 30746.8 31315.0 31356.2 31479.2 31737.8 4242.0 4245.7 4271.8 4315.2 4351.1 321178.0 321320.0 321753.0 322127.0 322722.4 44081.8 58260.0 58964.4 59054.0 59060.0 43897.0 43915.8 44020.4 44101.3 44153.0 12755.2 12788.5 12797.2 12801.3 12858.8 9773.8 9921.0 9921.0 9955.6 9981.2 14539.3 14622.8 15040.8 15045.7 15204.1 5732.7 5818.7 5853.7 5989.3 6022.8 1067.0 1071.7 1118.4 1143.0 1153.3 30066.7 30635.0 30673.2 30883.7 30927.2 1162.4 1173.5 1175.2 1189.7 1240.5 15628.4 15945.8 16017.9 16193.0 16262.2 386091.0 390782.0 391239.0 391670.0 392426.0 52333.7 52866.2 52915.5 52973.2 53067.7 1228.7 1320.9 1345.0 1366.6 1369.8 27271.0 28008.7 29481.3 29726.4 29780.0 44418.8 44801.1 44834.3 44860.1 44864.8 261835.0 263310.0 263472.0 263578.0 264071.0 29314.7 33543.0 33557.2 33658.0 33806.8 38764.2 39077.8 39200.4 40095.8 40180.0 34163.3 34338.5 34463.8 34473.3 34560.3 35759.5 35780.5 35879.0 36337.5 36528.6 33704.8 33837.3 35002.5 37288.3 37550.9 31712.2 33142.3 33210.3 33326.8 33327.3 25626.0 25926.0 26134.6 26238.2 26520.2 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | [#2] jquery.html Cycles:180 Average:27460.73 Median:12549.56 stddev:81214.54 (647.2%) stddev-sans-first:81416.85 05:36:02 INFO - PROCESS | 12823 | Values: 348.5 351.1 355.7 356.3 360.4 17613.0 17704.7 19052.5 19063.9 19077.3 17721.0 18620.3 18625.3 18760.2 18865.8 5459.2 5691.3 5729.6 5731.2 5732.3 4059.3 5623.9 6041.2 6270.7 6301.7 6215.2 6236.5 6259.6 6267.5 6273.9 5917.9 6178.8 6182.8 6184.0 6193.8 3706.9 5168.0 5379.0 5383.1 5449.9 20156.5 20250.4 20298.2 20466.5 20472.9 2217.2 2429.9 2543.7 2788.9 3048.2 13232.7 13514.2 13544.1 13713.5 13878.3 1855.3 1860.5 1913.3 1987.3 1988.3 67055.0 68019.0 68346.0 68488.0 69014.7 9269.5 9699.5 9784.9 9922.4 9982.4 13619.1 13748.3 13872.0 13880.4 13886.9 6991.3 7107.7 7123.4 7137.5 7218.9 6745.7 6772.3 6834.9 6879.8 6918.8 5948.7 6057.2 6073.2 6076.1 6153.2 1660.6 1701.7 1720.4 1723.1 1778.9 1030.2 1032.8 1086.0 1094.9 1128.2 17971.3 18450.4 18606.9 18659.6 19085.0 1014.7 1034.9 1039.8 1082.4 1085.8 10698.6 10945.6 10963.5 10965.6 11106.5 480829.0 489436.0 501029.0 506110.0 506220.0 67255.7 71682.3 71919.0 72966.0 73069.0 1061.9 1064.8 1075.5 1080.4 1090.4 16343.7 16345.9 16409.0 16443.5 16848.6 22881.9 33344.5 34372.3 34795.5 35281.6 46741.8 46801.3 46986.5 47263.0 47277.5 7949.1 8087.6 8272.0 8367.5 8419.9 12286.4 12365.6 12396.3 12455.6 12466.9 10720.8 11435.7 11577.2 11731.9 11804.4 10749.8 11018.9 11274.3 11275.8 11357.6 11190.7 11789.4 11868.3 11968.1 12018.9 7794.8 7863.8 8212.6 8290.0 8356.9 10886.4 10967.5 11040.3 11247.9 11429.1 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | [#3] mootools.html Cycles:180 Average:5452.71 Median:6201.23 stddev:2770.49 (44.7%) stddev-sans-first:2760.79 05:36:02 INFO - PROCESS | 12823 | Values: 1314.1 1420.4 1466.1 1561.5 1727.3 7340.0 7485.7 7571.3 7609.3 7610.2 7359.2 7495.4 7502.8 7506.1 7517.4 1977.4 2250.4 2254.3 2290.8 2321.7 2319.3 2320.6 2325.7 2331.8 2333.3 2268.1 2325.4 2328.1 2329.4 2329.7 2256.3 2313.9 2315.0 2316.4 2318.1 2304.6 2308.5 2309.2 2319.9 2342.0 7790.3 7830.5 7833.3 7851.3 7860.7 4811.9 4928.3 4928.7 4941.2 4946.0 3294.8 3381.1 3407.7 3449.2 3477.5 1104.7 1130.6 1131.3 1148.8 1154.0 10610.9 10750.5 10758.1 10762.7 10796.2 4303.1 4328.2 4373.7 4407.4 4414.9 8967.6 8971.1 8973.1 8997.6 9017.5 4330.4 4933.3 4953.3 4982.5 4986.7 3964.3 4006.9 4011.3 4401.2 4547.2 3666.7 3722.9 3759.1 3770.5 3774.2 1194.3 1204.5 1215.4 1219.1 1240.2 1285.2 1318.8 1319.4 1394.9 1399.6 7148.4 7344.4 7367.7 7371.3 7452.2 1139.6 1147.1 1166.7 1167.5 1170.5 5887.2 5894.9 5919.3 5938.7 5975.3 8795.2 9212.1 9235.3 9307.8 9434.2 9316.4 9472.3 9481.0 9484.9 9494.7 7074.0 7201.6 7248.2 7276.8 7391.3 6843.3 6866.2 6870.3 6886.0 6889.1 8323.2 8501.9 8573.4 8603.1 8623.2 8670.3 8791.6 8811.5 8953.5 8965.2 6099.2 6513.3 6659.2 6668.3 6778.0 7318.2 7328.6 7368.9 7370.6 7381.9 6503.6 6676.0 6692.3 6819.1 6844.0 6479.8 6580.6 6615.8 6639.5 6677.0 6962.4 6994.0 7004.3 7089.8 7153.2 6303.3 6356.0 6371.0 6417.7 6425.4 6420.7 6441.5 6492.8 6509.7 6509.8 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | [#4] prototype.html Cycles:180 Average:5322.34 Median:6082.71 stddev:1623.79 (26.7%) stddev-sans-first:1584.44 05:36:02 INFO - PROCESS | 12823 | Values: 325.4 332.5 334.1 336.3 340.5 6071.6 6083.7 6112.6 6119.5 6132.3 6066.3 6067.8 6077.5 6081.7 6085.9 4389.7 4483.8 4555.9 4613.4 4629.4 4620.4 4631.9 4636.7 4643.7 4654.6 4582.1 4588.2 4589.4 4605.8 4607.4 4377.7 4484.4 4553.8 4600.9 4612.7 4016.5 4028.5 4037.4 4040.8 4043.4 5774.8 5822.6 5824.8 5825.5 5836.8 5321.3 5332.8 5341.1 5344.1 5348.5 6343.8 6345.0 6363.7 6372.7 6373.6 4197.4 4330.0 4342.0 4348.5 4435.2 6626.3 6692.8 6698.5 6706.9 6709.9 4403.2 4408.8 4430.9 4441.4 4451.1 4494.0 4498.4 4499.0 4499.9 4501.7 5252.3 5257.5 5259.6 5261.3 5267.5 6232.7 6454.5 6461.4 6480.2 6481.5 1557.7 1568.6 1576.1 1578.1 1583.4 963.3 1001.0 1011.4 1013.4 1017.3 6066.2 6084.7 6168.8 6173.5 6173.5 6563.8 6573.8 6584.6 6593.4 6598.4 6071.3 6073.4 6074.4 6075.8 6079.9 3510.9 3521.5 3535.1 3538.1 3548.4 6678.0 6843.5 6855.0 6855.8 6860.1 6703.1 6716.6 6717.2 6724.1 6746.6 6792.5 6846.0 6858.9 6872.6 6879.6 6511.4 6553.4 6559.9 6566.8 6568.7 6327.6 6453.3 6488.4 6493.4 6496.9 6821.2 6827.2 6832.6 6835.6 6850.9 4428.3 4431.0 4432.0 4440.9 4446.2 6539.4 6542.5 6570.8 6575.3 6579.3 6246.4 6382.4 6390.2 6394.1 6411.9 6280.9 6282.5 6348.3 6354.0 6358.1 6197.9 6215.5 6237.7 6314.5 6321.5 6375.5 6377.5 6378.0 6380.9 6386.3 6047.2 6181.8 6205.2 6222.9 6236.5 05:36:02 INFO - PROCESS | 12823 | 05:36:02 INFO - PROCESS | 12823 | [#5] yui.html Cycles:180 Average:14770.75 Median:25049.77 stddev:16760.40 (66.9%) stddev-sans-first:16774.28 05:36:02 INFO - PROCESS | 12823 | Values: 736.4 741.6 743.2 747.9 794.9 14778.3 15050.9 15056.9 15081.7 15089.8 13736.3 13828.8 13846.9 13848.1 14771.9 813.8 817.1 822.7 824.6 826.9 819.4 825.2 828.8 832.6 832.9 861.1 869.5 870.5 870.6 871.3 858.9 861.1 866.7 868.0 868.8 621.7 626.8 628.6 629.3 629.4 13602.3 13607.3 13619.7 13623.0 13643.7 13275.1 13539.5 13683.5 13705.7 13812.7 11394.8 11588.4 11838.9 11910.9 12034.0 3821.6 3895.3 3905.7 4009.7 4016.1 51947.2 52726.7 52727.5 53156.0 53611.2 10183.4 10368.8 10826.7 10934.8 11292.2 17940.2 18030.3 18300.5 18379.7 18823.0 8293.5 8360.2 8404.3 8421.1 8590.5 4596.9 4737.7 4836.5 4945.3 4957.6 3180.8 3183.8 3191.4 3201.0 3202.3 593.3 604.6 609.3 617.7 618.7 674.0 731.5 744.7 770.3 784.6 9398.6 9541.6 9627.6 9716.0 9772.9 713.0 734.2 752.2 764.2 769.6 4402.9 4453.2 4477.8 4488.7 4604.7 60405.0 60595.4 60904.4 60910.7 60999.0 50603.2 50671.7 50728.0 52310.7 53022.5 46912.0 47224.5 47578.5 48114.5 48232.8 9754.6 9896.0 9919.8 9976.2 10026.2 37111.6 37341.4 38065.4 38288.0 38979.0 45502.7 48356.5 48707.5 48768.8 49446.8 11599.1 12517.4 12528.6 12573.7 12940.4 12958.2 13040.5 13060.7 13080.2 13163.1 11913.0 12266.1 12526.3 12553.0 12785.3 12501.0 12659.3 12662.6 12665.4 13037.2 12513.1 12513.3 12676.4 12697.8 13130.6 10397.4 10629.2 10633.5 10787.0 11103.4 10622.8 10638.2 10709.7 10714.8 10837.2 05:36:02 INFO - PROCESS | 12823 | -------- Summary: end -------- 05:36:02 INFO - PROCESS | 12823 | 05:36:03 INFO - TEST-INFO | 12823: exit 0 05:36:03 INFO - TEST-OK | dromaeo_css | took 1112510ms 05:36:03 INFO - TEST-START | kraken 05:36:03 INFO - operating with platform_type : linux_ 05:36:03 INFO - Initialising browser for kraken test... 05:36:03 INFO - TEST-INFO | started process 13008 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLi5F6s/profile http://localhost:46333/getInfo.html) 05:36:07 INFO - PROCESS | 13008 | __metrics Screen width/height:1600/1200 05:36:07 INFO - PROCESS | 13008 | colorDepth:24 05:36:07 INFO - PROCESS | 13008 | Browser inner width/height: 1024/697 05:36:07 INFO - PROCESS | 13008 | __metrics 05:36:09 ERROR - PROCESS | 13008 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:36:09 INFO - PROCESS | 13008 | 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. 05:36:10 INFO - TEST-INFO | 13008: exit 0 05:36:10 INFO - Browser initialized. 05:36:10 INFO - Running cycle 1/1 for kraken test... 05:36:10 INFO - TEST-INFO | started process 13095 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLi5F6s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:21 INFO - PROCESS | 13095 | RSS: Main: 153051136 05:36:21 INFO - PROCESS | 13095 | 05:36:24 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:24 INFO - PROCESS | 13095 | RSS: Main: 194568192 05:36:24 INFO - PROCESS | 13095 | 05:36:27 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-dft) 05:36:28 INFO - PROCESS | 13095 | RSS: Main: 184713216 05:36:28 INFO - PROCESS | 13095 | 05:36:31 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-fft) 05:36:31 INFO - PROCESS | 13095 | RSS: Main: 168140800 05:36:31 INFO - PROCESS | 13095 | 05:36:33 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-oscillator) 05:36:34 INFO - PROCESS | 13095 | RSS: Main: 170975232 05:36:34 INFO - PROCESS | 13095 | 05:36:36 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:37 INFO - PROCESS | 13095 | RSS: Main: 172937216 05:36:37 INFO - PROCESS | 13095 | 05:36:40 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46333/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:40 INFO - PROCESS | 13095 | RSS: Main: 172908544 05:36:40 INFO - PROCESS | 13095 | 05:36:44 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46333/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:44 INFO - PROCESS | 13095 | RSS: Main: 173588480 05:36:44 INFO - PROCESS | 13095 | 05:36:47 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46333/tests/kraken/driver.html?testName=json-parse-financial) 05:36:47 INFO - PROCESS | 13095 | RSS: Main: 173334528 05:36:47 INFO - PROCESS | 13095 | 05:36:49 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:50 INFO - PROCESS | 13095 | RSS: Main: 185049088 05:36:50 INFO - PROCESS | 13095 | 05:36:51 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:52 INFO - PROCESS | 13095 | RSS: Main: 183885824 05:36:52 INFO - PROCESS | 13095 | 05:36:54 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:54 INFO - PROCESS | 13095 | RSS: Main: 198467584 05:36:54 INFO - PROCESS | 13095 | 05:36:57 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:57 INFO - PROCESS | 13095 | RSS: Main: 203911168 05:36:57 INFO - PROCESS | 13095 | 05:37:00 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:00 INFO - PROCESS | 13095 | RSS: Main: 202375168 05:37:00 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46333/tests/kraken/driver.html?testName=ai-astar) 05:37:02 INFO - PROCESS | 13095 | RSS: Main: 263573504 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | __start_tp_report 05:37:02 INFO - PROCESS | 13095 | _x_x_mozilla_page_load 05:37:02 INFO - PROCESS | 13095 | _x_x_mozilla_page_load_details 05:37:02 INFO - PROCESS | 13095 | |i|pagename|runs| 05:37:02 INFO - PROCESS | 13095 | |0;ai-astar;108;111;105;110;113;111;100;112;110;109 05:37:02 INFO - PROCESS | 13095 | |1;audio-beat-detection;153;127;158;169;134;153;159;129;174;135 05:37:02 INFO - PROCESS | 13095 | |2;audio-dft;161;160;164;161;161;160;161;163;161;159 05:37:02 INFO - PROCESS | 13095 | |3;audio-fft;73;72;111;100;72;72;71;122;104;74 05:37:02 INFO - PROCESS | 13095 | |4;audio-oscillator;93;93;150;93;93;93;140;92;92;141 05:37:02 INFO - PROCESS | 13095 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;116 05:37:02 INFO - PROCESS | 13095 | |6;imaging-darkroom;147;146;145;146;147;145;145;146;145;145 05:37:02 INFO - PROCESS | 13095 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;96 05:37:02 INFO - PROCESS | 13095 | |8;json-parse-financial;58;58;57;56;57;56;57;66;55;56 05:37:02 INFO - PROCESS | 13095 | |9;json-stringify-tinderbox;61;61;64;61;61;61;61;61;62;61 05:37:02 INFO - PROCESS | 13095 | |10;stanford-crypto-aes;79;78;79;80;79;80;79;80;79;80 05:37:02 INFO - PROCESS | 13095 | |11;stanford-crypto-ccm;111;111;110;110;110;110;113;114;126;112 05:37:02 INFO - PROCESS | 13095 | |12;stanford-crypto-pbkdf2;144;131;139;138;134;131;140;139;140;137 05:37:02 INFO - PROCESS | 13095 | |13;stanford-crypto-sha256-iterative;65;76;70;65;65;64;65;70;64;64 05:37:02 INFO - PROCESS | 13095 | __end_tp_report 05:37:02 INFO - PROCESS | 13095 | __start_cc_report 05:37:02 INFO - PROCESS | 13095 | _x_x_mozilla_cycle_collect,1034 05:37:02 INFO - PROCESS | 13095 | __end_cc_report 05:37:02 INFO - PROCESS | 13095 | __startTimestamp1458823022833__endTimestamp 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | ------- Summary: start ------- 05:37:02 INFO - PROCESS | 13095 | Number of tests: 14 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.84 (3.5%) stddev-sans-first:4.06 05:37:02 INFO - PROCESS | 13095 | Values: 108.0 111.0 105.0 110.0 113.0 111.0 100.0 112.0 110.0 109.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.50 stddev:16.81 (10.8%) stddev-sans-first:17.77 05:37:02 INFO - PROCESS | 13095 | Values: 153.0 127.0 158.0 169.0 134.0 153.0 159.0 129.0 174.0 135.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 05:37:02 INFO - PROCESS | 13095 | Values: 161.0 160.0 164.0 161.0 161.0 160.0 161.0 163.0 161.0 159.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#3] audio-fft Cycles:10 Average:87.10 Median:72.00 stddev:19.87 (27.6%) stddev-sans-first:20.41 05:37:02 INFO - PROCESS | 13095 | Values: 73.0 72.0 111.0 100.0 72.0 72.0 71.0 122.0 104.0 74.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:24.75 (26.6%) stddev-sans-first:25.65 05:37:02 INFO - PROCESS | 13095 | Values: 93.0 93.0 150.0 93.0 93.0 93.0 140.0 92.0 92.0 141.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:37:02 INFO - PROCESS | 13095 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 05:37:02 INFO - PROCESS | 13095 | Values: 147.0 146.0 145.0 146.0 147.0 145.0 145.0 146.0 145.0 145.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:37:02 INFO - PROCESS | 13095 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.10 (5.4%) stddev-sans-first:3.28 05:37:02 INFO - PROCESS | 13095 | Values: 58.0 58.0 57.0 56.0 57.0 56.0 57.0 66.0 55.0 56.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 05:37:02 INFO - PROCESS | 13095 | Values: 61.0 61.0 64.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 05:37:02 INFO - PROCESS | 13095 | Values: 79.0 78.0 79.0 80.0 79.0 80.0 79.0 80.0 79.0 80.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#11] stanford-crypto-ccm Cycles:10 Average:112.70 Median:111.50 stddev:4.88 (4.4%) stddev-sans-first:5.13 05:37:02 INFO - PROCESS | 13095 | Values: 111.0 111.0 110.0 110.0 110.0 110.0 113.0 114.0 126.0 112.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.30 Median:139.00 stddev:4.16 (3.0%) stddev-sans-first:3.64 05:37:02 INFO - PROCESS | 13095 | Values: 144.0 131.0 139.0 138.0 134.0 131.0 140.0 139.0 140.0 137.0 05:37:02 INFO - PROCESS | 13095 | 05:37:02 INFO - PROCESS | 13095 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:65.00 stddev:3.97 (6.1%) stddev-sans-first:4.15 05:37:02 INFO - PROCESS | 13095 | Values: 65.0 76.0 70.0 65.0 65.0 64.0 65.0 70.0 64.0 64.0 05:37:02 INFO - PROCESS | 13095 | -------- Summary: end -------- 05:37:02 INFO - PROCESS | 13095 | 05:37:03 INFO - TEST-INFO | 13095: exit 0 05:37:03 INFO - TEST-OK | kraken | took 60599ms 05:37:03 INFO - SUITE-END | took 1173s 05:37:03 INFO - Completed test suite (00:19:33) 05:37:03 INFO - javascript benchmark 05:37:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2962.392709494553, 3032.711892370227, 3068.0, 3073.8616762245683, 3099.225193701574, 5125.794968201277, 5128.102582048141, 5173.870653233671, 5179.093658609747, 5204.271402003723, 5171.948280517194, 5188.766505507252, 5209.687418754868, 5283.313169287997, 5320.813771517997, 4709.858704238878, 4717.504662010482, 4762.809487620491, 4764.857054288377, 4963.1810751226185, 4887.120318342697, 4896.657233993622, 4921.581665558414, 4930.630202734809, 4931.038447502739, 4722.244440889458, 4747.833825816115, 4825.806967721287, 4856.15017371962, 4876.171050921352, 4788.545088216614, 4808.35087263222, 4809.422869255712, 4811.422629284473, 4842.2736589511505, 4734.526547345273, 4773.236282194832, 4783.449903261135, 4785.353977213066, 4791.161546729343, 5040.621953353513, 5146.794128234867, 5201.141811601081, 5220.947790522122, 5229.2417599448245, 5533.391326954032, 5546.805861794818, 5561.5272701820395, 5562.137868630369, 5565.193047008162, 5425.6202065855405, 5525.4474552544425, 5531.2809334786625, 5532.723363831792, 5534.557235421156, 5185.196294574347, 5216.347956505437, 5224.085784987612, 5265.815696450606, 5279.049771041211, 5658.91511627326, 5661.405552417019, 5668.57485688575, 5668.914966275509, 5711.771529138871, 5225.608079394061, 5387.057264978613, 5442.428545002796, 5451.972740136353, 5460.91808622863, 5483.75323110461, 5518.889622207534, 5537.307836520435, 5540.612157149041, 5573.749181286852, 5492.642978206404, 5504.669719816744, 5507.256520369779, 5507.834764957058, 5516.724163791794, 5420.430854760272, 5483.396826349099, 5509.559235261169, 5539.362973258047, 5571.721413929368, 4230.915381692349, 4235.851745188966, 4241.87274381769, 4271.978640106841, 4273.508546517191, 3775.112848480605, 3793.8292776824555, 3801.334766415866, 3821.063839359319, 3832.137769001952, 5192.428832828386, 5206.349206349207, 5244.895102097937, 5251.186066159751, 5285.867853303621, 5586.91619625706, 5593.049181639131, 5607.046802043662, 5623.10030395143, 5623.212750214973, 5276.445973172838, 5277.656952298088, 5308.734563271821, 5310.522053015247, 5359.410464848864, 4635.3278774578175, 4774.641901857374, 4805.9759701201965, 4815.494373090845, 4843.297721830385, 5635.098384258499, 5680.488756011979, 5683.772649094072, 5695.7152142392715, 5698.0, 5472.835814925558, 5478.506934375925, 5498.505134537831, 5499.532539734168, 5543.8891222174525, 5763.3084029915, 5764.164196191613, 5773.3072031356505, 5812.0, 5829.854253643693, 5302.231176479466, 5303.549198318186, 5305.098133317269, 5331.067063263836, 5349.57203423733, 5377.8117765878005, 5384.353877534721, 5399.0, 5425.213344065168, 5497.670139791625, 5440.129579267298, 5443.210734443563, 5452.345718513804, 5464.644798088111, 5492.038893193595, 5399.460053994726, 5403.648762830403, 5404.918926216032, 5405.081136206775, 5459.535939445192, 5232.450592687713, 5280.577553795611, 5322.893542129058, 5324.520793128637, 5363.490468405651, 5376.301080859464, 5396.757145928521, 5410.97294513525, 5412.945870541244, 5413.485718856702, 5278.445763194809, 5297.205419187153, 5297.841064768063, 5302.443243459381, 5305.230741542532], "unit": "score", "name": "dojo.html", "value": 5120.191862263866}, {"lowerIsBetter": false, "replicates": [547.3049227481099, 550.545799715235, 552.3289203617605, 569.8945695046417, 591.3258884871245, 28967.855160724193, 38618.806905965466, 39006.0, 39093.804530977344, 39134.0, 40642.59357406425, 40979.0, 41138.79430602843, 41140.0, 41153.79423102888, 7422.0, 8515.872261916093, 8708.042115367305, 8708.651653933866, 8708.869366959469, 10226.284160108795, 10395.896041039607, 10457.790844183111, 10462.110720588758, 10466.4766761662, 10245.28283020189, 10328.380297182155, 10368.326058806191, 10370.844437333408, 10378.0, 10155.89844101557, 10235.539400726948, 10257.794844103151, 10259.487025648725, 10264.486775661187, 10086.546105425201, 10201.285909986304, 10219.795604087876, 10225.897741022569, 10229.0, 41086.58913410857, 41553.37669934954, 41652.37521437181, 41664.58335416668, 41678.79160604178, 3410.38613049651, 3539.415996360623, 3621.692156166729, 3913.5303763548554, 3997.540282867449, 30746.846265768752, 31315.0, 31356.21609459759, 31479.213019674462, 31737.84131079353, 4242.0, 4245.745255284693, 4271.786410679485, 4315.244832154361, 4351.129774045172, 321178.0, 321320.0, 321753.0, 322127.0, 322722.3863880689, 44081.77959110184, 58260.0, 58964.41035589589, 59054.0, 59060.0, 43897.0, 43915.78042109769, 44020.37786032484, 44101.33847992283, 44153.0, 12755.170913890568, 12788.488460461478, 12797.168184068007, 12801.29592872401, 12858.807117893239, 9773.755656108511, 9921.0, 9921.0, 9955.552000159865, 9981.201503879673, 14539.27303634814, 14622.780658290134, 15040.849591503946, 15045.699086018438, 15204.087754734752, 5732.6847023413275, 5818.709064546756, 5853.7365818538265, 5989.31122920861, 6022.759089636365, 1066.983995240072, 1071.6838532632892, 1118.4072441605963, 1142.994285028586, 1153.3368313219933, 30066.69933300683, 30635.0, 30673.233169170948, 30883.69116308853, 30927.226819329248, 1162.3607016141088, 1173.501261963662, 1175.2243519277406, 1189.7025743564109, 1240.466599362283, 15628.374865005273, 15945.760813587573, 16017.919910400606, 16193.0, 16262.18689065542, 386091.0, 390782.0, 391239.0, 391670.0, 392426.0, 52333.7383313081, 52866.207006894925, 52915.47084529183, 52973.205401919, 53067.734661326445, 1228.7235372041398, 1320.9075364724376, 1344.9798253026213, 1366.5763613279914, 1369.8287714035746, 27271.0, 28008.71991280061, 29481.32852518552, 29726.405471890874, 29780.0, 44418.77790611026, 44801.10397792091, 44834.327485087095, 44860.102797943204, 44864.77567612141, 261835.0, 263310.0, 263472.0, 263578.0, 264071.0, 29314.70685293205, 33543.0, 33557.16107097342, 33658.0, 33806.830965846, 38764.22471550497, 39077.80461097676, 39200.411993820686, 40095.79952100338, 40180.0, 34163.31673366469, 34338.48492272668, 34463.827680862436, 34473.31053378868, 34560.308793824486, 35759.46360804642, 35780.4632930501, 35879.0, 36337.454938176474, 36528.634713653584, 33704.83147584246, 33837.3232535343, 35002.474962875065, 37288.254234915694, 37550.86940436604, 31712.207194820316, 33142.337153257286, 33210.33579328351, 33326.83414573178, 33327.33345333031, 25626.0, 25926.0, 26134.607980880683, 26238.212853614423, 26520.204393868215], "unit": "score", "name": "ext.html", "value": 18519.674218439926}, {"lowerIsBetter": false, "replicates": [348.51705991008265, 351.05741085186276, 355.68042562094627, 356.306982918224, 360.38374379810523, 17613.0, 17704.734428983575, 19052.523686907833, 19063.90468047661, 19077.332293369735, 17721.0, 18620.255189792428, 18625.348112816053, 18760.24959001638, 18865.811341886576, 5459.235707001023, 5691.288588926384, 5729.570282228829, 5731.226284451608, 5732.2548068751, 4059.330210515276, 5623.9437605623825, 6041.214642096521, 6270.7178176981915, 6301.6849157542165, 6215.223097112861, 6236.469900058501, 6259.593126446766, 6267.498600112003, 6273.905891411609, 5917.852053698649, 6178.783742569011, 6182.783602573933, 6183.96908015457, 6193.7832175873855, 3706.9258614827822, 5168.0, 5379.031774280628, 5383.084875571162, 5449.863753406157, 20156.49608759778, 20250.392488225378, 20298.18807247708, 20466.488337791525, 20472.897635511876, 2217.2350539063996, 2429.878506074689, 2543.7201907790127, 2788.9262633885896, 3048.17699221209, 13232.735345293137, 13514.189148651112, 13544.119632223874, 13713.520026799113, 13878.306084695825, 1855.276442187548, 1860.4604664647236, 1913.2920819296949, 1987.3044434447827, 1988.30409356724, 67055.0, 68019.00166637631, 68346.0, 68488.0, 69014.65492672555, 9269.490178040138, 9699.466529340954, 9784.853227201598, 9922.40465572068, 9982.402815549478, 13619.114757540729, 13748.312584370742, 13872.0, 13880.4447822088, 13886.930565347311, 6991.3358230969, 7107.715691372287, 7123.43012558994, 7137.500374973702, 7218.927810721825, 6745.696443659949, 6772.255051944282, 6834.931650683429, 6879.793606191823, 6918.827029324207, 5948.672822994777, 6057.182280392179, 6073.240844894388, 6076.118962750465, 6153.246324797501, 1660.6346603747156, 1701.6936951348628, 1720.423658074534, 1723.1125970125395, 1778.9466316010542, 1030.2324768047702, 1032.808930347888, 1086.0225796782959, 1094.9069329106956, 1128.2215271462665, 17971.281148754166, 18450.446486605422, 18606.906965465085, 18659.626807463774, 19085.0, 1014.6803756816579, 1034.9327293725885, 1039.8284283093205, 1082.3614067700096, 1085.777415629794, 10698.62554810578, 10945.631796025496, 10963.50664220112, 10965.61620343284, 11106.500207490682, 480829.0, 489436.0, 501029.0, 506110.0, 506220.0, 67255.66372168205, 71682.2831771686, 71919.0, 72966.0, 73069.0, 1061.9150467962545, 1064.7657515346611, 1075.4837677914488, 1080.400377790318, 1090.432974853072, 16343.673126537165, 16345.918270408572, 16409.0, 16443.506694799176, 16848.57878553046, 22881.88559057194, 33344.49983250205, 34372.31255374929, 34795.478067828495, 35281.647183527835, 46741.76629116833, 46801.297980531, 46986.530134698216, 47263.0, 47277.52722472731, 7949.125596184531, 8087.595620219083, 8272.04871439792, 8367.456115352483, 8419.873701894354, 12286.385680716106, 12365.629031129081, 12396.318202498589, 12455.626331210078, 12466.875331246934, 10720.839187412352, 11435.714107147387, 11577.247478913843, 11731.88268117308, 11804.3507607079, 10749.838752418877, 11018.889811102106, 11274.267172633752, 11275.830862537232, 11357.602483913024, 11190.66428007161, 11789.351585662871, 11868.347240901834, 11968.102392320785, 12018.939905300767, 7794.766157015299, 7863.764087077397, 8212.589370531568, 8289.95855020721, 8356.916430835858, 10886.38630937906, 10967.50646220906, 11040.33757974524, 11247.88752112501, 11429.085673146295], "unit": "score", "name": "jquery.html", "value": 8889.42277586961}, {"lowerIsBetter": false, "replicates": [1314.1129737427234, 1420.3821337718093, 1466.1423067505511, 1561.5393458929614, 1727.2745446912295, 7339.963300183498, 7485.663145158467, 7571.280728330807, 7609.315161635452, 7610.16288208298, 7359.227281135484, 7495.36289415399, 7502.849943001137, 7506.136794268661, 7517.398608111352, 1977.377126205248, 2250.3586477853814, 2254.3349711834967, 2290.816734661223, 2321.698179236697, 2319.257837492003, 2320.628699408095, 2325.7209134903837, 2331.8367714260007, 2333.2533589251448, 2268.0587556164173, 2325.3953971967326, 2328.080408238745, 2329.4060014696315, 2329.697139371879, 2256.3343813575034, 2313.9190128345513, 2315.0392587076344, 2316.3630001749484, 2318.07277089164, 2304.6312589985523, 2308.5036717105904, 2309.203324852923, 2319.9188028419094, 2342.02805835578, 7790.298873101448, 7830.530168189927, 7833.255840695125, 7851.254130857559, 7860.68557257709, 4811.879703007417, 4928.26076088586, 4928.654994150411, 4941.184704523749, 4946.0, 3294.8352582370785, 3381.1378098584705, 3407.71034462071, 3449.189440481485, 3477.4783782432582, 1104.7017305327518, 1130.5703832543581, 1131.332513816852, 1148.827675848621, 1153.9711507212303, 10610.946945265225, 10750.462476876124, 10758.139348852073, 10762.73093172677, 10796.2442629016, 4303.139372125587, 4328.220920234325, 4373.737575745466, 4407.360932664746, 4414.940414300545, 8967.551622418983, 8971.102889710977, 8973.057828927998, 8997.64009439615, 9017.458952462874, 4330.35044743291, 4933.260010998307, 4953.2570114483115, 4982.501749824988, 4986.650934434628, 3964.28642844285, 4006.9198616027516, 4011.3180759270995, 4401.185780630593, 4547.1587756264535, 3666.7433279670167, 3722.8883133506038, 3759.1353988582778, 3770.472133901256, 3774.226283611908, 1194.2535915053093, 1204.4519743516853, 1215.4166000319897, 1219.0613227814533, 1240.1876770715196, 1285.2288626823831, 1318.7824009038593, 1319.445832750228, 1394.8953828462907, 1399.5731301953, 7148.39238664709, 7344.375728063174, 7367.705291788268, 7371.299726525972, 7452.21751716062, 1139.6467095200514, 1147.1396452660504, 1166.6616681162538, 1167.4746364136172, 1170.4791367841228, 5887.2052272943465, 5894.852628684317, 5919.289685237713, 5938.673372964442, 5975.282966044016, 8795.208431241219, 9212.124848139416, 9235.307351948497, 9307.76730581741, 9434.198093162158, 9316.369635313793, 9472.336936414385, 9481.0, 9484.90515094854, 9494.667686631074, 7074.0, 7201.639918004079, 7248.166460856964, 7276.781696549112, 7391.33477986973, 6843.315668433117, 6866.244713081457, 6870.27862074475, 6886.0, 6889.138857642794, 8323.209295116954, 8501.872471912802, 8573.442726222776, 8603.139686031596, 8623.223909848144, 8670.30637548982, 8791.560421978747, 8811.515366654896, 8953.462792232487, 8965.237954773916, 6099.176611157614, 6513.348665133449, 6659.167604049494, 6668.266490685924, 6778.017187507882, 7318.231585683639, 7328.560286382834, 7368.926310736824, 7370.5946172961, 7381.889271661037, 6503.642299673564, 6675.9666201670625, 6692.263850976291, 6819.147606549182, 6844.041834143323, 6479.838004049937, 6580.605163690194, 6615.768448104293, 6639.468842492685, 6677.0, 6962.443004559522, 6993.965030174817, 7004.264552221944, 7089.82275443118, 7153.2131465537705, 6303.275123360689, 6356.046593011085, 6371.044343348535, 6417.679116044273, 6425.357464253537, 6420.743170273324, 6441.5490915635455, 6492.837679058061, 6509.73961041572, 6509.837254068497], "unit": "score", "name": "mootools.html", "value": 4531.714890438097}, {"lowerIsBetter": false, "replicates": [325.3752794634302, 332.48464879436875, 334.0912717408648, 336.2535171918342, 340.4807668305835, 6071.605345652535, 6083.7262323195455, 6112.633242005477, 6119.510439164867, 6132.325444201134, 6066.272047354312, 6067.7572897084065, 6077.513798896089, 6081.695915204233, 6085.939140608592, 4389.714668546534, 4483.820647174109, 4555.863324100283, 4613.400257966459, 4629.351890735291, 4620.353150558924, 4631.884202894921, 4636.698614590057, 4643.744594047326, 4654.627629789608, 4582.060677561109, 4588.151192029469, 4589.426321709786, 4605.815767369301, 4607.424071991001, 4377.6935614507, 4484.394606728115, 4553.817847286105, 4600.861974140747, 4612.746298953556, 4016.5380981187245, 4028.4762980812307, 4037.394390841368, 4040.7575545467366, 4043.3732771420478, 5774.769009239625, 5822.563307751935, 5824.796132135355, 5825.475707186331, 5836.766529338822, 5321.255024296602, 5332.760025798849, 5341.0653135701095, 5344.091504444254, 5348.5186333230195, 6343.777967771152, 6345.016522439029, 6363.681815909186, 6372.681365931685, 6373.585716928431, 4197.412362269285, 4329.982454123278, 4342.0, 4348.5216626171095, 4435.2238358287495, 6626.304238054983, 6692.765753198663, 6698.531102822755, 6706.859833828261, 6709.865802683919, 4403.163398954252, 4408.801603927831, 4430.867073987785, 4441.444819397575, 4451.132029254264, 4494.0337827367275, 4498.370228168059, 4498.955010449919, 4499.910001799945, 4501.729896206238, 5252.264682944391, 5257.5005374489365, 5259.579233661298, 5261.289725887033, 5267.473252674702, 6232.688365581703, 6454.4513716333695, 6461.418472337512, 6480.189976252968, 6481.546291759626, 1557.7196104701036, 1568.647054412748, 1576.0622429654338, 1578.0925967568464, 1583.3745670460103, 963.3208587945621, 1000.9599616015278, 1011.4234886114991, 1013.3615822032073, 1017.2523195451338, 6066.241719785027, 6084.665343406155, 6168.784092556739, 6173.506119510518, 6173.536984726164, 6563.803085907431, 6573.80278591643, 6584.6378449184795, 6593.3736295051895, 6598.43913267368, 6071.2714474263375, 6073.362296958756, 6074.362191969868, 6075.787347442907, 6079.908801367983, 3510.9297814043575, 3521.454174602941, 3535.133892196377, 3538.080099174233, 3548.361294966931, 6677.966610166918, 6843.486738494633, 6855.0, 6855.794326170223, 6860.0738900247825, 6703.128593282842, 6716.5634233774645, 6717.193936727624, 6724.125863637696, 6746.595204287759, 6792.490563207681, 6846.0, 6858.862822743617, 6872.62200578963, 6879.621620810904, 6511.446527045254, 6553.377429144223, 6559.868802624016, 6566.8358291043105, 6568.7372505099265, 6327.588706734047, 6453.322401148, 6488.448481879093, 6493.448056915215, 6496.902546461902, 6821.237398853472, 6827.249002609609, 6832.624205668537, 6835.555688880207, 6850.931490685229, 4428.269335559597, 4431.0, 4431.977840110779, 4440.866773996656, 4446.199684056772, 6539.378759017885, 6542.476601871744, 6570.8357291066195, 6575.309592492719, 6579.309172537006, 6246.437820596168, 6382.393672601095, 6390.169277993831, 6394.136791533084, 6411.903821442589, 6280.874382512233, 6282.465990390868, 6348.333424990309, 6354.0, 6358.0780786784735, 6197.938020619736, 6215.502759779117, 6237.656928868956, 6314.494840412848, 6321.52588555851, 6375.458086062737, 6377.521685873486, 6378.0, 6380.904286435614, 6386.329435409401, 6047.213862197887, 6181.783637572664, 6205.193324867739, 6222.875542489215, 6236.469900058546], "unit": "score", "name": "prototype.html", "value": 4785.879332339592}, {"lowerIsBetter": false, "replicates": [736.3924762071292, 741.6365980669472, 743.2344684974478, 747.9364254038406, 794.8767940969149, 14778.334974926127, 15050.924745376286, 15056.924715376408, 15081.698366032686, 15089.849101508982, 13736.313184340768, 13828.792568111487, 13846.930765346184, 13848.09987350824, 14771.852281477182, 813.8168911994799, 817.0726225733805, 822.6627082896014, 824.6495239523209, 826.9173082691713, 819.4223072733708, 825.1789469477848, 828.8383765165795, 832.6419639554989, 832.8958880139983, 861.0958493581745, 869.4870026684255, 870.4951128345544, 870.6430363550945, 871.2768402226137, 858.9269912057482, 861.1388611388611, 866.7356456280831, 868.0494858130337, 868.7741187291286, 621.7295476467751, 626.7962912053555, 628.5725706519565, 629.3360504667573, 629.3894921925724, 13602.31988400576, 13607.251601161932, 13619.659508512268, 13623.04638675293, 13643.658908527266, 13275.137116087424, 13539.458421663121, 13683.452661893512, 13705.657358566015, 13812.654683632889, 11394.829077563843, 11588.362640054793, 11838.940805295919, 11910.940445297805, 12034.037277017906, 3821.617838216184, 3895.2793733159456, 3905.7070719695853, 4009.67922566194, 4016.0562267867026, 51947.22079168815, 52726.736366318306, 52727.47272527302, 53156.0, 53611.19583206255, 10183.43991080483, 10368.844467332996, 10826.729331766612, 10934.835977460345, 11292.209545331913, 17940.19269132892, 18030.2787888483, 18300.450986470427, 18379.72430413545, 18823.0, 8293.543855087908, 8360.205780450848, 8404.327653787683, 8421.115782842835, 8590.484570925764, 4596.862094137181, 4737.715737055719, 4836.450563972128, 4945.332380128709, 4957.553820156203, 3180.7773455858332, 3183.793053451518, 3191.441497737933, 3200.9679903201136, 3202.2634793997513, 593.2673148661399, 604.5737754882797, 609.326694003129, 617.6911544227886, 618.653554009756, 673.9654630142708, 731.5208538407352, 744.7356188553094, 770.2720928722416, 784.5606460382204, 9398.577064032135, 9541.634225709142, 9627.56675949584, 9716.0, 9772.902270977342, 713.0231582731691, 734.1850545894054, 752.1500704204324, 764.1545667213728, 769.6036541181296, 4402.911941761146, 4453.242948698729, 4477.843275485342, 4488.685791994529, 4604.654650901196, 60405.0, 60595.39404605985, 60904.390956090756, 60910.69544652337, 60999.0, 50603.24095138576, 50671.746641267295, 50728.0, 52310.738446308285, 53022.469775302525, 46911.999999999316, 47224.5277547227, 47578.5242147581, 48114.51885481171, 48232.758836206296, 9754.609815607297, 9895.950520247352, 9919.801603967735, 9976.187990594377, 10026.240707453375, 37111.6288837119, 37341.4398784013, 38065.4290185653, 38288.042798929135, 38979.0, 45502.67724566161, 48356.51643483661, 48707.512924870294, 48768.756156218995, 49446.752766235935, 11599.130065244972, 12517.436715347649, 12528.561500347809, 12573.74852502963, 12940.352982350656, 12958.157719748186, 13040.478380864659, 13060.738785224432, 13080.215187088805, 13163.078584499377, 11913.0, 12266.141370104007, 12526.311052892179, 12553.0, 12785.296808675612, 12501.0, 12659.303738294482, 12662.620121396372, 12665.430055647334, 13037.217766934014, 12513.061520385825, 12513.311767852856, 12676.429560669976, 12697.80953285683, 13130.606081817561, 10397.42814145199, 10629.202809789142, 10633.468326583485, 10787.0, 11103.389313587508, 10622.8406573903, 10638.202134839763, 10709.732256693645, 10714.839277411002, 10837.187210959051], "unit": "score", "name": "yui.html", "value": 6783.71450540747}], "name": "dromaeo_css", "value": 7061.8847381083115}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 110.0, 113.0, 111.0, 100.0, 112.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 158.0, 169.0, 134.0, 153.0, 159.0, 129.0, 174.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 164.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 111.0, 100.0, 72.0, 72.0, 71.0, 122.0, 104.0, 74.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 150.0, 93.0, 93.0, 93.0, 140.0, 92.0, 92.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 147.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 56.0, 57.0, 56.0, 57.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 64.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.4}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 79.0, 80.0, 79.0, 80.0, 79.0, 80.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 113.0, 114.0, 126.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.7}, {"lowerIsBetter": true, "replicates": [144.0, 131.0, 139.0, 138.0, 134.0, 131.0, 140.0, 139.0, 140.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.3}, {"lowerIsBetter": true, "replicates": [65.0, 76.0, 70.0, 65.0, 65.0, 64.0, 65.0, 70.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1487.2}]} 05:37:04 INFO - Return code: 0 05:37:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:04 ERROR - # TBPL SUCCESS # 05:37:04 INFO - Running post-action listener: _resource_record_post_action 05:37:04 INFO - Running post-run listener: _resource_record_post_run 05:37:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 20480; Write bytes: 301432832; Read time: 32; Write time: 278792 05:37:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13864960; Read time: 0; Write time: 3412 05:37:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 20480; Write bytes: 285118464; Read time: 32; Write time: 273912 05:37:05 INFO - Running post-run listener: _upload_blobber_files 05:37:05 INFO - Blob upload gear active. 05:37:05 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:37:05 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:05 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'] 05:37:05 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 05:37:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:06 INFO - (blobuploader) - INFO - Done attempting. 05:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:07 INFO - (blobuploader) - INFO - Done attempting. 05:37:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:07 INFO - Return code: 0 05:37:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:37:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/204436721d9ce8ac4bf6f2c27224ffd5dc90f45d8114080dc989e699105321af4820623ba8944f1dba0f8e70e91f7fd6150cc775a1649e51aa34727b770132e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/876c7332d8981910412e792b57c3f563c6f9723f6b29b8bd06cb6a1febeae3a7619733d88a0f4db0ab7b253fa5e4f15a3140b41d8111861f10e621dbacc1fde4"} 05:37:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:37:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:37:07 INFO - Contents: 05:37:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/204436721d9ce8ac4bf6f2c27224ffd5dc90f45d8114080dc989e699105321af4820623ba8944f1dba0f8e70e91f7fd6150cc775a1649e51aa34727b770132e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/876c7332d8981910412e792b57c3f563c6f9723f6b29b8bd06cb6a1febeae3a7619733d88a0f4db0ab7b253fa5e4f15a3140b41d8111861f10e621dbacc1fde4"} 05:37:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:07 INFO - Copying logs to upload dir... 05:37:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:37:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.347483 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-24 05:37:07.478949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 05:37:07.486053) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 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/204436721d9ce8ac4bf6f2c27224ffd5dc90f45d8114080dc989e699105321af4820623ba8944f1dba0f8e70e91f7fd6150cc775a1649e51aa34727b770132e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/876c7332d8981910412e792b57c3f563c6f9723f6b29b8bd06cb6a1febeae3a7619733d88a0f4db0ab7b253fa5e4f15a3140b41d8111861f10e621dbacc1fde4"} build_url:https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/fcyHjfIpSEqLcpz0EJD4-A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/204436721d9ce8ac4bf6f2c27224ffd5dc90f45d8114080dc989e699105321af4820623ba8944f1dba0f8e70e91f7fd6150cc775a1649e51aa34727b770132e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/876c7332d8981910412e792b57c3f563c6f9723f6b29b8bd06cb6a1febeae3a7619733d88a0f4db0ab7b253fa5e4f15a3140b41d8111861f10e621dbacc1fde4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 05:37:07.513652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:37:07.513986) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458817841.405053-1767928313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:37:07.596264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 05:37:07.596569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 05:37:07.599387) ========= ========= Total master_lag: 0.60 =========