builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1457750430.44 results: success (0) buildid: 20160311160029 builduid: cc79e15a4dc24abfa7c3aab1ab32b2c9 revision: edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.440370) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.440873) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.441207) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006202 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.465101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.465449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.480273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.480868) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.530924) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.531267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.531724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.532046) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 18:40:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-03-11 18:40:31 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.727799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.728141) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.777902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:30.778601) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 --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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 18:40:31,600 truncating revision to first 12 chars 2016-03-11 18:40:31,600 Setting DEBUG logging. 2016-03-11 18:40:31,600 attempt 1/10 2016-03-11 18:40:31,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/edcc2ad52ece?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 18:40:32,003 unpacking tar archive at: mozilla-aurora-edcc2ad52ece/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714502 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:31.508806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:31.509237) ========= echo edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'edcc2ad52ece9427517f1bc7d1d4e9497ed479f6'] 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 program finished with exit code 0 elapsedTime=0.003666 script_repo_revision: 'edcc2ad52ece9427517f1bc7d1d4e9497ed479f6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:31.558954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:31.559324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 18:40:31.570259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-03-11 18:40:31.570707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:40:32 INFO - MultiFileLogger online at 20160311 18:40:32 in /builds/slave/test-pgo 18:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:40:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:40:32 INFO - {'append_to_log': False, 18:40:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:40:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:40:32 INFO - 'branch': 'Mozilla-Aurora', 18:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:32 INFO - 'config_files': ('talos/linux_config.py',), 18:40:32 INFO - 'default_actions': ('clobber', 18:40:32 INFO - 'read-buildbot-config', 18:40:32 INFO - 'download-and-extract', 18:40:32 INFO - 'populate-webroot', 18:40:32 INFO - 'create-virtualenv', 18:40:32 INFO - 'install', 18:40:32 INFO - 'run-tests'), 18:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:32 INFO - 'download_minidump_stackwalk': True, 18:40:32 INFO - 'download_symbols': 'ondemand', 18:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:32 INFO - 'installer_path': 'installer.exe', 18:40:32 INFO - 'log_level': 'info', 18:40:32 INFO - 'log_name': 'talos', 18:40:32 INFO - 'log_to_console': True, 18:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:40:32 INFO - 'opt_config_files': (), 18:40:32 INFO - 'pip_index': False, 18:40:32 INFO - 'sps_profile': False, 18:40:32 INFO - 'sps_profile_interval': 0, 18:40:32 INFO - 'suite': 'dromaeojs', 18:40:32 INFO - 'system_bits': '32', 18:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:32 INFO - 'title': 'talos-linux64-ix-057', 18:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:32 INFO - 'use_talos_json': True, 18:40:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:32 INFO - 'work_dir': 'build'} 18:40:32 INFO - ##### 18:40:32 INFO - ##### Running clobber step. 18:40:32 INFO - ##### 18:40:32 INFO - Running pre-action listener: _resource_record_pre_action 18:40:32 INFO - Running main action method: clobber 18:40:32 INFO - rmtree: /builds/slave/test-pgo/build 18:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:40:32 INFO - Running post-action listener: _resource_record_post_action 18:40:32 INFO - ##### 18:40:32 INFO - ##### Running read-buildbot-config step. 18:40:32 INFO - ##### 18:40:32 INFO - Running pre-action listener: _resource_record_pre_action 18:40:32 INFO - Running main action method: read_buildbot_config 18:40:32 INFO - Using buildbot properties: 18:40:32 INFO - { 18:40:32 INFO - "project": "", 18:40:32 INFO - "product": "firefox", 18:40:32 INFO - "script_repo_revision": "production", 18:40:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:40:32 INFO - "repository": "", 18:40:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:40:32 INFO - "buildid": "20160311160029", 18:40:32 INFO - "pgo_build": "True", 18:40:32 INFO - "basedir": "/builds/slave/test-pgo", 18:40:32 INFO - "buildnumber": 350, 18:40:32 INFO - "slavename": "talos-linux64-ix-057", 18:40:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:40:32 INFO - "platform": "ubuntu64_hw", 18:40:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:40:32 INFO - "branch": "mozilla-aurora", 18:40:32 INFO - "repo_path": "releases/mozilla-aurora", 18:40:32 INFO - "revision": "edcc2ad52ece9427517f1bc7d1d4e9497ed479f6", 18:40:32 INFO - "stage_platform": "linux64-pgo", 18:40:32 INFO - "builduid": "cc79e15a4dc24abfa7c3aab1ab32b2c9", 18:40:32 INFO - "slavebuilddir": "test" 18:40:32 INFO - } 18:40:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 18:40:32 INFO - Running post-action listener: _resource_record_post_action 18:40:32 INFO - ##### 18:40:32 INFO - ##### Running download-and-extract step. 18:40:32 INFO - ##### 18:40:32 INFO - Running pre-action listener: _resource_record_pre_action 18:40:32 INFO - Running main action method: download_and_extract 18:40:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:32 INFO - https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:40:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:40:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:40:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:40:33 INFO - Downloaded 1448 bytes. 18:40:33 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:40:33 INFO - Using the following test package requirements: 18:40:33 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:40:33 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:40:33 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:40:33 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'jsshell-linux-x86_64.zip'], 18:40:33 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:40:33 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:40:33 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:40:33 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:40:33 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:40:33 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:40:33 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:40:33 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:40:33 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')]} 18:40:33 INFO - https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:40:34 INFO - Downloaded 23305728 bytes. 18:40:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:40:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:40:35 INFO - Return code: 0 18:40:35 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:35 INFO - https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:40:37 INFO - Downloaded 23305728 bytes. 18:40:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:40:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:40:38 INFO - Return code: 0 18:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:38 INFO - https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:40:39 INFO - Downloaded 10845161 bytes. 18:40:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:40:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:40:39 INFO - Return code: 0 18:40:39 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')]} 18:40:39 INFO - https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:40:41 INFO - Downloaded 60418737 bytes. 18:40:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:40:41 INFO - mkdir: /builds/slave/test-pgo/properties 18:40:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:40:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:40:41 INFO - Contents: 18:40:41 INFO - build_url:https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:40:41 INFO - Running post-action listener: _resource_record_post_action 18:40:41 INFO - Running post-action listener: set_extra_try_arguments 18:40:41 INFO - ##### 18:40:41 INFO - ##### Running populate-webroot step. 18:40:41 INFO - ##### 18:40:41 INFO - Running pre-action listener: _resource_record_pre_action 18:40:41 INFO - Running main action method: populate_webroot 18:40:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:40:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:40:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:40:41 INFO - '--tppagecycles', 18:40:41 INFO - '7'], 18:40:41 INFO - 'tests': ['tsvgm']}}, 18:40:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:40:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:40:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:40:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:40:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'tests': ['damp', 'tps']}, 18:40:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['damp', 'tps']}, 18:40:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:40:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:41 INFO - 'other': {'tests': ['a11yr', 18:40:41 INFO - 'ts_paint', 18:40:41 INFO - 'tpaint', 18:40:41 INFO - 'sessionrestore', 18:40:41 INFO - 'sessionrestore_no_auto_restore', 18:40:41 INFO - 'tabpaint']}, 18:40:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['a11yr', 18:40:41 INFO - 'ts_paint', 18:40:41 INFO - 'tpaint', 18:40:41 INFO - 'sessionrestore', 18:40:41 INFO - 'sessionrestore_no_auto_restore', 18:40:41 INFO - 'tabpaint']}, 18:40:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['a11yr', 18:40:41 INFO - 'ts_paint', 18:40:41 INFO - 'tpaint', 18:40:41 INFO - 'sessionrestore', 18:40:41 INFO - 'sessionrestore_no_auto_restore', 18:40:41 INFO - 'tabpaint']}, 18:40:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['a11yr', 18:40:41 INFO - 'ts_paint', 18:40:41 INFO - 'tpaint', 18:40:41 INFO - 'sessionrestore', 18:40:41 INFO - 'sessionrestore_no_auto_restore', 18:40:41 INFO - 'tabpaint']}, 18:40:41 INFO - 'other_l64': {'tests': ['a11yr', 18:40:41 INFO - 'ts_paint', 18:40:41 INFO - 'tpaint', 18:40:41 INFO - 'sessionrestore', 18:40:41 INFO - 'sessionrestore_no_auto_restore', 18:40:41 INFO - 'tabpaint']}, 18:40:41 INFO - 'other_nol64': {'tests': ['a11yr', 18:40:41 INFO - 'ts_paint', 18:40:41 INFO - 'tpaint', 18:40:41 INFO - 'sessionrestore', 18:40:41 INFO - 'sessionrestore_no_auto_restore', 18:40:41 INFO - 'tabpaint']}, 18:40:41 INFO - 'svgr': {'tests': ['tsvgx', 18:40:41 INFO - 'tsvgr_opacity', 18:40:41 INFO - 'tart', 18:40:41 INFO - 'tscrollx', 18:40:41 INFO - 'cart']}, 18:40:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['tsvgx', 18:40:41 INFO - 'tsvgr_opacity', 18:40:41 INFO - 'tart', 18:40:41 INFO - 'tscrollx', 18:40:41 INFO - 'cart']}, 18:40:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'tests': ['tp5o']}, 18:40:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'talos_options': ['--e10s'], 18:40:41 INFO - 'tests': ['tp5o']}, 18:40:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'talos_options': ['--xperf_path', 18:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:41 INFO - 'tests': ['tp5n']}, 18:40:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:41 INFO - 'talos_options': ['--e10s', 18:40:41 INFO - '--xperf_path', 18:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:41 INFO - 'tests': ['tp5n']}}, 18:40:41 INFO - 'talos.zip': {'path': '', 18:40:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:40:41 INFO - Running post-action listener: _resource_record_post_action 18:40:41 INFO - ##### 18:40:41 INFO - ##### Running create-virtualenv step. 18:40:41 INFO - ##### 18:40:41 INFO - Running pre-action listener: _resource_record_pre_action 18:40:41 INFO - Running main action method: create_virtualenv 18:40:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:40:41 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 18:40:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:40:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:42 INFO - Using real prefix '/usr' 18:40:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:40:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:44 INFO - Installing pip.................done. 18:40:44 INFO - Return code: 0 18:40:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:40:44 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')]} 18:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:44 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')]} 18:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:44 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:44 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 18:40:44 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 18:40:44 INFO - Using env: {'DISPLAY': ':0', 18:40:44 INFO - 'HOME': '/home/cltbld', 18:40:44 INFO - 'LANG': 'en_US.UTF-8', 18:40:44 INFO - 'LANGUAGE': 'en_US:en', 18:40:44 INFO - 'LOGNAME': 'cltbld', 18:40:44 INFO - 'MAIL': '/var/mail/cltbld', 18:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:44 INFO - 'MOZ_NO_REMOTE': '1', 18:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:44 INFO - 'NO_EM_RESTART': '1', 18:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:44 INFO - 'SHELL': '/bin/bash', 18:40:44 INFO - 'SHLVL': '1', 18:40:44 INFO - 'TERM': 'linux', 18:40:44 INFO - 'TMOUT': '86400', 18:40:44 INFO - 'USER': 'cltbld', 18:40:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:44 INFO - '_': '/tools/buildbot/bin/python'} 18:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:44 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 18:40:44 INFO - Cleaning up... 18:40:44 INFO - Return code: 0 18:40:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:40:44 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')]} 18:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:44 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')]} 18:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:44 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:44 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 18:40:44 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 18:40:44 INFO - Using env: {'DISPLAY': ':0', 18:40:44 INFO - 'HOME': '/home/cltbld', 18:40:44 INFO - 'LANG': 'en_US.UTF-8', 18:40:44 INFO - 'LANGUAGE': 'en_US:en', 18:40:44 INFO - 'LOGNAME': 'cltbld', 18:40:44 INFO - 'MAIL': '/var/mail/cltbld', 18:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:44 INFO - 'MOZ_NO_REMOTE': '1', 18:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:44 INFO - 'NO_EM_RESTART': '1', 18:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:44 INFO - 'SHELL': '/bin/bash', 18:40:44 INFO - 'SHLVL': '1', 18:40:44 INFO - 'TERM': 'linux', 18:40:44 INFO - 'TMOUT': '86400', 18:40:44 INFO - 'USER': 'cltbld', 18:40:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:44 INFO - '_': '/tools/buildbot/bin/python'} 18:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:44 INFO - Downloading/unpacking psutil>=0.7.1 18:40:44 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 18:40:44 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 18:40:44 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 18:40:44 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 18:40:44 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 18:40:44 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 18:40:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:46 INFO - Installing collected packages: psutil 18:40:46 INFO - Running setup.py install for psutil 18:40:46 INFO - building 'psutil._psutil_linux' extension 18:40:46 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 18:40:47 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 18:40:47 INFO - building 'psutil._psutil_posix' extension 18:40:47 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 18:40:47 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 18:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:47 INFO - Successfully installed psutil 18:40:47 INFO - Cleaning up... 18:40:47 INFO - Return code: 0 18:40:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:40:47 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')]} 18:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:47 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')]} 18:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:47 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:47 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 18:40:47 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 18:40:47 INFO - Using env: {'DISPLAY': ':0', 18:40:47 INFO - 'HOME': '/home/cltbld', 18:40:47 INFO - 'LANG': 'en_US.UTF-8', 18:40:47 INFO - 'LANGUAGE': 'en_US:en', 18:40:47 INFO - 'LOGNAME': 'cltbld', 18:40:47 INFO - 'MAIL': '/var/mail/cltbld', 18:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:47 INFO - 'MOZ_NO_REMOTE': '1', 18:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:47 INFO - 'NO_EM_RESTART': '1', 18:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:47 INFO - 'SHELL': '/bin/bash', 18:40:47 INFO - 'SHLVL': '1', 18:40:47 INFO - 'TERM': 'linux', 18:40:47 INFO - 'TMOUT': '86400', 18:40:47 INFO - 'USER': 'cltbld', 18:40:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:47 INFO - '_': '/tools/buildbot/bin/python'} 18:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:40:47 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 18:40:47 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 18:40:47 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 18:40:47 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 18:40:47 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 18:40:47 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 18:40:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:40:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:40:49 INFO - Installing collected packages: mozsystemmonitor 18:40:49 INFO - Running setup.py install for mozsystemmonitor 18:40:49 INFO - Successfully installed mozsystemmonitor 18:40:49 INFO - Cleaning up... 18:40:49 INFO - Return code: 0 18:40:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:49 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:49 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 18:40:49 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 18:40:49 INFO - Using env: {'DISPLAY': ':0', 18:40:49 INFO - 'HOME': '/home/cltbld', 18:40:49 INFO - 'LANG': 'en_US.UTF-8', 18:40:49 INFO - 'LANGUAGE': 'en_US:en', 18:40:49 INFO - 'LOGNAME': 'cltbld', 18:40:49 INFO - 'MAIL': '/var/mail/cltbld', 18:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:49 INFO - 'MOZ_NO_REMOTE': '1', 18:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:49 INFO - 'NO_EM_RESTART': '1', 18:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:49 INFO - 'SHELL': '/bin/bash', 18:40:49 INFO - 'SHLVL': '1', 18:40:49 INFO - 'TERM': 'linux', 18:40:49 INFO - 'TMOUT': '86400', 18:40:49 INFO - 'USER': 'cltbld', 18:40:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:49 INFO - '_': '/tools/buildbot/bin/python'} 18:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:49 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 18:40:49 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 18:40:49 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 18:40:49 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 18:40:49 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 18:40:49 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 18:40:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:40:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:52 INFO - Downloading docopt-0.6.1.tar.gz 18:40:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:52 INFO - Running setup.py install for blobuploader 18:40:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:40:52 INFO - Running setup.py install for requests 18:40:52 INFO - Running setup.py install for docopt 18:40:52 INFO - Successfully installed blobuploader requests docopt 18:40:52 INFO - Cleaning up... 18:40:53 INFO - Return code: 0 18:40:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:40: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')]} 18:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40: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')]} 18:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:53 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:53 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 18:40:53 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 18:40:53 INFO - Using env: {'DISPLAY': ':0', 18:40:53 INFO - 'HOME': '/home/cltbld', 18:40:53 INFO - 'LANG': 'en_US.UTF-8', 18:40:53 INFO - 'LANGUAGE': 'en_US:en', 18:40:53 INFO - 'LOGNAME': 'cltbld', 18:40:53 INFO - 'MAIL': '/var/mail/cltbld', 18:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:53 INFO - 'MOZ_NO_REMOTE': '1', 18:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:53 INFO - 'NO_EM_RESTART': '1', 18:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:53 INFO - 'SHELL': '/bin/bash', 18:40:53 INFO - 'SHLVL': '1', 18:40:53 INFO - 'TERM': 'linux', 18:40:53 INFO - 'TMOUT': '86400', 18:40:53 INFO - 'USER': 'cltbld', 18:40:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:53 INFO - '_': '/tools/buildbot/bin/python'} 18:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:40:53 INFO - Running setup.py (path:/tmp/pip-Xt0Q5F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:40:53 INFO - Running setup.py (path:/tmp/pip-G0wtdb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:40:53 INFO - Running setup.py (path:/tmp/pip-5vs2UW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:40:53 INFO - Running setup.py (path:/tmp/pip-UpdA5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:40:53 INFO - Running setup.py (path:/tmp/pip-sRUfX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:40:53 INFO - Running setup.py (path:/tmp/pip-qjdKsP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:40:53 INFO - Running setup.py (path:/tmp/pip-SVW9qV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:40:53 INFO - Running setup.py (path:/tmp/pip-Zj9I4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:40:53 INFO - Running setup.py (path:/tmp/pip-6PRxqG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:40:53 INFO - Running setup.py (path:/tmp/pip-IoV7dD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:40:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:40:53 INFO - Running setup.py (path:/tmp/pip-5RvkY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:40:54 INFO - Running setup.py (path:/tmp/pip-l7CFH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:40:54 INFO - Running setup.py (path:/tmp/pip-465ym3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:40:54 INFO - Running setup.py (path:/tmp/pip-L5I5NM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:40:54 INFO - Running setup.py (path:/tmp/pip-BR12UH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:40:54 INFO - Running setup.py (path:/tmp/pip-XQnOWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:40:54 INFO - Running setup.py (path:/tmp/pip-guVAjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:40:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:54 INFO - Running setup.py install for manifestparser 18:40:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:40:54 INFO - Running setup.py install for mozcrash 18:40:54 INFO - Running setup.py install for mozdebug 18:40:54 INFO - Running setup.py install for mozdevice 18:40:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:40:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:40:54 INFO - Running setup.py install for mozfile 18:40:55 INFO - Running setup.py install for mozhttpd 18:40:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for mozinfo 18:40:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for mozInstall 18:40:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for mozleak 18:40:55 INFO - Running setup.py install for mozlog 18:40:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for moznetwork 18:40:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for mozprocess 18:40:55 INFO - Running setup.py install for mozprofile 18:40:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for mozrunner 18:40:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:40:55 INFO - Running setup.py install for mozscreenshot 18:40:56 INFO - Running setup.py install for moztest 18:40:56 INFO - Running setup.py install for mozversion 18:40:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:40:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:56 INFO - Cleaning up... 18:40:56 INFO - Return code: 0 18:40:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:56 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 18:40:56 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 18:40:56 INFO - Using env: {'DISPLAY': ':0', 18:40:56 INFO - 'HOME': '/home/cltbld', 18:40:56 INFO - 'LANG': 'en_US.UTF-8', 18:40:56 INFO - 'LANGUAGE': 'en_US:en', 18:40:56 INFO - 'LOGNAME': 'cltbld', 18:40:56 INFO - 'MAIL': '/var/mail/cltbld', 18:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:56 INFO - 'MOZ_NO_REMOTE': '1', 18:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:56 INFO - 'NO_EM_RESTART': '1', 18:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:56 INFO - 'SHELL': '/bin/bash', 18:40:56 INFO - 'SHLVL': '1', 18:40:56 INFO - 'TERM': 'linux', 18:40:56 INFO - 'TMOUT': '86400', 18:40:56 INFO - 'USER': 'cltbld', 18:40:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:56 INFO - '_': '/tools/buildbot/bin/python'} 18:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:40:56 INFO - Running setup.py (path:/tmp/pip-lm1y3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:40:56 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)) 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:40:56 INFO - Running setup.py (path:/tmp/pip-_Sb2p7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:40:56 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)) 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:40:56 INFO - Running setup.py (path:/tmp/pip-lk38d9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:40:56 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)) 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:40:56 INFO - Running setup.py (path:/tmp/pip-UP4Rgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:40:56 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)) 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:40:56 INFO - Running setup.py (path:/tmp/pip-N_PsBH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:40:56 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)) 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:40:56 INFO - Running setup.py (path:/tmp/pip-iHVVPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:40:56 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)) 18:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:40:56 INFO - Running setup.py (path:/tmp/pip-bz2qJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:40:57 INFO - Running setup.py (path:/tmp/pip-aGfmXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:40:57 INFO - Running setup.py (path:/tmp/pip-ntmbEQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:40:57 INFO - Running setup.py (path:/tmp/pip-8IvF2l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:40:57 INFO - Running setup.py (path:/tmp/pip-59jgb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:40:57 INFO - Running setup.py (path:/tmp/pip-gExVQl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:40:57 INFO - Running setup.py (path:/tmp/pip-PUJ2AQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:40:57 INFO - Running setup.py (path:/tmp/pip-JwF9Fp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:40:57 INFO - Running setup.py (path:/tmp/pip-gnnoJ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:40:57 INFO - Running setup.py (path:/tmp/pip-o9JHu2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:40:57 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)) 18:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:40:57 INFO - Running setup.py (path:/tmp/pip-mQF8S7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:40:57 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)) 18:40:57 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)) 18:40:57 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)) 18:40:57 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)) 18:40:57 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)) 18:40:57 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)) 18:40:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40:59 INFO - Downloading blessings-1.6.tar.gz 18:40:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:59 INFO - Installing collected packages: blessings 18:40:59 INFO - Running setup.py install for blessings 18:40:59 INFO - Successfully installed blessings 18:40:59 INFO - Cleaning up... 18:40:59 INFO - Return code: 0 18:40:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:40:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:40:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:40:59 INFO - Reading from file tmpfile_stdout 18:40:59 INFO - Current package versions: 18:40:59 INFO - argparse == 1.2.1 18:40:59 INFO - blessings == 1.6 18:40:59 INFO - blobuploader == 1.2.4 18:40:59 INFO - docopt == 0.6.1 18:40:59 INFO - manifestparser == 1.1 18:40:59 INFO - mozInstall == 1.12 18:40:59 INFO - mozcrash == 0.17 18:40:59 INFO - mozdebug == 0.1 18:40:59 INFO - mozdevice == 0.48 18:40:59 INFO - mozfile == 1.2 18:40:59 INFO - mozhttpd == 0.7 18:40:59 INFO - mozinfo == 0.9 18:40:59 INFO - mozleak == 0.1 18:40:59 INFO - mozlog == 3.1 18:40:59 INFO - moznetwork == 0.27 18:40:59 INFO - mozprocess == 0.22 18:40:59 INFO - mozprofile == 0.28 18:40:59 INFO - mozrunner == 6.11 18:40:59 INFO - mozscreenshot == 0.1 18:40:59 INFO - mozsystemmonitor == 0.0 18:40:59 INFO - moztest == 0.7 18:40:59 INFO - mozversion == 1.4 18:40:59 INFO - psutil == 3.1.1 18:40:59 INFO - requests == 1.2.3 18:40:59 INFO - wsgiref == 0.1.2 18:40:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:59 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:40:59 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 18:40:59 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 18:40:59 INFO - Using env: {'DISPLAY': ':0', 18:40:59 INFO - 'HOME': '/home/cltbld', 18:40:59 INFO - 'LANG': 'en_US.UTF-8', 18:40:59 INFO - 'LANGUAGE': 'en_US:en', 18:40:59 INFO - 'LOGNAME': 'cltbld', 18:40:59 INFO - 'MAIL': '/var/mail/cltbld', 18:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:59 INFO - 'MOZ_NO_REMOTE': '1', 18:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:59 INFO - 'NO_EM_RESTART': '1', 18:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:59 INFO - 'SHELL': '/bin/bash', 18:40:59 INFO - 'SHLVL': '1', 18:40:59 INFO - 'TERM': 'linux', 18:40:59 INFO - 'TMOUT': '86400', 18:40:59 INFO - 'USER': 'cltbld', 18:40:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:59 INFO - '_': '/tools/buildbot/bin/python'} 18:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 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)) 18:41:00 INFO - Cleaning up... 18:41:00 INFO - Return code: 0 18:41:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:41:00 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')]} 18:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:00 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')]} 18:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:00 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:41:00 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 18:41:00 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 18:41:00 INFO - Using env: {'DISPLAY': ':0', 18:41:00 INFO - 'HOME': '/home/cltbld', 18:41:00 INFO - 'LANG': 'en_US.UTF-8', 18:41:00 INFO - 'LANGUAGE': 'en_US:en', 18:41:00 INFO - 'LOGNAME': 'cltbld', 18:41:00 INFO - 'MAIL': '/var/mail/cltbld', 18:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:00 INFO - 'MOZ_NO_REMOTE': '1', 18:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:00 INFO - 'NO_EM_RESTART': '1', 18:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:00 INFO - 'SHELL': '/bin/bash', 18:41:00 INFO - 'SHLVL': '1', 18:41:00 INFO - 'TERM': 'linux', 18:41:00 INFO - 'TMOUT': '86400', 18:41:00 INFO - 'USER': 'cltbld', 18:41:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:00 INFO - '_': '/tools/buildbot/bin/python'} 18:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:00 INFO - Downloading/unpacking jsonschema 18:41:00 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 18:41:00 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 18:41:00 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 18:41:00 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 18:41:00 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 18:41:00 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 18:41:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:02 INFO - Downloading/unpacking functools32 (from jsonschema) 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:02 INFO - warning: no files found matching '*.txt' 18:41:02 INFO - no previously-included directories found matching 'build' 18:41:02 INFO - no previously-included directories found matching 'dist' 18:41:02 INFO - no previously-included directories found matching '.git*' 18:41:02 INFO - Installing collected packages: jsonschema, functools32 18:41:02 INFO - Running setup.py install for functools32 18:41:02 INFO - warning: no files found matching '*.txt' 18:41:02 INFO - no previously-included directories found matching 'build' 18:41:02 INFO - no previously-included directories found matching 'dist' 18:41:02 INFO - no previously-included directories found matching '.git*' 18:41:02 INFO - Successfully installed jsonschema functools32 18:41:02 INFO - Cleaning up... 18:41:02 INFO - Return code: 0 18:41:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:41:02 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')]} 18:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:02 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')]} 18:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:02 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 0x7f2e3f263f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a56d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', '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 18:41:02 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 18:41:02 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 18:41:02 INFO - Using env: {'DISPLAY': ':0', 18:41:02 INFO - 'HOME': '/home/cltbld', 18:41:02 INFO - 'LANG': 'en_US.UTF-8', 18:41:02 INFO - 'LANGUAGE': 'en_US:en', 18:41:02 INFO - 'LOGNAME': 'cltbld', 18:41:02 INFO - 'MAIL': '/var/mail/cltbld', 18:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:02 INFO - 'MOZ_NO_REMOTE': '1', 18:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:02 INFO - 'NO_EM_RESTART': '1', 18:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:02 INFO - 'SHELL': '/bin/bash', 18:41:02 INFO - 'SHLVL': '1', 18:41:02 INFO - 'TERM': 'linux', 18:41:02 INFO - 'TMOUT': '86400', 18:41:02 INFO - 'USER': 'cltbld', 18:41:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:02 INFO - '_': '/tools/buildbot/bin/python'} 18:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:02 INFO - Downloading/unpacking flake8 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 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 18:41:02 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 18:41:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:41:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:41:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 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 18:41:04 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 18:41:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:41:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:05 INFO - no previously-included directories found matching 'docs/_build' 18:41:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:41:05 INFO - Running setup.py install for pep8 18:41:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:05 INFO - no previously-included directories found matching 'docs/_build' 18:41:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:41:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:41:05 INFO - Cleaning up... 18:41:05 INFO - Return code: 0 18:41:05 INFO - Running post-action listener: _resource_record_post_action 18:41:05 INFO - Running post-action listener: _start_resource_monitoring 18:41:05 INFO - Starting resource monitoring. 18:41:05 INFO - ##### 18:41:05 INFO - ##### Running install step. 18:41:05 INFO - ##### 18:41:05 INFO - Running pre-action listener: _resource_record_pre_action 18:41:05 INFO - Running main action method: install 18:41:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:41:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:41:05 INFO - Reading from file tmpfile_stdout 18:41:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:41:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:41:06 INFO - Reading from file tmpfile_stdout 18:41:06 INFO - Output received: 18:41:06 INFO - Usage: mozinstall [options] installer 18:41:06 INFO - Options: 18:41:06 INFO - -h, --help show this help message and exit 18:41:06 INFO - -d DEST, --destination=DEST 18:41:06 INFO - Directory to install application into. [default: 18:41:06 INFO - "/builds/slave/test-pgo"] 18:41:06 INFO - --app=APP Application being installed. [default: firefox] 18:41:06 INFO - mkdir: /builds/slave/test-pgo/build/application 18:41:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:41:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:41:21 INFO - Reading from file tmpfile_stdout 18:41:21 INFO - Output received: 18:41:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:41:21 INFO - Running post-action listener: _resource_record_post_action 18:41:21 INFO - ##### 18:41:21 INFO - ##### Running run-tests step. 18:41:21 INFO - ##### 18:41:21 INFO - Running pre-action listener: _resource_record_pre_action 18:41:21 INFO - Running main action method: run_tests 18:41:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:41:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:41:21 INFO - Python 2.7.3 18:41:21 INFO - Return code: 0 18:41:21 INFO - grabbing minidump binary from tooltool 18:41:21 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')]} 18:41:21 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 0x2934920>, '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 0x2935820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2935cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:41:21 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 18:41:21 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 18:41:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:21 INFO - Return code: 0 18:41:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:41:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:41:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:41:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:41:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:41:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:41:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:41:22 INFO - Return code: 0 18:41:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 18:41:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 18:41:22 INFO - Using env: {'DISPLAY': ':0', 18:41:22 INFO - 'HOME': '/home/cltbld', 18:41:22 INFO - 'LANG': 'en_US.UTF-8', 18:41:22 INFO - 'LANGUAGE': 'en_US:en', 18:41:22 INFO - 'LOGNAME': 'cltbld', 18:41:22 INFO - 'MAIL': '/var/mail/cltbld', 18:41:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:41:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:22 INFO - 'MOZ_NO_REMOTE': '1', 18:41:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:22 INFO - 'NO_EM_RESTART': '1', 18:41:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:22 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:41:22 INFO - 'SHELL': '/bin/bash', 18:41:22 INFO - 'SHLVL': '1', 18:41:22 INFO - 'TERM': 'linux', 18:41:22 INFO - 'TMOUT': '86400', 18:41:22 INFO - 'USER': 'cltbld', 18:41:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232', 18:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:22 INFO - '_': '/tools/buildbot/bin/python'} 18:41:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 18:41:22 INFO - mozversion application_buildid: 20160311160029 18:41:22 INFO - mozversion application_changeset: edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 18:41:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:41:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:22 INFO - mozversion application_name: Firefox 18:41:22 INFO - mozversion application_remotingname: firefox-dev 18:41:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:41:22 INFO - mozversion application_vendor: Mozilla 18:41:22 INFO - mozversion application_version: 47.0a2 18:41:22 INFO - mozversion platform_buildid: 20160311160029 18:41:22 INFO - mozversion platform_changeset: edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 18:41:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:41:22 INFO - mozversion platform_version: 47.0a2 18:41:22 INFO - using testdate: 1457750482 18:41:22 INFO - actual date: 1457750482 18:41:22 INFO - starting webserver on 'localhost:34865' 18:41:22 INFO - SUITE-START | Running 2 tests 18:41:22 INFO - TEST-START | dromaeo_css 18:41:22 INFO - operating with platform_type : linux_ 18:41:22 INFO - Initialising browser for dromaeo_css test... 18:41:22 INFO - TEST-INFO | started process 331 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIHhMAI/profile http://localhost:34865/getInfo.html) 18:41:26 INFO - PROCESS | 331 | __metrics Screen width/height:1600/1200 18:41:26 INFO - PROCESS | 331 | colorDepth:24 18:41:26 INFO - PROCESS | 331 | Browser inner width/height: 1024/697 18:41:26 INFO - PROCESS | 331 | __metrics 18:41:27 INFO - PROCESS | 331 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:28 INFO - TEST-INFO | 331: exit 0 18:41:28 INFO - Browser initialized. 18:41:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:28 INFO - TEST-INFO | started process 427 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIHhMAI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:40 INFO - PROCESS | 427 | RSS: Main: 142934016 18:41:40 INFO - PROCESS | 427 | 18:42:31 INFO - PROCESS | 427 | 1457750551957 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] 18:44:39 INFO - PROCESS | 427 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34865/tests/dromaeo/cssquery-ext.html) 18:44:40 INFO - PROCESS | 427 | RSS: Main: 255152128 18:44:40 INFO - PROCESS | 427 | 18:47:42 INFO - PROCESS | 427 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-ext.html (next: http://localhost:34865/tests/dromaeo/cssquery-jquery.html) 18:47:42 INFO - PROCESS | 427 | RSS: Main: 229396480 18:47:42 INFO - PROCESS | 427 | 18:50:44 INFO - PROCESS | 427 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34865/tests/dromaeo/cssquery-mootools.html) 18:50:45 INFO - PROCESS | 427 | RSS: Main: 219811840 18:50:45 INFO - PROCESS | 427 | 18:53:47 INFO - PROCESS | 427 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34865/tests/dromaeo/cssquery-prototype.html) 18:53:47 INFO - PROCESS | 427 | RSS: Main: 199086080 18:53:47 INFO - PROCESS | 427 | 18:56:50 INFO - PROCESS | 427 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34865/tests/dromaeo/cssquery-yui.html) 18:56:50 INFO - PROCESS | 427 | RSS: Main: 212586496 18:56:50 INFO - PROCESS | 427 | 18:59:52 INFO - PROCESS | 427 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-yui.html (next: http://localhost:34865/tests/dromaeo/cssquery-dojo.html) 18:59:53 INFO - PROCESS | 427 | RSS: Main: 249237504 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | __start_tp_report 18:59:53 INFO - PROCESS | 427 | _x_x_mozilla_page_load 18:59:53 INFO - PROCESS | 427 | _x_x_mozilla_page_load_details 18:59:53 INFO - PROCESS | 427 | |i|pagename|runs| 18:59:53 INFO - PROCESS | 427 | |0;dojo.html;3237.5791147150867;3292.275699346146;3331.0839519132237;3332.0170549687855;3357.4292370297053;5288.8413347599535;5289.841304760858;5325.174597937316;5336.839894803153;5338.733063346826;5323.281357016802;5337.626366154371;5361.0618141825125;5365.731713414333;5366.060939335611;4752.952470475303;4890.828820991257;4891.413030436335;4943.530364615356;4956.256561515784;4843.443004054526;4940.752962351868;4944.480829512903;4947.03532811102;4950.257461380804;4806.4232292125;4854.466008739054;4861.052094841507;4861.319415281863;4936.925946110811;4756.524347565216;4789.521047895218;4793.328933949268;4804.783784729678;4805.951940480585;4711.623070154379;4747.715137091785;4848.10310092634;4862.17343051682;4875.9760450305475;5042.747862606855;5049.267856160873;5066.0374528839775;5068.974655126738;5082.059818933509;5506.449355064502;5553.250311208016;5579.246801681802;5588.385277619459;5680.147977803321;5594.300712410949;5602.327720673505;5603.691796951166;5614.6631202128;5631.014572449846;5202.479752024805;5204.193350030751;5204.479552044765;5208.140656791663;5245.423003469616;5719.056355701263;5722.74247658848;5765.538756899438;5847.502962248172;5940.108983652401;5704.71476426177;5715.771369145187;5721.141828725725;5723.198752174699;5723.484886360247;5770.826875193751;5791.652500849962;5794.333651630117;5796.739146738407;5797.217375654317;5449.99175152598;5698.515626171739;5724.141378793214;5766.798162064308;5794.768209271582;5563.165525171256;5570.860728481739;5581.776728930798;5584.832455026356;5584.972075139598;4310.1983710588365;4314.956850431518;4318.697691161651;4323.962249060203;4344.9348259776125;3903.9609603903596;3939.9015024624614;3971.582983786661;4004.6796256299426;4026.879193624196;5257.947420525822;5303.337082864642;5309.256704061435;5323.361196656426;5341.919871201935;5537.750801213955;5619.016672082369;5623.465770751772;5628.986782379129;5639.802606908821;5391.865203369947;5436.374816896028;5445.754941027663;5445.809396671177;5486.753096110685;4961.751912404366;4981.327520784647;4987.276844857548;4990.550850423407;5018.723970181675;5791.652500849962;5860.355360910296;5940.34656187819;5956.315023772322;5960.135780311917;5771.451712087429;5796.1305804129715;5801.448862358069;5803.622764520462;5809.099589563624;5958.255218097738;5963.165156878127;5965.8806823862415;5967.761289548543;5969.552283578836;5506.201600767947;5675.375708671961;5685.090385538294;5691.4877661010705;5696.8006119785605;5775.162601422686;5793.652380857162;5800.187973683604;5803.7388317524965;5806.68063256525;5624.718764061862;5661.895930293554;5665.20687103814;5665.631733937281;5683.090705487102;5524.475174858382;5566.944330556643;5589;5639.182318563703;5653.660780353192;5449.564034877121;5462.808801691922;5473.726313684379;5477.123660214346;5489.560835133259;5613.607047506799;5642.746076426489;5663.32040155184;5665.971670141623;5669.603127781016;5302.840914772563;5365.758540865749;5393.811216607557;5475.534579560782;5495.835124946258 18:59:53 INFO - PROCESS | 427 | |1;ext.html;552.997235013825;563.0709329606146;567.1832561111999;571.3001573072986;606.7512319948822;30144.698553014463;38801.41797873031;38970.61029389705;39041.41437878434;39057.609423905786;42365.57634423655;42783.35824962628;42897.35653965193;42930.14139717212;42941.570584294146;8699.695510657128;8881.822363552725;8887;8891.42205756627;8892.199702026815;8725.825483490325;8904.421212621191;8925.95537022314;8928.151825576593;9146.085391460834;8946.86579701305;9164.908350916505;9181.49501777402;9182.449053056804;9185.219256363183;8899.199072083511;9104.226140778042;9122.315826313054;9122.817543649157;9125.99614042458;8940.64237430502;9040.41237319572;9043.819123617557;9046.728598142066;9082.636694532212;42144.36783448251;42748;42855;42986.140277194594;43048.3542746859;3844.0774214188673;3884.514435695538;4105.733127346743;4382.715123516961;4582.6104781093645;32164.517532237034;32652.183695407566;32653.83673081643;32863.342733145204;32970;3752.5309336332957;3757.5866654667966;3874.418837174418;3942.704297177723;4009.51885773709;267102;267700.6614966932;268097;268300;268862;60765;60775.392246076975;61191.69404152951;61215;61230.38769612247;65069;71341.64329178321;72528.27471725321;72571.63714181501;72592.63703681553;15308.770368444482;15521.922390387976;15543.533693989199;15548.378064877505;15559;11266.155038372155;11322.433878306052;11349.886501135048;11356.54573817038;11357.37534435614;21277.148914043573;21666.674999875013;21667.67498487524;21671.56656866854;21681.45796355072;8555.315574754004;8650.188688676206;8777.341699372573;8806.295496360275;8896;1005.2058873490007;1009.3086235928413;1022.3916769522123;1041.5156952017348;1079.1366906474789;26872.865635672086;27132.186034418603;27302.180934571996;27649.447011059667;27829.721702782714;1097.9451027448595;1116.1405717597404;1137.3914955498933;1203.3441774233063;1203.9879601204052;14643.56069317922;14692;14721.92639036798;15118.09291442517;15563.22183890801;415088;420062;421360;421951;422032;59065;59167.70416147978;59446.70276648676;59795.70102149461;59824.401755982755;1270.2061211742662;1467.7578199596946;1491.1649476293528;1520.8935374523678;1590.4671934901937;28491.28771780722;28757;30116.69883301139;30476.542851857685;31351;46873.53126468691;47066;47446.52553474421;47454.52545474639;47528.287075694585;238413;238578;244508;245358;245631;29859.402811944074;36341.27317453583;36630;37072.07319817026;37157.628423716495;43890.78054609706;44088.11823763571;44132.11735765202;44239.77880110707;44631;37068.629313706515;37113.814430927676;37349.81325093357;37532;37911.81044094762;36349.0912727184;36763.44854827126;36922;37119.257614848095;37166;36834.8158259207;37761.81119094387;38124;38167.80916095402;38235;35908.820455897556;36773.63226367809;37050;37505.81247093747;37528.81235593805;26212.60681089747;27153.72846271512;27212.863935680194;27220.01068861656;27422.314442139104 18:59:53 INFO - PROCESS | 427 | |2;jquery.html;386.50141317700167;389.63569062926166;390.54696551999666;392.62614474751257;402.5692509015355;17630.118494075294;18099.095045247752;18163.273469061223;18185;18506.352277670252;17103.57241068974;17190.484285471455;17665.20506577204;17672.64654706905;18582.721259181122;5555.583331250163;5684.261046064006;5689.715514224293;5718.056520674084;5721.456461636138;5303.124984377573;5437.238786569884;5464.12573988162;5636.436356364351;5683.374828768853;5384.434634363394;5396.973015134939;5410.756515956772;5411.404745477994;5415.377231618355;5388.649737767052;5402.9729851350885;5412.729363531827;5439.292891924025;5468.179773034037;5209.426963034063;5277.551408130314;5313.857520633043;5316.813911513079;5331.813386531491;13022.804657930139;14490;21408.35774926739;21451;21477.89261053685;2403.6875206223253;2781.443711257736;2933.9559906601417;3002.8198308101582;3028.3489049854165;9546.522673866279;9816.509174541245;10102.494875256209;10405.323653962469;10472.790544189149;1953.394447721211;1957.6476234277825;1961.2743284984504;1983.7917018712972;2001.3895761792648;48839.75580122112;57804.71097644485;59216.70391648014;62074.689626551575;66325.66837165832;10440.42577658236;10510.842337364946;10605.522751476203;10680;10710.143188545053;12920.612381628565;13953.162810231419;24539.754602453748;25447.74552254491;25558.744412556007;9221.077892210726;9261.30540209487;9385.765355866022;9386.436813791195;9674.613015479303;7299.927000729925;7389.889151662729;7411.221821708751;7587;7731.884021739678;8353.20644538768;8388.706395276136;8446.57767111642;8492.447990880573;8510.063892971768;3195.5685982392542;3237.2668829488666;3251;3298.65364136767;3313.950290745641;952.852307892264;1001.1790331927895;1058.3755584205203;1082.924195306321;1104.9613363438343;16972.76569180689;17054.14729263532;17331.65336693259;17843.553911152067;17900.641987160445;995.581855620641;1029.1098200056897;1030.1707125763683;1047.528612124547;1087.065123993365;9503.952480237693;10127.898721012696;10144.188464922789;10146.441945693057;10263.640772572924;410752;448112;448239;449447;453215;71945.28054719491;73916;76933;77688;77999;1033.5865653738415;1046.2048842879467;1048.4548035021746;1050.8633877596017;1064.1486810551528;15221.238938053275;15375.692486150438;15433.289682817429;15443.382264709286;15485.612859678598;26765.330866728487;28148.71851281461;32624.184395390304;32787.67212327846;34560.65439345675;46342.76828615835;47124.76437617927;47342.52657473519;48171.036579267515;49094.26358604695;8085.474444161111;8185.590720463834;8279.337652987868;8328;8406.159384061544;12685.556005539762;12883.935580322039;12890.162139460905;13032.609021729364;13083.738325233633;10985;11491.138164637518;11510.53957841677;11664.541932258468;11877.524899003944;11628.6511404658;11706.180567360203;11713.824292635447;11835.82246266324;11936.70158246016;11404.372759498307;11735.23720958135;11743.236689615147;11863.169578129447;12117.939410303245;8299.917000829915;8392.076871544248;8395.370347224105;8459.534725590152;8563.82872342562;8735;10487.213458990758;10531.315464494783;10645.680629581126;10739.496470494294 18:59:53 INFO - PROCESS | 427 | |3;mootools.html;1470.0738534723137;1524.4588171199227;1531.6017835362804;1810.4568629411174;1985.513549180451;8285.627146778394;8480.406371553978;8482.703105391312;8485.236328730412;8490.830183396329;7948.165442628528;8080.070791858938;8083.878741818878;8098.149694282104;8099.028116626013;2169.327508472371;2397.9040838366445;2410;2440.4508985478215;2458.7787099161073;2453.6319552067152;2470.2712699753615;2479.454520005596;2481.6649752283483;2483.3046746910895;2459.225344016629;2491.725910149891;2492.028109037477;2492.439201179738;2493.3143385568933;2390.509945461185;2409.3253888911045;2429.7327293997646;2433.111914151322;2433.537627850703;2426.041713523166;2429.2955043037496;2434;2441.7680320369536;2447.5349683560066;8804;8810.911890881072;8883.866741998876;8884.200421962054;8894.644214231488;5161.2516185152945;5233.816816411445;5294.470552944713;5302.734863256822;5305.814296499604;3199.392115498048;3251.1059458648824;3282.1302354875975;3300.9009729708146;3301.1417031571723;1046.7801761629992;1061.2677252695614;1072.217281384586;1072.8337107748312;1106.1095817866615;12192.207506512137;12222.938885305517;12225.816612750816;12231.633051008484;12247.081468889779;4742.146413645577;4778.95361487493;4806.038792241566;4843.2735089736825;4895.241237608177;10288.639897603547;10310.020548048073;10326.122279606167;10327.380357178594;10346.27576069683;4838.854834354905;5211.140161873249;5342.2787923630585;5354.4645535446925;5361.758720857571;4538.160440318552;4621.260598304255;4628.74541900192;4629.884252893705;4677.298405239173;3838.2131663009573;3898.590647981978;3961.088949541564;4016.176683779818;4046.676265898721;1269.5873841001712;1309.260267948606;1317.5783749200164;1323.3647849032325;1332.460353556811;1211.0432758121162;1216.2823933878876;1289.5551034892947;1327.4491086199118;1336.1315145155727;8436.789080273042;8437.451565648213;8483.321334293241;8493.490390576586;8501.914980850112;509.1523848598839;516.1148630099398;519.9168133098686;523.2909407752517;526.9578433725293;6247.531435142382;6338.239411270677;6341.270753863365;6345.428911397904;6432.74269029243;10659.360438373567;10866.348019118877;10893.346399216072;11060.059894909024;11077.390743509022;10576.41829699374;10787;10823.13414926804;10853.34879907208;10934.289271197347;8327.333813294801;8362.414630975773;8396.748097557083;8453.873191902127;8473.322134229371;7848.058233011847;7853.410994175574;7858.724944626911;7921.1682773307975;7944.801379965547;9132.360734748503;9318.906810931803;9320.860187097334;9442.48066356357;9451.480168590793;9483.762905927131;9607.327487075838;9675.854862176931;9803.117719405287;9822.901770982198;6791.490638202055;6962.268961758942;7141.714331426892;7704.26809453101;7764.611769411394;8201.26188643025;8205.83588328242;8233.135520770473;8264.669413223644;8264.876026859722;7288.635568221674;7397;7401.59291238987;7487.625618719151;7652.273034061755;7303.196648368569;7617.885731714139;7630.2751238632245;7698.153203147761;7707.92292077072;7726.304632583095;7774;7805.687772489264;7809.492382995087;7812.92187078122;7083.964580177066;7095.787126386217;7102.5028248022145;7126.750563730245;7163.820904477429;7139.143302803489;7163;7166.964165179141;7189.964050179716;7200.243974382614 18:59:53 INFO - PROCESS | 427 | |4;prototype.html;360.85746130278534;362.7388280438084;365.6380183618219;366.19619934244326;366.5399923096513;5908.231929849125;5916.437938395857;5922.963481390756;5931.436513531213;5937.495312898409;5859.736311865966;5860.912086318709;5871.677057761822;5872.823815285537;5873.148393482953;4409.360642706822;4508.5491450854815;4604.355390245369;4617.353570500141;4632.745199014053;4585.358049873021;4610.654200934943;4624.583787459128;4625.352450656911;4633.698809577367;4567.885802854938;4584.51862554432;4586.105709386671;4588.105319462706;4591.77041147943;4443.688941774077;4461.241588929906;4532.8866778330475;4547.886302842422;4549.931751023704;3996.660283875874;4003.5796241394523;4003.579624139482;4006.198760247962;4012.378081397359;5556.499915007668;5562.694051827148;5565.2486914266465;5573.359063707644;5575.2473416088715;5276.419593844674;5288.68267903927;5291.86770330741;5295.179247216687;5300.893982120375;6199.225096862892;6199.783007594712;6200.131981522591;6202.162708034402;6204.906926396107;4298.699091063627;4412.338149277634;4413.9117217655785;4437.556244375537;4441.311596702516;6471.967640161816;6493.318201588812;6517.902231466532;6521.706523206467;6530.216374035099;4553.931691024637;4554.453465584151;4556.476005259371;4557.772111394417;4562.520935301745;4593.609543188866;4597.770111494478;4605.332226827091;4612.215923293048;4614.446266448048;5275.287836142148;5277.234800953917;5288.365396152486;5288.471152884681;5292.894142117136;6154.353792851775;6268.874622507525;6300.1494798202575;6307.2431308242385;6310.432061114522;1603.2224371180203;1617.9321647712454;1627.1294857251314;1629.4459883639383;1631.5921019745065;1035.5598870480017;1087.782443511285;1108.9722756931142;1145.118258940611;1157.1205883528578;6020.187274717945;6022.789202377896;6023.939760602338;6027.819165425044;6027.8794424111275;6385.712642931079;6390.392912673288;6414.262359828586;6424.775132870327;6429.3570642936265;5970.164177015221;6038.516918646497;6047.092936059538;6047.78832740852;6052.969735151384;3445.4659527773233;3450.654934506529;3466.5666791651042;3466.687998080185;3470.6529347065093;6510.479161667055;6661.966690166518;6663.400293973566;6678.565893216925;6682.365175308338;6539.444147247537;6582.24304205013;6583.650351677895;6588.8352791180605;6591.934080659132;6654.367835055662;6657.034729964225;6657.966710166418;6660.034295027097;6670.599764014175;6357.396047375492;6369.554131210771;6374.521910856612;6376.4580010697755;6376.776812811529;6154.415330543591;6268.498520118288;6304.684765761602;6304.747810087729;6320.683965801783;6647.9002814958785;6659.534902321481;6659.667016649051;6663.566868153554;6672.633005184762;4710.81156753726;4713.104510143062;4718.669693121448;4720.929186062143;4726.409198850144;6393.104965304768;6393.4885209184085;6399.136116624196;6400.935990640221;6405.647689377129;6102.786402475892;6227.252729672468;6232.657203853651;6233.844153896189;6238.656873871799;6221.875562488634;6229.5327850410495;6231.345708700703;6237.438630523275;6238.6880655967925;6060.303065147565;6078.6048906820915;6085.543584231112;6090.330063692902;6094.2077529920825;6238.937610623836;6239.781607643892;6243.656598887105;6252.718627661857;6253.093301471352;6001.4598686116715;6089.360617135137;6112.480439162543;6113.84715382119;6116.724747386289 18:59:53 INFO - PROCESS | 427 | |5;yui.html;780.4536824223045;793.0800271684847;863.4042510667639;893.1559676106074;904.9095090490947;14436.206008669518;14474.638134046654;14537;14572.27138643069;14613.853861461383;13008.739825203515;14291.285435728223;14464.783028254584;14489.49286774963;14496.347664355102;751.515272649141;897.4884315939917;899.4872922434215;910.6630546697731;926.5321012888481;902.3548163063408;903.1961554216753;903.3631289940577;904.1184844776357;909.822584596004;957.7414098193484;958.2094771813247;958.8897276813186;959.3572306554626;977.2524019125375;785.9921400786005;956.6986399284203;961.8461046232569;964.2912459342377;965.5703212070596;710.8969199466101;711.3491155592626;711.6157275071455;713.005357526248;713.5005496152662;14466.71066578673;14566.4901728439;14581;14612.926935365254;14622.195779232137;13511.256880871548;13669.316534173351;13819.723605527934;14169.716605667933;14463.987520873543;11139.498722557504;11157.776844463066;11411.372374519398;11754;11801.645950621494;3798.5821559628694;3829.636184562462;3839.616038396166;3841.750286231414;3842.2315536892734;50199;50957.74521127408;51701;51870.22194667083;51949.48050519484;11009.724756880982;11168.050715689258;11178.552857885594;11214.10287177024;11333.26333788301;20503.28238511645;20563.177472900916;20569.382918512467;20579.971001449867;20592.485187870425;7992.880106798402;8162.551059691656;8261.463004904663;8439.915600844035;8450.15808626142;4722.5513576210205;4772.546608072227;4876.317315575822;4895.828645997373;4951.653384263067;3354.4129777288877;3380.983095084509;3382.458806590934;3385.4921761735936;3389.8983030509125;559.7732918168149;583.3000399520507;613.5275837605019;635.1552435261092;650.3204151661525;706.7102487979904;733.6478490324674;741.8219627289411;756.3684323589864;761.3072104384983;8799.780005499786;8906.465612063297;8955.238804701674;8980.146886045815;9437.905620943702;550.2913453726203;554.0829926471696;610.9816705498843;617.9011358182669;678.6878036103448;4234.449521562177;4300.225959327351;4365.192439398721;4415.801288942005;4523.7285762854335;57562.424375755705;57604.71197643985;57834.84330313454;58189.41810581925;58424.707876461194;48318.27522587164;49234;50120.24819627708;50123.74938125286;51765.2235216472;48237.75881120572;48344.27483587749;48406.757966209945;48663;48768.512314876396;9184;9270;9328.95335523318;9407.388519746195;9438;35939.64060359468;36616;37370.626293736714;37677.24645507129;37815.810920945216;43825.34261986137;48274.75862620665;48762;48902;48988;10766.62316818939;10884.891151088705;11193.776124477628;11196;11582.305061696325;12285.385730713608;12343.506259749869;12830.871691282968;12842.935785321013;12952.740945180854;10227.43749093807;11665.894519749783;12306.138570299992;12622.179558328678;12765.872341276468;11946.163768536466;12040.939795300967;12250.142490025613;12480.68798280014;13005.804912926125;11634.36011019402;11658.12564057716;11976.820347694616;12257.816132758195;12639.115261931576;9351.38020664447;9473.66842160521;9634.807303853744;9887.456189909624;10354.275200735876;9853.408795472295;9865.009856026976;9917.900820991697;9934.801303974025;9995.750106247402 18:59:53 INFO - PROCESS | 427 | __end_tp_report 18:59:53 INFO - PROCESS | 427 | __start_cc_report 18:59:53 INFO - PROCESS | 427 | _x_x_mozilla_cycle_collect,879 18:59:53 INFO - PROCESS | 427 | __end_cc_report 18:59:53 INFO - PROCESS | 427 | __startTimestamp1457751593123__endTimestamp 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | ------- Summary: start ------- 18:59:53 INFO - PROCESS | 427 | Number of tests: 6 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | [#0] dojo.html Cycles:165 Average:5297.56 Median:5477.12 stddev:576.44 (10.5%) stddev-sans-first:555.10 18:59:53 INFO - PROCESS | 427 | Values: 3237.6 3292.3 3331.1 3332.0 3357.4 5288.8 5289.8 5325.2 5336.8 5338.7 5323.3 5337.6 5361.1 5365.7 5366.1 4753.0 4890.8 4891.4 4943.5 4956.3 4843.4 4940.8 4944.5 4947.0 4950.3 4806.4 4854.5 4861.1 4861.3 4936.9 4756.5 4789.5 4793.3 4804.8 4806.0 4711.6 4747.7 4848.1 4862.2 4876.0 5042.7 5049.3 5066.0 5069.0 5082.1 5506.4 5553.3 5579.2 5588.4 5680.1 5594.3 5602.3 5603.7 5614.7 5631.0 5202.5 5204.2 5204.5 5208.1 5245.4 5719.1 5722.7 5765.5 5847.5 5940.1 5704.7 5715.8 5721.1 5723.2 5723.5 5770.8 5791.7 5794.3 5796.7 5797.2 5450.0 5698.5 5724.1 5766.8 5794.8 5563.2 5570.9 5581.8 5584.8 5585.0 4310.2 4315.0 4318.7 4324.0 4344.9 3904.0 3939.9 3971.6 4004.7 4026.9 5257.9 5303.3 5309.3 5323.4 5341.9 5537.8 5619.0 5623.5 5629.0 5639.8 5391.9 5436.4 5445.8 5445.8 5486.8 4961.8 4981.3 4987.3 4990.6 5018.7 5791.7 5860.4 5940.3 5956.3 5960.1 5771.5 5796.1 5801.4 5803.6 5809.1 5958.3 5963.2 5965.9 5967.8 5969.6 5506.2 5675.4 5685.1 5691.5 5696.8 5775.2 5793.7 5800.2 5803.7 5806.7 5624.7 5661.9 5665.2 5665.6 5683.1 5524.5 5566.9 5589.0 5639.2 5653.7 5449.6 5462.8 5473.7 5477.1 5489.6 5613.6 5642.7 5663.3 5666.0 5669.6 5302.8 5365.8 5393.8 5475.5 5495.8 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | [#1] ext.html Cycles:180 Average:49079.39 Median:38145.90 stddev:84195.27 (220.7%) stddev-sans-first:84352.63 18:59:53 INFO - PROCESS | 427 | Values: 553.0 563.1 567.2 571.3 606.8 30144.7 38801.4 38970.6 39041.4 39057.6 42365.6 42783.4 42897.4 42930.1 42941.6 8699.7 8881.8 8887.0 8891.4 8892.2 8725.8 8904.4 8926.0 8928.2 9146.1 8946.9 9164.9 9181.5 9182.4 9185.2 8899.2 9104.2 9122.3 9122.8 9126.0 8940.6 9040.4 9043.8 9046.7 9082.6 42144.4 42748.0 42855.0 42986.1 43048.4 3844.1 3884.5 4105.7 4382.7 4582.6 32164.5 32652.2 32653.8 32863.3 32970.0 3752.5 3757.6 3874.4 3942.7 4009.5 267102.0 267700.7 268097.0 268300.0 268862.0 60765.0 60775.4 61191.7 61215.0 61230.4 65069.0 71341.6 72528.3 72571.6 72592.6 15308.8 15521.9 15543.5 15548.4 15559.0 11266.2 11322.4 11349.9 11356.5 11357.4 21277.1 21666.7 21667.7 21671.6 21681.5 8555.3 8650.2 8777.3 8806.3 8896.0 1005.2 1009.3 1022.4 1041.5 1079.1 26872.9 27132.2 27302.2 27649.4 27829.7 1097.9 1116.1 1137.4 1203.3 1204.0 14643.6 14692.0 14721.9 15118.1 15563.2 415088.0 420062.0 421360.0 421951.0 422032.0 59065.0 59167.7 59446.7 59795.7 59824.4 1270.2 1467.8 1491.2 1520.9 1590.5 28491.3 28757.0 30116.7 30476.5 31351.0 46873.5 47066.0 47446.5 47454.5 47528.3 238413.0 238578.0 244508.0 245358.0 245631.0 29859.4 36341.3 36630.0 37072.1 37157.6 43890.8 44088.1 44132.1 44239.8 44631.0 37068.6 37113.8 37349.8 37532.0 37911.8 36349.1 36763.4 36922.0 37119.3 37166.0 36834.8 37761.8 38124.0 38167.8 38235.0 35908.8 36773.6 37050.0 37505.8 37528.8 26212.6 27153.7 27212.9 27220.0 27422.3 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | [#2] jquery.html Cycles:180 Average:25896.19 Median:3111.96 stddev:72352.18 (2325.0%) stddev-sans-first:72529.80 18:59:53 INFO - PROCESS | 427 | Values: 386.5 389.6 390.5 392.6 402.6 17630.1 18099.1 18163.3 18185.0 18506.4 17103.6 17190.5 17665.2 17672.6 18582.7 5555.6 5684.3 5689.7 5718.1 5721.5 5303.1 5437.2 5464.1 5636.4 5683.4 5384.4 5397.0 5410.8 5411.4 5415.4 5388.6 5403.0 5412.7 5439.3 5468.2 5209.4 5277.6 5313.9 5316.8 5331.8 13022.8 14490.0 21408.4 21451.0 21477.9 2403.7 2781.4 2934.0 3002.8 3028.3 9546.5 9816.5 10102.5 10405.3 10472.8 1953.4 1957.6 1961.3 1983.8 2001.4 48839.8 57804.7 59216.7 62074.7 66325.7 10440.4 10510.8 10605.5 10680.0 10710.1 12920.6 13953.2 24539.8 25447.7 25558.7 9221.1 9261.3 9385.8 9386.4 9674.6 7299.9 7389.9 7411.2 7587.0 7731.9 8353.2 8388.7 8446.6 8492.4 8510.1 3195.6 3237.3 3251.0 3298.7 3314.0 952.9 1001.2 1058.4 1082.9 1105.0 16972.8 17054.1 17331.7 17843.6 17900.6 995.6 1029.1 1030.2 1047.5 1087.1 9504.0 10127.9 10144.2 10146.4 10263.6 410752.0 448112.0 448239.0 449447.0 453215.0 71945.3 73916.0 76933.0 77688.0 77999.0 1033.6 1046.2 1048.5 1050.9 1064.1 15221.2 15375.7 15433.3 15443.4 15485.6 26765.3 28148.7 32624.2 32787.7 34560.7 46342.8 47124.8 47342.5 48171.0 49094.3 8085.5 8185.6 8279.3 8328.0 8406.2 12685.6 12883.9 12890.2 13032.6 13083.7 10985.0 11491.1 11510.5 11664.5 11877.5 11628.7 11706.2 11713.8 11835.8 11936.7 11404.4 11735.2 11743.2 11863.2 12117.9 8299.9 8392.1 8395.4 8459.5 8563.8 8735.0 10487.2 10531.3 10645.7 10739.5 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | [#3] mootools.html Cycles:180 Average:6041.77 Median:2867.22 stddev:3247.09 (113.2%) stddev-sans-first:3238.02 18:59:53 INFO - PROCESS | 427 | Values: 1470.1 1524.5 1531.6 1810.5 1985.5 8285.6 8480.4 8482.7 8485.2 8490.8 7948.2 8080.1 8083.9 8098.1 8099.0 2169.3 2397.9 2410.0 2440.5 2458.8 2453.6 2470.3 2479.5 2481.7 2483.3 2459.2 2491.7 2492.0 2492.4 2493.3 2390.5 2409.3 2429.7 2433.1 2433.5 2426.0 2429.3 2434.0 2441.8 2447.5 8804.0 8810.9 8883.9 8884.2 8894.6 5161.3 5233.8 5294.5 5302.7 5305.8 3199.4 3251.1 3282.1 3300.9 3301.1 1046.8 1061.3 1072.2 1072.8 1106.1 12192.2 12222.9 12225.8 12231.6 12247.1 4742.1 4779.0 4806.0 4843.3 4895.2 10288.6 10310.0 10326.1 10327.4 10346.3 4838.9 5211.1 5342.3 5354.5 5361.8 4538.2 4621.3 4628.7 4629.9 4677.3 3838.2 3898.6 3961.1 4016.2 4046.7 1269.6 1309.3 1317.6 1323.4 1332.5 1211.0 1216.3 1289.6 1327.4 1336.1 8436.8 8437.5 8483.3 8493.5 8501.9 509.2 516.1 519.9 523.3 527.0 6247.5 6338.2 6341.3 6345.4 6432.7 10659.4 10866.3 10893.3 11060.1 11077.4 10576.4 10787.0 10823.1 10853.3 10934.3 8327.3 8362.4 8396.7 8453.9 8473.3 7848.1 7853.4 7858.7 7921.2 7944.8 9132.4 9318.9 9320.9 9442.5 9451.5 9483.8 9607.3 9675.9 9803.1 9822.9 6791.5 6962.3 7141.7 7704.3 7764.6 8201.3 8205.8 8233.1 8264.7 8264.9 7288.6 7397.0 7401.6 7487.6 7652.3 7303.2 7617.9 7630.3 7698.2 7707.9 7726.3 7774.0 7805.7 7809.5 7812.9 7084.0 7095.8 7102.5 7126.8 7163.8 7139.1 7163.0 7167.0 7190.0 7200.2 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | [#4] prototype.html Cycles:180 Average:5247.32 Median:5985.81 stddev:1543.88 (25.8%) stddev-sans-first:1504.02 18:59:53 INFO - PROCESS | 427 | Values: 360.9 362.7 365.6 366.2 366.5 5908.2 5916.4 5923.0 5931.4 5937.5 5859.7 5860.9 5871.7 5872.8 5873.1 4409.4 4508.5 4604.4 4617.4 4632.7 4585.4 4610.7 4624.6 4625.4 4633.7 4567.9 4584.5 4586.1 4588.1 4591.8 4443.7 4461.2 4532.9 4547.9 4549.9 3996.7 4003.6 4003.6 4006.2 4012.4 5556.5 5562.7 5565.2 5573.4 5575.2 5276.4 5288.7 5291.9 5295.2 5300.9 6199.2 6199.8 6200.1 6202.2 6204.9 4298.7 4412.3 4413.9 4437.6 4441.3 6472.0 6493.3 6517.9 6521.7 6530.2 4553.9 4554.5 4556.5 4557.8 4562.5 4593.6 4597.8 4605.3 4612.2 4614.4 5275.3 5277.2 5288.4 5288.5 5292.9 6154.4 6268.9 6300.1 6307.2 6310.4 1603.2 1617.9 1627.1 1629.4 1631.6 1035.6 1087.8 1109.0 1145.1 1157.1 6020.2 6022.8 6023.9 6027.8 6027.9 6385.7 6390.4 6414.3 6424.8 6429.4 5970.2 6038.5 6047.1 6047.8 6053.0 3445.5 3450.7 3466.6 3466.7 3470.7 6510.5 6662.0 6663.4 6678.6 6682.4 6539.4 6582.2 6583.7 6588.8 6591.9 6654.4 6657.0 6658.0 6660.0 6670.6 6357.4 6369.6 6374.5 6376.5 6376.8 6154.4 6268.5 6304.7 6304.7 6320.7 6647.9 6659.5 6659.7 6663.6 6672.6 4710.8 4713.1 4718.7 4720.9 4726.4 6393.1 6393.5 6399.1 6400.9 6405.6 6102.8 6227.3 6232.7 6233.8 6238.7 6221.9 6229.5 6231.3 6237.4 6238.7 6060.3 6078.6 6085.5 6090.3 6094.2 6238.9 6239.8 6243.7 6252.7 6253.1 6001.5 6089.4 6112.5 6113.8 6116.7 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - PROCESS | 427 | [#5] yui.html Cycles:180 Average:14521.88 Median:26819.16 stddev:16399.25 (61.1%) stddev-sans-first:16412.78 18:59:53 INFO - PROCESS | 427 | Values: 780.5 793.1 863.4 893.2 904.9 14436.2 14474.6 14537.0 14572.3 14613.9 13008.7 14291.3 14464.8 14489.5 14496.3 751.5 897.5 899.5 910.7 926.5 902.4 903.2 903.4 904.1 909.8 957.7 958.2 958.9 959.4 977.3 786.0 956.7 961.8 964.3 965.6 710.9 711.3 711.6 713.0 713.5 14466.7 14566.5 14581.0 14612.9 14622.2 13511.3 13669.3 13819.7 14169.7 14464.0 11139.5 11157.8 11411.4 11754.0 11801.6 3798.6 3829.6 3839.6 3841.8 3842.2 50199.0 50957.7 51701.0 51870.2 51949.5 11009.7 11168.1 11178.6 11214.1 11333.3 20503.3 20563.2 20569.4 20580.0 20592.5 7992.9 8162.6 8261.5 8439.9 8450.2 4722.6 4772.5 4876.3 4895.8 4951.7 3354.4 3381.0 3382.5 3385.5 3389.9 559.8 583.3 613.5 635.2 650.3 706.7 733.6 741.8 756.4 761.3 8799.8 8906.5 8955.2 8980.1 9437.9 550.3 554.1 611.0 617.9 678.7 4234.4 4300.2 4365.2 4415.8 4523.7 57562.4 57604.7 57834.8 58189.4 58424.7 48318.3 49234.0 50120.2 50123.7 51765.2 48237.8 48344.3 48406.8 48663.0 48768.5 9184.0 9270.0 9329.0 9407.4 9438.0 35939.6 36616.0 37370.6 37677.2 37815.8 43825.3 48274.8 48762.0 48902.0 48988.0 10766.6 10884.9 11193.8 11196.0 11582.3 12285.4 12343.5 12830.9 12842.9 12952.7 10227.4 11665.9 12306.1 12622.2 12765.9 11946.2 12040.9 12250.1 12480.7 13005.8 11634.4 11658.1 11976.8 12257.8 12639.1 9351.4 9473.7 9634.8 9887.5 10354.3 9853.4 9865.0 9917.9 9934.8 9995.8 18:59:53 INFO - PROCESS | 427 | -------- Summary: end -------- 18:59:53 INFO - PROCESS | 427 | 18:59:53 INFO - TEST-INFO | 427: exit 0 18:59:53 INFO - TEST-OK | dromaeo_css | took 1111213ms 18:59:53 INFO - TEST-START | kraken 18:59:53 INFO - operating with platform_type : linux_ 18:59:53 INFO - Initialising browser for kraken test... 18:59:53 INFO - TEST-INFO | started process 615 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdiFem2/profile http://localhost:34865/getInfo.html) 18:59:58 INFO - PROCESS | 615 | __metrics Screen width/height:1600/1200 18:59:58 INFO - PROCESS | 615 | colorDepth:24 18:59:58 INFO - PROCESS | 615 | Browser inner width/height: 1024/697 18:59:58 INFO - PROCESS | 615 | __metrics 18:59:59 INFO - PROCESS | 615 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:59:59 INFO - PROCESS | 615 | 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. 18:59:59 INFO - TEST-INFO | 615: exit 0 18:59:59 INFO - Browser initialized. 18:59:59 INFO - Running cycle 1/1 for kraken test... 18:59:59 INFO - TEST-INFO | started process 710 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdiFem2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:11 INFO - PROCESS | 710 | RSS: Main: 143208448 19:00:11 INFO - PROCESS | 710 | 19:00:14 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:14 INFO - PROCESS | 710 | RSS: Main: 179789824 19:00:14 INFO - PROCESS | 710 | 19:00:17 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-dft) 19:00:17 INFO - PROCESS | 710 | RSS: Main: 176492544 19:00:17 INFO - PROCESS | 710 | 19:00:20 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-fft) 19:00:21 INFO - PROCESS | 710 | RSS: Main: 175071232 19:00:21 INFO - PROCESS | 710 | 19:00:23 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-oscillator) 19:00:23 INFO - PROCESS | 710 | RSS: Main: 176001024 19:00:23 INFO - PROCESS | 710 | 19:00:26 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:26 INFO - PROCESS | 710 | RSS: Main: 172609536 19:00:26 INFO - PROCESS | 710 | 19:00:29 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34865/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:30 INFO - PROCESS | 710 | RSS: Main: 173506560 19:00:30 INFO - PROCESS | 710 | 19:00:33 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34865/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:34 INFO - PROCESS | 710 | RSS: Main: 175267840 19:00:34 INFO - PROCESS | 710 | 19:00:36 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34865/tests/kraken/driver.html?testName=json-parse-financial) 19:00:37 INFO - PROCESS | 710 | RSS: Main: 174522368 19:00:37 INFO - PROCESS | 710 | 19:00:39 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:39 INFO - PROCESS | 710 | RSS: Main: 180154368 19:00:39 INFO - PROCESS | 710 | 19:00:41 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:41 INFO - PROCESS | 710 | RSS: Main: 176967680 19:00:41 INFO - PROCESS | 710 | 19:00:43 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:44 INFO - PROCESS | 710 | RSS: Main: 182870016 19:00:44 INFO - PROCESS | 710 | 19:00:46 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:00:47 INFO - PROCESS | 710 | RSS: Main: 191078400 19:00:47 INFO - PROCESS | 710 | 19:00:50 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:00:50 INFO - PROCESS | 710 | RSS: Main: 191184896 19:00:50 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34865/tests/kraken/driver.html?testName=ai-astar) 19:00:52 INFO - PROCESS | 710 | RSS: Main: 250060800 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | __start_tp_report 19:00:52 INFO - PROCESS | 710 | _x_x_mozilla_page_load 19:00:52 INFO - PROCESS | 710 | _x_x_mozilla_page_load_details 19:00:52 INFO - PROCESS | 710 | |i|pagename|runs| 19:00:52 INFO - PROCESS | 710 | |0;ai-astar;109;111;105;111;111;112;100;110;110;109 19:00:52 INFO - PROCESS | 710 | |1;audio-beat-detection;147;131;152;163;124;153;150;126;164;125 19:00:52 INFO - PROCESS | 710 | |2;audio-dft;162;162;160;160;160;160;160;163;159;163 19:00:52 INFO - PROCESS | 710 | |3;audio-fft;74;76;72;160;76;75;73;75;158;75 19:00:52 INFO - PROCESS | 710 | |4;audio-oscillator;93;92;150;92;94;92;143;93;93;147 19:00:52 INFO - PROCESS | 710 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;116;117;117 19:00:52 INFO - PROCESS | 710 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;145 19:00:52 INFO - PROCESS | 710 | |7;imaging-desaturate;96;96;96;95;95;96;95;95;95;97 19:00:52 INFO - PROCESS | 710 | |8;json-parse-financial;57;56;55;53;54;54;52;61;51;52 19:00:52 INFO - PROCESS | 710 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;64;63;65 19:00:52 INFO - PROCESS | 710 | |10;stanford-crypto-aes;79;80;86;80;79;78;79;80;78;78 19:00:52 INFO - PROCESS | 710 | |11;stanford-crypto-ccm;128;111;115;120;111;118;112;115;112;111 19:00:52 INFO - PROCESS | 710 | |12;stanford-crypto-pbkdf2;145;135;142;145;145;133;144;146;142;141 19:00:52 INFO - PROCESS | 710 | |13;stanford-crypto-sha256-iterative;67;66;67;65;67;66;68;68;66;65 19:00:52 INFO - PROCESS | 710 | __end_tp_report 19:00:52 INFO - PROCESS | 710 | __start_cc_report 19:00:52 INFO - PROCESS | 710 | _x_x_mozilla_cycle_collect,1044 19:00:52 INFO - PROCESS | 710 | __end_cc_report 19:00:52 INFO - PROCESS | 710 | __startTimestamp1457751652528__endTimestamp 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | ------- Summary: start ------- 19:00:52 INFO - PROCESS | 710 | Number of tests: 14 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.65 (3.3%) stddev-sans-first:3.87 19:00:52 INFO - PROCESS | 710 | Values: 109.0 111.0 105.0 111.0 111.0 112.0 100.0 110.0 110.0 109.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:151.00 stddev:15.64 (10.4%) stddev-sans-first:16.54 19:00:52 INFO - PROCESS | 710 | Values: 147.0 131.0 152.0 163.0 124.0 153.0 150.0 126.0 164.0 125.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.48 19:00:52 INFO - PROCESS | 710 | Values: 162.0 162.0 160.0 160.0 160.0 160.0 160.0 163.0 159.0 163.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:35.65 (47.5%) stddev-sans-first:37.26 19:00:52 INFO - PROCESS | 710 | Values: 74.0 76.0 72.0 160.0 76.0 75.0 73.0 75.0 158.0 75.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.50 stddev:26.12 (28.2%) stddev-sans-first:27.06 19:00:52 INFO - PROCESS | 710 | Values: 93.0 92.0 150.0 92.0 94.0 92.0 143.0 93.0 93.0 147.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:00:52 INFO - PROCESS | 710 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 19:00:52 INFO - PROCESS | 710 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 19:00:52 INFO - PROCESS | 710 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 97.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:2.95 (5.4%) stddev-sans-first:2.99 19:00:52 INFO - PROCESS | 710 | Values: 57.0 56.0 55.0 53.0 54.0 54.0 52.0 61.0 51.0 52.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 19:00:52 INFO - PROCESS | 710 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 63.0 65.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.36 (3.0%) stddev-sans-first:2.49 19:00:52 INFO - PROCESS | 710 | Values: 79.0 80.0 86.0 80.0 79.0 78.0 79.0 80.0 78.0 78.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:115.00 stddev:5.46 (4.7%) stddev-sans-first:3.33 19:00:52 INFO - PROCESS | 710 | Values: 128.0 111.0 115.0 120.0 111.0 118.0 112.0 115.0 112.0 111.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:144.50 stddev:4.44 (3.1%) stddev-sans-first:4.56 19:00:52 INFO - PROCESS | 710 | Values: 145.0 135.0 142.0 145.0 145.0 133.0 144.0 146.0 142.0 141.0 19:00:52 INFO - PROCESS | 710 | 19:00:52 INFO - PROCESS | 710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 19:00:52 INFO - PROCESS | 710 | Values: 67.0 66.0 67.0 65.0 67.0 66.0 68.0 68.0 66.0 65.0 19:00:52 INFO - PROCESS | 710 | -------- Summary: end -------- 19:00:52 INFO - PROCESS | 710 | 19:00:53 INFO - TEST-INFO | 710: exit 0 19:00:53 INFO - TEST-OK | kraken | took 59639ms 19:00:53 INFO - SUITE-END | took 1170s 19:00:53 INFO - Completed test suite (00:19:31) 19:00:53 INFO - javascript benchmark 19:00:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3237.5791147150867, 3292.275699346146, 3331.0839519132237, 3332.0170549687855, 3357.4292370297053, 5288.8413347599535, 5289.841304760858, 5325.174597937316, 5336.839894803153, 5338.733063346826, 5323.281357016802, 5337.626366154371, 5361.0618141825125, 5365.731713414333, 5366.060939335611, 4752.952470475303, 4890.828820991257, 4891.413030436335, 4943.530364615356, 4956.256561515784, 4843.443004054526, 4940.752962351868, 4944.480829512903, 4947.03532811102, 4950.257461380804, 4806.4232292125, 4854.466008739054, 4861.052094841507, 4861.319415281863, 4936.925946110811, 4756.524347565216, 4789.521047895218, 4793.328933949268, 4804.783784729678, 4805.951940480585, 4711.623070154379, 4747.715137091785, 4848.10310092634, 4862.17343051682, 4875.9760450305475, 5042.747862606855, 5049.267856160873, 5066.0374528839775, 5068.974655126738, 5082.059818933509, 5506.449355064502, 5553.250311208016, 5579.246801681802, 5588.385277619459, 5680.147977803321, 5594.300712410949, 5602.327720673505, 5603.691796951166, 5614.6631202128, 5631.014572449846, 5202.479752024805, 5204.193350030751, 5204.479552044765, 5208.140656791663, 5245.423003469616, 5719.056355701263, 5722.74247658848, 5765.538756899438, 5847.502962248172, 5940.108983652401, 5704.71476426177, 5715.771369145187, 5721.141828725725, 5723.198752174699, 5723.484886360247, 5770.826875193751, 5791.652500849962, 5794.333651630117, 5796.739146738407, 5797.217375654317, 5449.99175152598, 5698.515626171739, 5724.141378793214, 5766.798162064308, 5794.768209271582, 5563.165525171256, 5570.860728481739, 5581.776728930798, 5584.832455026356, 5584.972075139598, 4310.1983710588365, 4314.956850431518, 4318.697691161651, 4323.962249060203, 4344.9348259776125, 3903.9609603903596, 3939.9015024624614, 3971.582983786661, 4004.6796256299426, 4026.879193624196, 5257.947420525822, 5303.337082864642, 5309.256704061435, 5323.361196656426, 5341.919871201935, 5537.750801213955, 5619.016672082369, 5623.465770751772, 5628.986782379129, 5639.802606908821, 5391.865203369947, 5436.374816896028, 5445.754941027663, 5445.809396671177, 5486.753096110685, 4961.751912404366, 4981.327520784647, 4987.276844857548, 4990.550850423407, 5018.723970181675, 5791.652500849962, 5860.355360910296, 5940.34656187819, 5956.315023772322, 5960.135780311917, 5771.451712087429, 5796.1305804129715, 5801.448862358069, 5803.622764520462, 5809.099589563624, 5958.255218097738, 5963.165156878127, 5965.8806823862415, 5967.761289548543, 5969.552283578836, 5506.201600767947, 5675.375708671961, 5685.090385538294, 5691.4877661010705, 5696.8006119785605, 5775.162601422686, 5793.652380857162, 5800.187973683604, 5803.7388317524965, 5806.68063256525, 5624.718764061862, 5661.895930293554, 5665.20687103814, 5665.631733937281, 5683.090705487102, 5524.475174858382, 5566.944330556643, 5589.0, 5639.182318563703, 5653.660780353192, 5449.564034877121, 5462.808801691922, 5473.726313684379, 5477.123660214346, 5489.560835133259, 5613.607047506799, 5642.746076426489, 5663.32040155184, 5665.971670141623, 5669.603127781016, 5302.840914772563, 5365.758540865749, 5393.811216607557, 5475.534579560782, 5495.835124946258], "unit": "score", "name": "dojo.html", "value": 5261.596484577149}, {"lowerIsBetter": false, "replicates": [552.997235013825, 563.0709329606146, 567.1832561111999, 571.3001573072986, 606.7512319948822, 30144.698553014463, 38801.41797873031, 38970.61029389705, 39041.41437878434, 39057.609423905786, 42365.57634423655, 42783.35824962628, 42897.35653965193, 42930.14139717212, 42941.570584294146, 8699.695510657128, 8881.822363552725, 8887.0, 8891.42205756627, 8892.199702026815, 8725.825483490325, 8904.421212621191, 8925.95537022314, 8928.151825576593, 9146.085391460834, 8946.86579701305, 9164.908350916505, 9181.49501777402, 9182.449053056804, 9185.219256363183, 8899.199072083511, 9104.226140778042, 9122.315826313054, 9122.817543649157, 9125.99614042458, 8940.64237430502, 9040.41237319572, 9043.819123617557, 9046.728598142066, 9082.636694532212, 42144.36783448251, 42748.0, 42855.0, 42986.140277194594, 43048.3542746859, 3844.0774214188673, 3884.514435695538, 4105.733127346743, 4382.715123516961, 4582.6104781093645, 32164.517532237034, 32652.183695407566, 32653.83673081643, 32863.342733145204, 32970.0, 3752.5309336332957, 3757.5866654667966, 3874.418837174418, 3942.704297177723, 4009.51885773709, 267102.0, 267700.6614966932, 268097.0, 268300.0, 268862.0, 60765.0, 60775.392246076975, 61191.69404152951, 61215.0, 61230.38769612247, 65069.0, 71341.64329178321, 72528.27471725321, 72571.63714181501, 72592.63703681553, 15308.770368444482, 15521.922390387976, 15543.533693989199, 15548.378064877505, 15559.0, 11266.155038372155, 11322.433878306052, 11349.886501135048, 11356.54573817038, 11357.37534435614, 21277.148914043573, 21666.674999875013, 21667.67498487524, 21671.56656866854, 21681.45796355072, 8555.315574754004, 8650.188688676206, 8777.341699372573, 8806.295496360275, 8896.0, 1005.2058873490007, 1009.3086235928413, 1022.3916769522123, 1041.5156952017348, 1079.1366906474789, 26872.865635672086, 27132.186034418603, 27302.180934571996, 27649.447011059667, 27829.721702782714, 1097.9451027448595, 1116.1405717597404, 1137.3914955498933, 1203.3441774233063, 1203.9879601204052, 14643.56069317922, 14692.0, 14721.92639036798, 15118.09291442517, 15563.22183890801, 415088.0, 420062.0, 421360.0, 421951.0, 422032.0, 59065.0, 59167.70416147978, 59446.70276648676, 59795.70102149461, 59824.401755982755, 1270.2061211742662, 1467.7578199596946, 1491.1649476293528, 1520.8935374523678, 1590.4671934901937, 28491.28771780722, 28757.0, 30116.69883301139, 30476.542851857685, 31351.0, 46873.53126468691, 47066.0, 47446.52553474421, 47454.52545474639, 47528.287075694585, 238413.0, 238578.0, 244508.0, 245358.0, 245631.0, 29859.402811944074, 36341.27317453583, 36630.0, 37072.07319817026, 37157.628423716495, 43890.78054609706, 44088.11823763571, 44132.11735765202, 44239.77880110707, 44631.0, 37068.629313706515, 37113.814430927676, 37349.81325093357, 37532.0, 37911.81044094762, 36349.0912727184, 36763.44854827126, 36922.0, 37119.257614848095, 37166.0, 36834.8158259207, 37761.81119094387, 38124.0, 38167.80916095402, 38235.0, 35908.820455897556, 36773.63226367809, 37050.0, 37505.81247093747, 37528.81235593805, 26212.60681089747, 27153.72846271512, 27212.863935680194, 27220.01068861656, 27422.314442139104], "unit": "score", "name": "ext.html", "value": 19405.190074091264}, {"lowerIsBetter": false, "replicates": [386.50141317700167, 389.63569062926166, 390.54696551999666, 392.62614474751257, 402.5692509015355, 17630.118494075294, 18099.095045247752, 18163.273469061223, 18185.0, 18506.352277670252, 17103.57241068974, 17190.484285471455, 17665.20506577204, 17672.64654706905, 18582.721259181122, 5555.583331250163, 5684.261046064006, 5689.715514224293, 5718.056520674084, 5721.456461636138, 5303.124984377573, 5437.238786569884, 5464.12573988162, 5636.436356364351, 5683.374828768853, 5384.434634363394, 5396.973015134939, 5410.756515956772, 5411.404745477994, 5415.377231618355, 5388.649737767052, 5402.9729851350885, 5412.729363531827, 5439.292891924025, 5468.179773034037, 5209.426963034063, 5277.551408130314, 5313.857520633043, 5316.813911513079, 5331.813386531491, 13022.804657930139, 14490.0, 21408.35774926739, 21451.0, 21477.89261053685, 2403.6875206223253, 2781.443711257736, 2933.9559906601417, 3002.8198308101582, 3028.3489049854165, 9546.522673866279, 9816.509174541245, 10102.494875256209, 10405.323653962469, 10472.790544189149, 1953.394447721211, 1957.6476234277825, 1961.2743284984504, 1983.7917018712972, 2001.3895761792648, 48839.75580122112, 57804.71097644485, 59216.70391648014, 62074.689626551575, 66325.66837165832, 10440.42577658236, 10510.842337364946, 10605.522751476203, 10680.0, 10710.143188545053, 12920.612381628565, 13953.162810231419, 24539.754602453748, 25447.74552254491, 25558.744412556007, 9221.077892210726, 9261.30540209487, 9385.765355866022, 9386.436813791195, 9674.613015479303, 7299.927000729925, 7389.889151662729, 7411.221821708751, 7587.0, 7731.884021739678, 8353.20644538768, 8388.706395276136, 8446.57767111642, 8492.447990880573, 8510.063892971768, 3195.5685982392542, 3237.2668829488666, 3251.0, 3298.65364136767, 3313.950290745641, 952.852307892264, 1001.1790331927895, 1058.3755584205203, 1082.924195306321, 1104.9613363438343, 16972.76569180689, 17054.14729263532, 17331.65336693259, 17843.553911152067, 17900.641987160445, 995.581855620641, 1029.1098200056897, 1030.1707125763683, 1047.528612124547, 1087.065123993365, 9503.952480237693, 10127.898721012696, 10144.188464922789, 10146.441945693057, 10263.640772572924, 410752.0, 448112.0, 448239.0, 449447.0, 453215.0, 71945.28054719491, 73916.0, 76933.0, 77688.0, 77999.0, 1033.5865653738415, 1046.2048842879467, 1048.4548035021746, 1050.8633877596017, 1064.1486810551528, 15221.238938053275, 15375.692486150438, 15433.289682817429, 15443.382264709286, 15485.612859678598, 26765.330866728487, 28148.71851281461, 32624.184395390304, 32787.67212327846, 34560.65439345675, 46342.76828615835, 47124.76437617927, 47342.52657473519, 48171.036579267515, 49094.26358604695, 8085.474444161111, 8185.590720463834, 8279.337652987868, 8328.0, 8406.159384061544, 12685.556005539762, 12883.935580322039, 12890.162139460905, 13032.609021729364, 13083.738325233633, 10985.0, 11491.138164637518, 11510.53957841677, 11664.541932258468, 11877.524899003944, 11628.6511404658, 11706.180567360203, 11713.824292635447, 11835.82246266324, 11936.70158246016, 11404.372759498307, 11735.23720958135, 11743.236689615147, 11863.169578129447, 12117.939410303245, 8299.917000829915, 8392.076871544248, 8395.370347224105, 8459.534725590152, 8563.82872342562, 8735.0, 10487.213458990758, 10531.315464494783, 10645.680629581126, 10739.496470494294], "unit": "score", "name": "jquery.html", "value": 9104.860333890307}, {"lowerIsBetter": false, "replicates": [1470.0738534723137, 1524.4588171199227, 1531.6017835362804, 1810.4568629411174, 1985.513549180451, 8285.627146778394, 8480.406371553978, 8482.703105391312, 8485.236328730412, 8490.830183396329, 7948.165442628528, 8080.070791858938, 8083.878741818878, 8098.149694282104, 8099.028116626013, 2169.327508472371, 2397.9040838366445, 2410.0, 2440.4508985478215, 2458.7787099161073, 2453.6319552067152, 2470.2712699753615, 2479.454520005596, 2481.6649752283483, 2483.3046746910895, 2459.225344016629, 2491.725910149891, 2492.028109037477, 2492.439201179738, 2493.3143385568933, 2390.509945461185, 2409.3253888911045, 2429.7327293997646, 2433.111914151322, 2433.537627850703, 2426.041713523166, 2429.2955043037496, 2434.0, 2441.7680320369536, 2447.5349683560066, 8804.0, 8810.911890881072, 8883.866741998876, 8884.200421962054, 8894.644214231488, 5161.2516185152945, 5233.816816411445, 5294.470552944713, 5302.734863256822, 5305.814296499604, 3199.392115498048, 3251.1059458648824, 3282.1302354875975, 3300.9009729708146, 3301.1417031571723, 1046.7801761629992, 1061.2677252695614, 1072.217281384586, 1072.8337107748312, 1106.1095817866615, 12192.207506512137, 12222.938885305517, 12225.816612750816, 12231.633051008484, 12247.081468889779, 4742.146413645577, 4778.95361487493, 4806.038792241566, 4843.2735089736825, 4895.241237608177, 10288.639897603547, 10310.020548048073, 10326.122279606167, 10327.380357178594, 10346.27576069683, 4838.854834354905, 5211.140161873249, 5342.2787923630585, 5354.4645535446925, 5361.758720857571, 4538.160440318552, 4621.260598304255, 4628.74541900192, 4629.884252893705, 4677.298405239173, 3838.2131663009573, 3898.590647981978, 3961.088949541564, 4016.176683779818, 4046.676265898721, 1269.5873841001712, 1309.260267948606, 1317.5783749200164, 1323.3647849032325, 1332.460353556811, 1211.0432758121162, 1216.2823933878876, 1289.5551034892947, 1327.4491086199118, 1336.1315145155727, 8436.789080273042, 8437.451565648213, 8483.321334293241, 8493.490390576586, 8501.914980850112, 509.1523848598839, 516.1148630099398, 519.9168133098686, 523.2909407752517, 526.9578433725293, 6247.531435142382, 6338.239411270677, 6341.270753863365, 6345.428911397904, 6432.74269029243, 10659.360438373567, 10866.348019118877, 10893.346399216072, 11060.059894909024, 11077.390743509022, 10576.41829699374, 10787.0, 10823.13414926804, 10853.34879907208, 10934.289271197347, 8327.333813294801, 8362.414630975773, 8396.748097557083, 8453.873191902127, 8473.322134229371, 7848.058233011847, 7853.410994175574, 7858.724944626911, 7921.1682773307975, 7944.801379965547, 9132.360734748503, 9318.906810931803, 9320.860187097334, 9442.48066356357, 9451.480168590793, 9483.762905927131, 9607.327487075838, 9675.854862176931, 9803.117719405287, 9822.901770982198, 6791.490638202055, 6962.268961758942, 7141.714331426892, 7704.26809453101, 7764.611769411394, 8201.26188643025, 8205.83588328242, 8233.135520770473, 8264.669413223644, 8264.876026859722, 7288.635568221674, 7397.0, 7401.59291238987, 7487.625618719151, 7652.273034061755, 7303.196648368569, 7617.885731714139, 7630.2751238632245, 7698.153203147761, 7707.92292077072, 7726.304632583095, 7774.0, 7805.687772489264, 7809.492382995087, 7812.92187078122, 7083.964580177066, 7095.787126386217, 7102.5028248022145, 7126.750563730245, 7163.820904477429, 7139.143302803489, 7163.0, 7166.964165179141, 7189.964050179716, 7200.243974382614], "unit": "score", "name": "mootools.html", "value": 4826.546242547417}, {"lowerIsBetter": false, "replicates": [360.85746130278534, 362.7388280438084, 365.6380183618219, 366.19619934244326, 366.5399923096513, 5908.231929849125, 5916.437938395857, 5922.963481390756, 5931.436513531213, 5937.495312898409, 5859.736311865966, 5860.912086318709, 5871.677057761822, 5872.823815285537, 5873.148393482953, 4409.360642706822, 4508.5491450854815, 4604.355390245369, 4617.353570500141, 4632.745199014053, 4585.358049873021, 4610.654200934943, 4624.583787459128, 4625.352450656911, 4633.698809577367, 4567.885802854938, 4584.51862554432, 4586.105709386671, 4588.105319462706, 4591.77041147943, 4443.688941774077, 4461.241588929906, 4532.8866778330475, 4547.886302842422, 4549.931751023704, 3996.660283875874, 4003.5796241394523, 4003.579624139482, 4006.198760247962, 4012.378081397359, 5556.499915007668, 5562.694051827148, 5565.2486914266465, 5573.359063707644, 5575.2473416088715, 5276.419593844674, 5288.68267903927, 5291.86770330741, 5295.179247216687, 5300.893982120375, 6199.225096862892, 6199.783007594712, 6200.131981522591, 6202.162708034402, 6204.906926396107, 4298.699091063627, 4412.338149277634, 4413.9117217655785, 4437.556244375537, 4441.311596702516, 6471.967640161816, 6493.318201588812, 6517.902231466532, 6521.706523206467, 6530.216374035099, 4553.931691024637, 4554.453465584151, 4556.476005259371, 4557.772111394417, 4562.520935301745, 4593.609543188866, 4597.770111494478, 4605.332226827091, 4612.215923293048, 4614.446266448048, 5275.287836142148, 5277.234800953917, 5288.365396152486, 5288.471152884681, 5292.894142117136, 6154.353792851775, 6268.874622507525, 6300.1494798202575, 6307.2431308242385, 6310.432061114522, 1603.2224371180203, 1617.9321647712454, 1627.1294857251314, 1629.4459883639383, 1631.5921019745065, 1035.5598870480017, 1087.782443511285, 1108.9722756931142, 1145.118258940611, 1157.1205883528578, 6020.187274717945, 6022.789202377896, 6023.939760602338, 6027.819165425044, 6027.8794424111275, 6385.712642931079, 6390.392912673288, 6414.262359828586, 6424.775132870327, 6429.3570642936265, 5970.164177015221, 6038.516918646497, 6047.092936059538, 6047.78832740852, 6052.969735151384, 3445.4659527773233, 3450.654934506529, 3466.5666791651042, 3466.687998080185, 3470.6529347065093, 6510.479161667055, 6661.966690166518, 6663.400293973566, 6678.565893216925, 6682.365175308338, 6539.444147247537, 6582.24304205013, 6583.650351677895, 6588.8352791180605, 6591.934080659132, 6654.367835055662, 6657.034729964225, 6657.966710166418, 6660.034295027097, 6670.599764014175, 6357.396047375492, 6369.554131210771, 6374.521910856612, 6376.4580010697755, 6376.776812811529, 6154.415330543591, 6268.498520118288, 6304.684765761602, 6304.747810087729, 6320.683965801783, 6647.9002814958785, 6659.534902321481, 6659.667016649051, 6663.566868153554, 6672.633005184762, 4710.81156753726, 4713.104510143062, 4718.669693121448, 4720.929186062143, 4726.409198850144, 6393.104965304768, 6393.4885209184085, 6399.136116624196, 6400.935990640221, 6405.647689377129, 6102.786402475892, 6227.252729672468, 6232.657203853651, 6233.844153896189, 6238.656873871799, 6221.875562488634, 6229.5327850410495, 6231.345708700703, 6237.438630523275, 6238.6880655967925, 6060.303065147565, 6078.6048906820915, 6085.543584231112, 6090.330063692902, 6094.2077529920825, 6238.937610623836, 6239.781607643892, 6243.656598887105, 6252.718627661857, 6253.093301471352, 6001.4598686116715, 6089.360617135137, 6112.480439162543, 6113.84715382119, 6116.724747386289], "unit": "score", "name": "prototype.html", "value": 4757.297790237828}, {"lowerIsBetter": false, "replicates": [780.4536824223045, 793.0800271684847, 863.4042510667639, 893.1559676106074, 904.9095090490947, 14436.206008669518, 14474.638134046654, 14537.0, 14572.27138643069, 14613.853861461383, 13008.739825203515, 14291.285435728223, 14464.783028254584, 14489.49286774963, 14496.347664355102, 751.515272649141, 897.4884315939917, 899.4872922434215, 910.6630546697731, 926.5321012888481, 902.3548163063408, 903.1961554216753, 903.3631289940577, 904.1184844776357, 909.822584596004, 957.7414098193484, 958.2094771813247, 958.8897276813186, 959.3572306554626, 977.2524019125375, 785.9921400786005, 956.6986399284203, 961.8461046232569, 964.2912459342377, 965.5703212070596, 710.8969199466101, 711.3491155592626, 711.6157275071455, 713.005357526248, 713.5005496152662, 14466.71066578673, 14566.4901728439, 14581.0, 14612.926935365254, 14622.195779232137, 13511.256880871548, 13669.316534173351, 13819.723605527934, 14169.716605667933, 14463.987520873543, 11139.498722557504, 11157.776844463066, 11411.372374519398, 11754.0, 11801.645950621494, 3798.5821559628694, 3829.636184562462, 3839.616038396166, 3841.750286231414, 3842.2315536892734, 50199.0, 50957.74521127408, 51701.0, 51870.22194667083, 51949.48050519484, 11009.724756880982, 11168.050715689258, 11178.552857885594, 11214.10287177024, 11333.26333788301, 20503.28238511645, 20563.177472900916, 20569.382918512467, 20579.971001449867, 20592.485187870425, 7992.880106798402, 8162.551059691656, 8261.463004904663, 8439.915600844035, 8450.15808626142, 4722.5513576210205, 4772.546608072227, 4876.317315575822, 4895.828645997373, 4951.653384263067, 3354.4129777288877, 3380.983095084509, 3382.458806590934, 3385.4921761735936, 3389.8983030509125, 559.7732918168149, 583.3000399520507, 613.5275837605019, 635.1552435261092, 650.3204151661525, 706.7102487979904, 733.6478490324674, 741.8219627289411, 756.3684323589864, 761.3072104384983, 8799.780005499786, 8906.465612063297, 8955.238804701674, 8980.146886045815, 9437.905620943702, 550.2913453726203, 554.0829926471696, 610.9816705498843, 617.9011358182669, 678.6878036103448, 4234.449521562177, 4300.225959327351, 4365.192439398721, 4415.801288942005, 4523.7285762854335, 57562.424375755705, 57604.71197643985, 57834.84330313454, 58189.41810581925, 58424.707876461194, 48318.27522587164, 49234.0, 50120.24819627708, 50123.74938125286, 51765.2235216472, 48237.75881120572, 48344.27483587749, 48406.757966209945, 48663.0, 48768.512314876396, 9184.0, 9270.0, 9328.95335523318, 9407.388519746195, 9438.0, 35939.64060359468, 36616.0, 37370.626293736714, 37677.24645507129, 37815.810920945216, 43825.34261986137, 48274.75862620665, 48762.0, 48902.0, 48988.0, 10766.62316818939, 10884.891151088705, 11193.776124477628, 11196.0, 11582.305061696325, 12285.385730713608, 12343.506259749869, 12830.871691282968, 12842.935785321013, 12952.740945180854, 10227.43749093807, 11665.894519749783, 12306.138570299992, 12622.179558328678, 12765.872341276468, 11946.163768536466, 12040.939795300967, 12250.142490025613, 12480.68798280014, 13005.804912926125, 11634.36011019402, 11658.12564057716, 11976.820347694616, 12257.816132758195, 12639.115261931576, 9351.38020664447, 9473.66842160521, 9634.807303853744, 9887.456189909624, 10354.275200735876, 9853.408795472295, 9865.009856026976, 9917.900820991697, 9934.801303974025, 9995.750106247402], "unit": "score", "name": "yui.html", "value": 6758.125923322118}], "name": "dromaeo_css", "value": 7242.052878836907}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 111.0, 111.0, 112.0, 100.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [147.0, 131.0, 152.0, 163.0, 124.0, 153.0, 150.0, 126.0, 164.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 160.0, 160.0, 163.0, 159.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 72.0, 160.0, 76.0, 75.0, 73.0, 75.0, 158.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 150.0, 92.0, 94.0, 92.0, 143.0, 93.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 53.0, 54.0, 54.0, 52.0, 61.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 86.0, 80.0, 79.0, 78.0, 79.0, 80.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [128.0, 111.0, 115.0, 120.0, 111.0, 118.0, 112.0, 115.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 135.0, 142.0, 145.0, 145.0, 133.0, 144.0, 146.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 65.0, 67.0, 66.0, 68.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1493.3999999999999}]} 19:00:53 INFO - Return code: 0 19:00:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:00:53 INFO - # TBPL SUCCESS # 19:00:53 INFO - Running post-action listener: _resource_record_post_action 19:00:53 INFO - Running post-run listener: _resource_record_post_run 19:00:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 262144; Write bytes: 510357504; Read time: 12; Write time: 498364 19:00:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254218240; Read time: 0; Write time: 320516 19:00:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252014592; Read time: 12; Write time: 176856 19:00:54 INFO - Running post-run listener: _upload_blobber_files 19:00:54 INFO - Blob upload gear active. 19:00:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:00:54 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 19:00:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:00:55 INFO - (blobuploader) - INFO - Open directory for files ... 19:00:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:00:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:56 INFO - (blobuploader) - INFO - Done attempting. 19:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:56 INFO - (blobuploader) - INFO - Done attempting. 19:00:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:56 INFO - Return code: 0 19:00:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:00:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04e185efbb5895c50f85290ba573c90dcb7e1f71ef0a2445b76a647327354c33b83b5013ab64818cca95d4658e8183d90d8a3e02b803b0679b210fef80dc4e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b73881a358dba8163df9dd33323388101c177b9dea8bb53d6e221bfdc3435146ecddb3e031c8427d6e68b426d32564aa1c959983159914f757a9fdda3f9575"} 19:00:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:00:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:00:56 INFO - Contents: 19:00:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04e185efbb5895c50f85290ba573c90dcb7e1f71ef0a2445b76a647327354c33b83b5013ab64818cca95d4658e8183d90d8a3e02b803b0679b210fef80dc4e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b73881a358dba8163df9dd33323388101c177b9dea8bb53d6e221bfdc3435146ecddb3e031c8427d6e68b426d32564aa1c959983159914f757a9fdda3f9575"} 19:00:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:56 INFO - Copying logs to upload dir... 19:00:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:00:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.543033 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-03-11 19:00:56.133918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 19:00:56.137163) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 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-Aurora/sha512/04e185efbb5895c50f85290ba573c90dcb7e1f71ef0a2445b76a647327354c33b83b5013ab64818cca95d4658e8183d90d8a3e02b803b0679b210fef80dc4e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b73881a358dba8163df9dd33323388101c177b9dea8bb53d6e221bfdc3435146ecddb3e031c8427d6e68b426d32564aa1c959983159914f757a9fdda3f9575"} build_url:https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/N52AJzm6TQGYzOwJ8fNi2A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04e185efbb5895c50f85290ba573c90dcb7e1f71ef0a2445b76a647327354c33b83b5013ab64818cca95d4658e8183d90d8a3e02b803b0679b210fef80dc4e2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b73881a358dba8163df9dd33323388101c177b9dea8bb53d6e221bfdc3435146ecddb3e031c8427d6e68b426d32564aa1c959983159914f757a9fdda3f9575"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 19:00:56.168305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 19:00:56.169067) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457746751.54564-1395133232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 19:00:56.253318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 19:00:56.253686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 19:00:56.254009) ========= ========= Total master_lag: 0.29 =========