builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1458268569.64 results: success (0) buildid: 20160317170433 builduid: 86ed20a3e7d445f292cdc0c0cf5b8d23 revision: 3ffa45c6352e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.638615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.639040) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.639327) ========= 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006487 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.662234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.662509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.677335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.677603) ========= 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.726850) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.727150) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.727502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.727774) ========= 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 19:36:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.7M=0s 2016-03-17 19:36:09 (66.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.903455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.903738) ========= 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.953408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:09.954013) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3ffa45c6352e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3ffa45c6352e --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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 19:36:10,049 Setting DEBUG logging. 2016-03-17 19:36:10,049 attempt 1/10 2016-03-17 19:36:10,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3ffa45c6352e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 19:36:10,305 unpacking tar archive at: mozilla-inbound-3ffa45c6352e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:10.498908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:10.499299) ========= echo 3ffa45c6352e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3ffa45c6352e'] 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3ffa45c6352e program finished with exit code 0 elapsedTime=0.004731 script_repo_revision: '3ffa45c6352e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:10.551995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:10.552280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 19:36:10.562483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-17 19:36:10.562756) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:36:10 INFO - MultiFileLogger online at 20160317 19:36:10 in /builds/slave/test-pgo 19:36:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:36:10 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:36:10 INFO - {'append_to_log': False, 19:36:10 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:36:10 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:36:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:36:10 INFO - 'branch': 'Mozilla-Inbound', 19:36:10 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:10 INFO - 'config_files': ('talos/linux_config.py',), 19:36:10 INFO - 'default_actions': ('clobber', 19:36:10 INFO - 'read-buildbot-config', 19:36:10 INFO - 'download-and-extract', 19:36:10 INFO - 'populate-webroot', 19:36:10 INFO - 'create-virtualenv', 19:36:10 INFO - 'install', 19:36:10 INFO - 'run-tests'), 19:36:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:10 INFO - 'download_minidump_stackwalk': True, 19:36:10 INFO - 'download_symbols': 'ondemand', 19:36:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:10 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:10 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:10 INFO - 'installer_path': 'installer.exe', 19:36:10 INFO - 'log_level': 'info', 19:36:10 INFO - 'log_name': 'talos', 19:36:10 INFO - 'log_to_console': True, 19:36:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:36:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:36:10 INFO - 'opt_config_files': (), 19:36:10 INFO - 'pip_index': False, 19:36:10 INFO - 'sps_profile': False, 19:36:10 INFO - 'sps_profile_interval': 0, 19:36:10 INFO - 'suite': 'dromaeojs', 19:36:10 INFO - 'system_bits': '32', 19:36:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:10 INFO - 'title': 'talos-linux64-ix-031', 19:36:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:10 INFO - 'use_talos_json': True, 19:36:10 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:36:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:10 INFO - 'work_dir': 'build'} 19:36:10 INFO - ##### 19:36:10 INFO - ##### Running clobber step. 19:36:10 INFO - ##### 19:36:10 INFO - Running pre-action listener: _resource_record_pre_action 19:36:10 INFO - Running main action method: clobber 19:36:10 INFO - rmtree: /builds/slave/test-pgo/build 19:36:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:36:11 INFO - Running post-action listener: _resource_record_post_action 19:36:11 INFO - ##### 19:36:11 INFO - ##### Running read-buildbot-config step. 19:36:11 INFO - ##### 19:36:11 INFO - Running pre-action listener: _resource_record_pre_action 19:36:11 INFO - Running main action method: read_buildbot_config 19:36:11 INFO - Using buildbot properties: 19:36:11 INFO - { 19:36:11 INFO - "project": "", 19:36:11 INFO - "product": "firefox", 19:36:11 INFO - "script_repo_revision": "production", 19:36:11 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:36:11 INFO - "repository": "", 19:36:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:36:11 INFO - "buildid": "20160317170433", 19:36:11 INFO - "pgo_build": "True", 19:36:11 INFO - "basedir": "/builds/slave/test-pgo", 19:36:11 INFO - "buildnumber": 804, 19:36:11 INFO - "slavename": "talos-linux64-ix-031", 19:36:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:36:11 INFO - "platform": "ubuntu64_hw", 19:36:11 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:36:11 INFO - "branch": "mozilla-inbound", 19:36:11 INFO - "repo_path": "integration/mozilla-inbound", 19:36:11 INFO - "revision": "3ffa45c6352e", 19:36:11 INFO - "stage_platform": "linux64-pgo", 19:36:11 INFO - "builduid": "86ed20a3e7d445f292cdc0c0cf5b8d23", 19:36:11 INFO - "slavebuilddir": "test" 19:36:11 INFO - } 19:36:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:36:11 INFO - Running post-action listener: _resource_record_post_action 19:36:11 INFO - ##### 19:36:11 INFO - ##### Running download-and-extract step. 19:36:11 INFO - ##### 19:36:11 INFO - Running pre-action listener: _resource_record_pre_action 19:36:11 INFO - Running main action method: download_and_extract 19:36:11 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:36:11 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')]} 19:36:11 INFO - https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:36:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:36:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:36:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:36:13 INFO - Downloaded 1361 bytes. 19:36:13 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:36:13 INFO - Using the following test package requirements: 19:36:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:36:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:36:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'jsshell-linux-x86_64.zip'], 19:36:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:36:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:36:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:36:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:36:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:36:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:13 INFO - https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:14 INFO - Downloaded 23404357 bytes. 19:36:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:36:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:36:16 INFO - Return code: 0 19:36:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:16 INFO - https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:24 INFO - Downloaded 23404357 bytes. 19:36:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:36:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:36:25 INFO - Return code: 0 19:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:25 INFO - https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:36:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:36:27 INFO - Downloaded 10845161 bytes. 19:36:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:36:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:36:27 INFO - Return code: 0 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:27 INFO - https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:36:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:36:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:36:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:36:28 INFO - Downloaded 56195523 bytes. 19:36:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:36:28 INFO - mkdir: /builds/slave/test-pgo/properties 19:36:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:36:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:36:28 INFO - Contents: 19:36:28 INFO - build_url:https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:36:29 INFO - Running post-action listener: _resource_record_post_action 19:36:29 INFO - Running post-action listener: set_extra_try_arguments 19:36:29 INFO - ##### 19:36:29 INFO - ##### Running populate-webroot step. 19:36:29 INFO - ##### 19:36:29 INFO - Running pre-action listener: _resource_record_pre_action 19:36:29 INFO - Running main action method: populate_webroot 19:36:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:29 INFO - '--tppagecycles', 19:36:29 INFO - '7'], 19:36:29 INFO - 'tests': ['tsvgm']}}, 19:36:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:36:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:36:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'tests': ['damp', 'tps']}, 19:36:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['damp', 'tps']}, 19:36:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:36:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:29 INFO - 'other': {'tests': ['a11yr', 19:36:29 INFO - 'ts_paint', 19:36:29 INFO - 'tpaint', 19:36:29 INFO - 'sessionrestore', 19:36:29 INFO - 'sessionrestore_no_auto_restore', 19:36:29 INFO - 'tabpaint']}, 19:36:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['a11yr', 19:36:29 INFO - 'ts_paint', 19:36:29 INFO - 'tpaint', 19:36:29 INFO - 'sessionrestore', 19:36:29 INFO - 'sessionrestore_no_auto_restore', 19:36:29 INFO - 'tabpaint']}, 19:36:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['a11yr', 19:36:29 INFO - 'ts_paint', 19:36:29 INFO - 'tpaint', 19:36:29 INFO - 'sessionrestore', 19:36:29 INFO - 'sessionrestore_no_auto_restore', 19:36:29 INFO - 'tabpaint']}, 19:36:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['a11yr', 19:36:29 INFO - 'ts_paint', 19:36:29 INFO - 'tpaint', 19:36:29 INFO - 'sessionrestore', 19:36:29 INFO - 'sessionrestore_no_auto_restore', 19:36:29 INFO - 'tabpaint']}, 19:36:29 INFO - 'other_l64': {'tests': ['a11yr', 19:36:29 INFO - 'ts_paint', 19:36:29 INFO - 'tpaint', 19:36:29 INFO - 'sessionrestore', 19:36:29 INFO - 'sessionrestore_no_auto_restore', 19:36:29 INFO - 'tabpaint']}, 19:36:29 INFO - 'other_nol64': {'tests': ['a11yr', 19:36:29 INFO - 'ts_paint', 19:36:29 INFO - 'tpaint', 19:36:29 INFO - 'sessionrestore', 19:36:29 INFO - 'sessionrestore_no_auto_restore', 19:36:29 INFO - 'tabpaint']}, 19:36:29 INFO - 'svgr': {'tests': ['tsvgx', 19:36:29 INFO - 'tsvgr_opacity', 19:36:29 INFO - 'tart', 19:36:29 INFO - 'tscrollx', 19:36:29 INFO - 'cart']}, 19:36:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['tsvgx', 19:36:29 INFO - 'tsvgr_opacity', 19:36:29 INFO - 'tart', 19:36:29 INFO - 'tscrollx', 19:36:29 INFO - 'cart']}, 19:36:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'tests': ['tp5o']}, 19:36:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'talos_options': ['--e10s'], 19:36:29 INFO - 'tests': ['tp5o']}, 19:36:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'talos_options': ['--xperf_path', 19:36:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:29 INFO - 'tests': ['tp5n']}, 19:36:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:29 INFO - 'talos_options': ['--e10s', 19:36:29 INFO - '--xperf_path', 19:36:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:29 INFO - 'tests': ['tp5n']}}, 19:36:29 INFO - 'talos.zip': {'path': '', 19:36:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:29 INFO - Running post-action listener: _resource_record_post_action 19:36:29 INFO - ##### 19:36:29 INFO - ##### Running create-virtualenv step. 19:36:29 INFO - ##### 19:36:29 INFO - Running pre-action listener: _resource_record_pre_action 19:36:29 INFO - Running main action method: create_virtualenv 19:36:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:36:29 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 19:36:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:36:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:29 INFO - Using real prefix '/usr' 19:36:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:36:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:32 INFO - Installing pip.................done. 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:36: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')]} 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:32 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 19:36:32 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 19:36:32 INFO - Using env: {'DISPLAY': ':0', 19:36:32 INFO - 'HOME': '/home/cltbld', 19:36:32 INFO - 'LANG': 'en_US.UTF-8', 19:36:32 INFO - 'LANGUAGE': 'en_US:en', 19:36:32 INFO - 'LOGNAME': 'cltbld', 19:36:32 INFO - 'MAIL': '/var/mail/cltbld', 19:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:32 INFO - 'MOZ_NO_REMOTE': '1', 19:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:32 INFO - 'NO_EM_RESTART': '1', 19:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:32 INFO - 'SHELL': '/bin/bash', 19:36:32 INFO - 'SHLVL': '1', 19:36:32 INFO - 'TERM': 'linux', 19:36:32 INFO - 'TMOUT': '86400', 19:36:32 INFO - 'USER': 'cltbld', 19:36:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:32 INFO - '_': '/tools/buildbot/bin/python'} 19:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:32 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 19:36:32 INFO - Cleaning up... 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:36: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')]} 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:32 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 19:36:32 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 19:36:32 INFO - Using env: {'DISPLAY': ':0', 19:36:32 INFO - 'HOME': '/home/cltbld', 19:36:32 INFO - 'LANG': 'en_US.UTF-8', 19:36:32 INFO - 'LANGUAGE': 'en_US:en', 19:36:32 INFO - 'LOGNAME': 'cltbld', 19:36:32 INFO - 'MAIL': '/var/mail/cltbld', 19:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:32 INFO - 'MOZ_NO_REMOTE': '1', 19:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:32 INFO - 'NO_EM_RESTART': '1', 19:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:32 INFO - 'SHELL': '/bin/bash', 19:36:32 INFO - 'SHLVL': '1', 19:36:32 INFO - 'TERM': 'linux', 19:36:32 INFO - 'TMOUT': '86400', 19:36:32 INFO - 'USER': 'cltbld', 19:36:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:32 INFO - '_': '/tools/buildbot/bin/python'} 19:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:32 INFO - Downloading/unpacking psutil>=0.7.1 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:34 INFO - Installing collected packages: psutil 19:36:34 INFO - Running setup.py install for psutil 19:36:34 INFO - building 'psutil._psutil_linux' extension 19:36:34 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 19:36:34 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 19:36:34 INFO - building 'psutil._psutil_posix' extension 19:36:34 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 19:36:34 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 19:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:34 INFO - Successfully installed psutil 19:36:34 INFO - Cleaning up... 19:36:35 INFO - Return code: 0 19:36:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:36: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')]} 19:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:35 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:35 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 19:36:35 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 19:36:35 INFO - Using env: {'DISPLAY': ':0', 19:36:35 INFO - 'HOME': '/home/cltbld', 19:36:35 INFO - 'LANG': 'en_US.UTF-8', 19:36:35 INFO - 'LANGUAGE': 'en_US:en', 19:36:35 INFO - 'LOGNAME': 'cltbld', 19:36:35 INFO - 'MAIL': '/var/mail/cltbld', 19:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:35 INFO - 'MOZ_NO_REMOTE': '1', 19:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:35 INFO - 'NO_EM_RESTART': '1', 19:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:35 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:35 INFO - 'SHELL': '/bin/bash', 19:36:35 INFO - 'SHLVL': '1', 19:36:35 INFO - 'TERM': 'linux', 19:36:35 INFO - 'TMOUT': '86400', 19:36:35 INFO - 'USER': 'cltbld', 19:36:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:35 INFO - '_': '/tools/buildbot/bin/python'} 19:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:36:35 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 19:36:35 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 19:36:35 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 19:36:35 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 19:36:35 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 19:36:35 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 19:36:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:36:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:36:37 INFO - Installing collected packages: mozsystemmonitor 19:36:37 INFO - Running setup.py install for mozsystemmonitor 19:36:37 INFO - Successfully installed mozsystemmonitor 19:36:37 INFO - Cleaning up... 19:36:37 INFO - Return code: 0 19:36:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:36:37 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')]} 19:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:37 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')]} 19:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:37 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:37 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 19:36:37 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 19:36:37 INFO - Using env: {'DISPLAY': ':0', 19:36:37 INFO - 'HOME': '/home/cltbld', 19:36:37 INFO - 'LANG': 'en_US.UTF-8', 19:36:37 INFO - 'LANGUAGE': 'en_US:en', 19:36:37 INFO - 'LOGNAME': 'cltbld', 19:36:37 INFO - 'MAIL': '/var/mail/cltbld', 19:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:37 INFO - 'MOZ_NO_REMOTE': '1', 19:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:37 INFO - 'NO_EM_RESTART': '1', 19:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:37 INFO - 'SHELL': '/bin/bash', 19:36:37 INFO - 'SHLVL': '1', 19:36:37 INFO - 'TERM': 'linux', 19:36:37 INFO - 'TMOUT': '86400', 19:36:37 INFO - 'USER': 'cltbld', 19:36:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:37 INFO - '_': '/tools/buildbot/bin/python'} 19:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:37 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 19:36:37 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 19:36:37 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 19:36:37 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 19:36:37 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 19:36:37 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 19:36:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:36:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 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 19:36:39 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 19:36:40 INFO - Downloading docopt-0.6.1.tar.gz 19:36:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:40 INFO - Running setup.py install for blobuploader 19:36:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:36:40 INFO - Running setup.py install for requests 19:36:40 INFO - Running setup.py install for docopt 19:36:40 INFO - Successfully installed blobuploader requests docopt 19:36:40 INFO - Cleaning up... 19:36:40 INFO - Return code: 0 19:36:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:40 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 19:36:40 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 19:36:40 INFO - Using env: {'DISPLAY': ':0', 19:36:40 INFO - 'HOME': '/home/cltbld', 19:36:40 INFO - 'LANG': 'en_US.UTF-8', 19:36:40 INFO - 'LANGUAGE': 'en_US:en', 19:36:40 INFO - 'LOGNAME': 'cltbld', 19:36:40 INFO - 'MAIL': '/var/mail/cltbld', 19:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:40 INFO - 'MOZ_NO_REMOTE': '1', 19:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:40 INFO - 'NO_EM_RESTART': '1', 19:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:40 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:40 INFO - 'SHELL': '/bin/bash', 19:36:40 INFO - 'SHLVL': '1', 19:36:40 INFO - 'TERM': 'linux', 19:36:40 INFO - 'TMOUT': '86400', 19:36:40 INFO - 'USER': 'cltbld', 19:36:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:40 INFO - '_': '/tools/buildbot/bin/python'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:40 INFO - Running setup.py (path:/tmp/pip-PCd_nZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:40 INFO - Running setup.py (path:/tmp/pip-24hG6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:41 INFO - Running setup.py (path:/tmp/pip-LkUyRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:41 INFO - Running setup.py (path:/tmp/pip-SOBnBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:41 INFO - Running setup.py (path:/tmp/pip-Ci1NGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:41 INFO - Running setup.py (path:/tmp/pip-OfmkGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:41 INFO - Running setup.py (path:/tmp/pip-L29XG5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:41 INFO - Running setup.py (path:/tmp/pip-esOUAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:41 INFO - Running setup.py (path:/tmp/pip-TQxS2q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:41 INFO - Running setup.py (path:/tmp/pip-G6vJ0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:41 INFO - Running setup.py (path:/tmp/pip-2lPvwD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:41 INFO - Running setup.py (path:/tmp/pip-iupWF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:41 INFO - Running setup.py (path:/tmp/pip-5HFhIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:41 INFO - Running setup.py (path:/tmp/pip-v1FWhf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:41 INFO - Running setup.py (path:/tmp/pip-x5kbph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:42 INFO - Running setup.py (path:/tmp/pip-zcH1i8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:42 INFO - Running setup.py (path:/tmp/pip-5Rn0Zk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:42 INFO - Running setup.py install for manifestparser 19:36:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Running setup.py install for mozcrash 19:36:42 INFO - Running setup.py install for mozdebug 19:36:42 INFO - Running setup.py install for mozdevice 19:36:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Running setup.py install for mozfile 19:36:42 INFO - Running setup.py install for mozhttpd 19:36:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Running setup.py install for mozinfo 19:36:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Running setup.py install for mozInstall 19:36:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:36:42 INFO - Running setup.py install for mozleak 19:36:43 INFO - Running setup.py install for mozlog 19:36:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Running setup.py install for moznetwork 19:36:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Running setup.py install for mozprocess 19:36:43 INFO - Running setup.py install for mozprofile 19:36:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Running setup.py install for mozrunner 19:36:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Running setup.py install for mozscreenshot 19:36:43 INFO - Running setup.py install for moztest 19:36:43 INFO - Running setup.py install for mozversion 19:36:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:36:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:43 INFO - Cleaning up... 19:36:43 INFO - Return code: 0 19:36:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:43 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 19:36:43 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 19:36:43 INFO - Using env: {'DISPLAY': ':0', 19:36:43 INFO - 'HOME': '/home/cltbld', 19:36:43 INFO - 'LANG': 'en_US.UTF-8', 19:36:43 INFO - 'LANGUAGE': 'en_US:en', 19:36:43 INFO - 'LOGNAME': 'cltbld', 19:36:43 INFO - 'MAIL': '/var/mail/cltbld', 19:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:43 INFO - 'MOZ_NO_REMOTE': '1', 19:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:43 INFO - 'NO_EM_RESTART': '1', 19:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:43 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:43 INFO - 'SHELL': '/bin/bash', 19:36:43 INFO - 'SHLVL': '1', 19:36:43 INFO - 'TERM': 'linux', 19:36:43 INFO - 'TMOUT': '86400', 19:36:43 INFO - 'USER': 'cltbld', 19:36:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:43 INFO - '_': '/tools/buildbot/bin/python'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:44 INFO - Running setup.py (path:/tmp/pip-7LNMpW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:44 INFO - Running setup.py (path:/tmp/pip-VtCkQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:44 INFO - Running setup.py (path:/tmp/pip-ViVHQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:44 INFO - Running setup.py (path:/tmp/pip-32bBgx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:44 INFO - Running setup.py (path:/tmp/pip-CS7PGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:44 INFO - Running setup.py (path:/tmp/pip-afosft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:44 INFO - Running setup.py (path:/tmp/pip-WjnrJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:44 INFO - Running setup.py (path:/tmp/pip-kiu5Nj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:44 INFO - Running setup.py (path:/tmp/pip-3WeUTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:44 INFO - Running setup.py (path:/tmp/pip-IjYp2r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:44 INFO - Running setup.py (path:/tmp/pip-YppoiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:44 INFO - Running setup.py (path:/tmp/pip-fgwXxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:45 INFO - Running setup.py (path:/tmp/pip-lQsbBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:45 INFO - Running setup.py (path:/tmp/pip-5AKi9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:45 INFO - Running setup.py (path:/tmp/pip-NOWIo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:45 INFO - Running setup.py (path:/tmp/pip-Sv5FfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:45 INFO - Running setup.py (path:/tmp/pip-UhEchd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:45 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)) 19:36:45 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)) 19:36:45 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)) 19:36:45 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)) 19:36:45 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)) 19:36:45 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)) 19:36:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:47 INFO - Downloading blessings-1.6.tar.gz 19:36:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:47 INFO - Installing collected packages: blessings 19:36:47 INFO - Running setup.py install for blessings 19:36:47 INFO - Successfully installed blessings 19:36:47 INFO - Cleaning up... 19:36:47 INFO - Return code: 0 19:36:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:36:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:36:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:36:47 INFO - Reading from file tmpfile_stdout 19:36:47 INFO - Current package versions: 19:36:47 INFO - argparse == 1.2.1 19:36:47 INFO - blessings == 1.6 19:36:47 INFO - blobuploader == 1.2.4 19:36:47 INFO - docopt == 0.6.1 19:36:47 INFO - manifestparser == 1.1 19:36:47 INFO - mozInstall == 1.12 19:36:47 INFO - mozcrash == 0.17 19:36:47 INFO - mozdebug == 0.1 19:36:47 INFO - mozdevice == 0.48 19:36:47 INFO - mozfile == 1.2 19:36:47 INFO - mozhttpd == 0.7 19:36:47 INFO - mozinfo == 0.9 19:36:47 INFO - mozleak == 0.1 19:36:47 INFO - mozlog == 3.1 19:36:47 INFO - moznetwork == 0.27 19:36:47 INFO - mozprocess == 0.22 19:36:47 INFO - mozprofile == 0.28 19:36:47 INFO - mozrunner == 6.11 19:36:47 INFO - mozscreenshot == 0.1 19:36:47 INFO - mozsystemmonitor == 0.0 19:36:47 INFO - moztest == 0.7 19:36:47 INFO - mozversion == 1.4 19:36:47 INFO - psutil == 3.1.1 19:36:47 INFO - requests == 1.2.3 19:36:47 INFO - wsgiref == 0.1.2 19:36:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:36: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')]} 19:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:47 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 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:47 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 19:36:47 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 19:36:47 INFO - Using env: {'DISPLAY': ':0', 19:36:47 INFO - 'HOME': '/home/cltbld', 19:36:47 INFO - 'LANG': 'en_US.UTF-8', 19:36:47 INFO - 'LANGUAGE': 'en_US:en', 19:36:47 INFO - 'LOGNAME': 'cltbld', 19:36:47 INFO - 'MAIL': '/var/mail/cltbld', 19:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:47 INFO - 'MOZ_NO_REMOTE': '1', 19:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:47 INFO - 'NO_EM_RESTART': '1', 19:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:47 INFO - 'SHELL': '/bin/bash', 19:36:47 INFO - 'SHLVL': '1', 19:36:47 INFO - 'TERM': 'linux', 19:36:47 INFO - 'TMOUT': '86400', 19:36:47 INFO - 'USER': 'cltbld', 19:36:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:47 INFO - '_': '/tools/buildbot/bin/python'} 19:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 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)) 19:36:47 INFO - Cleaning up... 19:36:47 INFO - Return code: 0 19:36:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:36: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')]} 19:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36: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', 'jsonschema'] in /builds/slave/test-pgo/build 19:36: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 jsonschema 19:36:47 INFO - Using env: {'DISPLAY': ':0', 19:36:47 INFO - 'HOME': '/home/cltbld', 19:36:47 INFO - 'LANG': 'en_US.UTF-8', 19:36:47 INFO - 'LANGUAGE': 'en_US:en', 19:36:47 INFO - 'LOGNAME': 'cltbld', 19:36:47 INFO - 'MAIL': '/var/mail/cltbld', 19:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:47 INFO - 'MOZ_NO_REMOTE': '1', 19:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:47 INFO - 'NO_EM_RESTART': '1', 19:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:47 INFO - 'SHELL': '/bin/bash', 19:36:47 INFO - 'SHLVL': '1', 19:36:47 INFO - 'TERM': 'linux', 19:36:47 INFO - 'TMOUT': '86400', 19:36:47 INFO - 'USER': 'cltbld', 19:36:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:47 INFO - '_': '/tools/buildbot/bin/python'} 19:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:48 INFO - Downloading/unpacking jsonschema 19:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:49 INFO - Downloading/unpacking functools32 (from jsonschema) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:50 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:50 INFO - warning: no files found matching '*.txt' 19:36:50 INFO - no previously-included directories found matching 'build' 19:36:50 INFO - no previously-included directories found matching 'dist' 19:36:50 INFO - no previously-included directories found matching '.git*' 19:36:50 INFO - Installing collected packages: jsonschema, functools32 19:36:50 INFO - Running setup.py install for functools32 19:36:50 INFO - warning: no files found matching '*.txt' 19:36:50 INFO - no previously-included directories found matching 'build' 19:36:50 INFO - no previously-included directories found matching 'dist' 19:36:50 INFO - no previously-included directories found matching '.git*' 19:36:50 INFO - Successfully installed jsonschema functools32 19:36:50 INFO - Cleaning up... 19:36:50 INFO - Return code: 0 19:36:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f5f635f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ada8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, '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': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', '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 19:36:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:36:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:36:50 INFO - Using env: {'DISPLAY': ':0', 19:36:50 INFO - 'HOME': '/home/cltbld', 19:36:50 INFO - 'LANG': 'en_US.UTF-8', 19:36:50 INFO - 'LANGUAGE': 'en_US:en', 19:36:50 INFO - 'LOGNAME': 'cltbld', 19:36:50 INFO - 'MAIL': '/var/mail/cltbld', 19:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:50 INFO - 'MOZ_NO_REMOTE': '1', 19:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:50 INFO - 'NO_EM_RESTART': '1', 19:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:50 INFO - 'SHELL': '/bin/bash', 19:36:50 INFO - 'SHLVL': '1', 19:36:50 INFO - 'TERM': 'linux', 19:36:50 INFO - 'TMOUT': '86400', 19:36:50 INFO - 'USER': 'cltbld', 19:36:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:50 INFO - '_': '/tools/buildbot/bin/python'} 19:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:50 INFO - Downloading/unpacking flake8 19:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:36:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:36:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:36:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:53 INFO - no previously-included directories found matching 'docs/_build' 19:36:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:36:53 INFO - Running setup.py install for pep8 19:36:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:53 INFO - no previously-included directories found matching 'docs/_build' 19:36:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:36:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:36:53 INFO - Cleaning up... 19:36:53 INFO - Return code: 0 19:36:53 INFO - Running post-action listener: _resource_record_post_action 19:36:53 INFO - Running post-action listener: _start_resource_monitoring 19:36:53 INFO - Starting resource monitoring. 19:36:53 INFO - ##### 19:36:53 INFO - ##### Running install step. 19:36:53 INFO - ##### 19:36:53 INFO - Running pre-action listener: _resource_record_pre_action 19:36:53 INFO - Running main action method: install 19:36:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:36:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:36:53 INFO - Reading from file tmpfile_stdout 19:36:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:36:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:36:53 INFO - Reading from file tmpfile_stdout 19:36:53 INFO - Output received: 19:36:53 INFO - Usage: mozinstall [options] installer 19:36:53 INFO - Options: 19:36:53 INFO - -h, --help show this help message and exit 19:36:53 INFO - -d DEST, --destination=DEST 19:36:53 INFO - Directory to install application into. [default: 19:36:53 INFO - "/builds/slave/test-pgo"] 19:36:53 INFO - --app=APP Application being installed. [default: firefox] 19:36:53 INFO - mkdir: /builds/slave/test-pgo/build/application 19:36:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:36:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:37:09 INFO - Reading from file tmpfile_stdout 19:37:09 INFO - Output received: 19:37:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:37:09 INFO - Running post-action listener: _resource_record_post_action 19:37:09 INFO - ##### 19:37:09 INFO - ##### Running run-tests step. 19:37:09 INFO - ##### 19:37:09 INFO - Running pre-action listener: _resource_record_pre_action 19:37:09 INFO - Running main action method: run_tests 19:37:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:37:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:37:09 INFO - Python 2.7.3 19:37:09 INFO - Return code: 0 19:37:09 INFO - grabbing minidump binary from tooltool 19:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:09 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 0x1c36920>, '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 0x1c37820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:37:09 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 19:37:09 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 19:37:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:09 INFO - Return code: 0 19:37:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:37:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:37:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:37:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:37:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:37:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:37:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:37:10 INFO - Return code: 0 19:37:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:37:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 19:37:10 INFO - Using env: {'DISPLAY': ':0', 19:37:10 INFO - 'HOME': '/home/cltbld', 19:37:10 INFO - 'LANG': 'en_US.UTF-8', 19:37:10 INFO - 'LANGUAGE': 'en_US:en', 19:37:10 INFO - 'LOGNAME': 'cltbld', 19:37:10 INFO - 'MAIL': '/var/mail/cltbld', 19:37:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:37:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:10 INFO - 'MOZ_NO_REMOTE': '1', 19:37:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:10 INFO - 'NO_EM_RESTART': '1', 19:37:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:37:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:37:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:37:10 INFO - 'SHELL': '/bin/bash', 19:37:10 INFO - 'SHLVL': '1', 19:37:10 INFO - 'TERM': 'linux', 19:37:10 INFO - 'TMOUT': '86400', 19:37:10 INFO - 'USER': 'cltbld', 19:37:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944', 19:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:10 INFO - '_': '/tools/buildbot/bin/python'} 19:37:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:37:11 INFO - mozversion application_buildid: 20160317170433 19:37:11 INFO - mozversion application_changeset: 3ffa45c6352e94c9a01dca98f52427dcd05e6ff8 19:37:11 INFO - mozversion application_display_name: Nightly 19:37:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:11 INFO - mozversion application_name: Firefox 19:37:11 INFO - mozversion application_remotingname: firefox 19:37:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:37:11 INFO - mozversion application_vendor: Mozilla 19:37:11 INFO - mozversion application_version: 48.0a1 19:37:11 INFO - mozversion platform_buildid: 20160317170433 19:37:11 INFO - mozversion platform_changeset: 3ffa45c6352e94c9a01dca98f52427dcd05e6ff8 19:37:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:37:11 INFO - mozversion platform_version: 48.0a1 19:37:11 INFO - using testdate: 1458268631 19:37:11 INFO - actual date: 1458268631 19:37:11 INFO - starting webserver on 'localhost:58834' 19:37:11 INFO - SUITE-START | Running 2 tests 19:37:11 INFO - TEST-START | dromaeo_css 19:37:11 INFO - operating with platform_type : linux_ 19:37:11 INFO - Initialising browser for dromaeo_css test... 19:37:11 INFO - TEST-INFO | started process 770 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1nccwH/profile http://localhost:58834/getInfo.html) 19:37:15 INFO - PROCESS | 770 | __metrics Screen width/height:1600/1200 19:37:15 INFO - PROCESS | 770 | colorDepth:24 19:37:15 INFO - PROCESS | 770 | Browser inner width/height: 1024/697 19:37:15 INFO - PROCESS | 770 | __metrics 19:37:16 ERROR - PROCESS | 770 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:37:16 INFO - PROCESS | 770 | 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. 19:37:17 INFO - TEST-INFO | 770: exit 0 19:37:17 INFO - Browser initialized. 19:37:17 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:17 INFO - TEST-INFO | started process 867 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1nccwH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:28 INFO - PROCESS | 867 | RSS: Main: 153329664 19:37:28 INFO - PROCESS | 867 | 19:38:19 INFO - PROCESS | 867 | 1458268699582 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] 19:40:28 INFO - PROCESS | 867 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58834/tests/dromaeo/cssquery-ext.html) 19:40:29 INFO - PROCESS | 867 | RSS: Main: 241958912 19:40:29 INFO - PROCESS | 867 | 19:43:31 INFO - PROCESS | 867 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-ext.html (next: http://localhost:58834/tests/dromaeo/cssquery-jquery.html) 19:43:32 INFO - PROCESS | 867 | RSS: Main: 238940160 19:43:32 INFO - PROCESS | 867 | 19:46:34 INFO - PROCESS | 867 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58834/tests/dromaeo/cssquery-mootools.html) 19:46:34 INFO - PROCESS | 867 | RSS: Main: 238874624 19:46:34 INFO - PROCESS | 867 | 19:49:36 INFO - PROCESS | 867 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58834/tests/dromaeo/cssquery-prototype.html) 19:49:37 INFO - PROCESS | 867 | RSS: Main: 219217920 19:49:37 INFO - PROCESS | 867 | 19:52:39 INFO - PROCESS | 867 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58834/tests/dromaeo/cssquery-yui.html) 19:52:40 INFO - PROCESS | 867 | RSS: Main: 214638592 19:52:40 INFO - PROCESS | 867 | 19:55:42 INFO - PROCESS | 867 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-yui.html (next: http://localhost:58834/tests/dromaeo/cssquery-dojo.html) 19:55:43 INFO - PROCESS | 867 | RSS: Main: 264458240 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | __start_tp_report 19:55:43 INFO - PROCESS | 867 | _x_x_mozilla_page_load 19:55:43 INFO - PROCESS | 867 | _x_x_mozilla_page_load_details 19:55:43 INFO - PROCESS | 867 | |i|pagename|runs| 19:55:43 INFO - PROCESS | 867 | |0;dojo.html;3169.3661267746447;3200.9519857202163;3245.6592057833927;3253.300540383817;3283.5238890360897;5022.246663000552;5117.711353892682;5119;5154.226865970101;5206.9218961715505;5229.477052294778;5255.395629502608;5256.894862102756;5281.841544753654;5290.603204759649;4695.8356457524;4738.45507766607;4761.333413322138;4762.952370476286;4938.407391113072;4876.536729010738;4902.289168070628;4903.117438861003;4925.064237794825;4940.7776650050655;4618.884527886813;4707.952920470786;4800.615950723934;4817.759112044384;4850.320955066276;4731.455882573514;4734.763261836894;4749.976250118727;4756.476787553366;4793.352897358846;4711.128441238382;4711.222648263032;4725.834595789131;4736.076465089309;4777;4973.154563724175;5087.8982420351385;5149.871253218662;5160.741962901878;5166.43169251382;5553.666779993173;5555;5562.3881373048935;5571.331440227158;5578.609497335188;5448.237246785453;5598.888022239533;5603.579731520112;5611.186377975171;5615.466530679579;5207.3751149862255;5243.108671525773;5260.158374660036;5298.443663415324;5305.946940530584;5752.597318187771;5759.481646651738;5762.1068734346245;5765.971170144123;5792.1311803229855;5435.239066530688;5561.277033985556;5562.554995600342;5571.554275657938;5576.330840299109;5624.268845050199;5625.381208067191;5631.1271752878365;5649.519790817826;5676.318841739017;5607.859803504945;5608;5611.382747897728;5611.859703507445;5612.1581762735095;5389.407165211824;5517.393086760453;5591.9720401397735;5607.859803504945;5610.326760788732;4267.594578515036;4276;4281.207976524353;4290.721103128287;4320.675949303752;3857.5370955485523;3869.245497128033;3870.3033453978555;3898.044978980168;3907.33575292201;5074.4671809460215;5151.665141765773;5225.007248622749;5228.7908483660985;5229.450907654717;5565.2486914266865;5582.944170558242;5592.888142237132;5597.104463285855;5625.324961004706;5241.50205730455;5241.842744717665;5246.842594722164;5248.685078895279;5291.047611429903;4649.070185962753;4771.165046116985;4778.450478194983;4837.177679794443;4841.903161936812;5924.8815023700145;5944.227250457413;5946.167536544887;5947.316058653224;5949.553783466257;5615.2700148980375;5624.521915637217;5629.662220266797;5630.493255607015;5634.32388113429;5701.4298570142655;5795.072788353843;5905.763769449174;5922.378150294329;5930;5539.418361072029;5546.889062218814;5548.195511650707;5550.08423610116;5556.055470569932;5575.080111781511;5599.664020158803;5611.326640802967;5616.466435688603;5619.353774316006;5104.540591346797;5442.945570544244;5503.532199763065;5542.168674698827;5547.972260138674;5377.516023557899;5410.729463526886;5422.295101636762;5441;5446.1558458439;5170.224466330081;5327.760250788801;5337.759800808895;5338.145896656516;5340.866478338073;5386.380566234933;5425.945740542544;5469.288992430958;5492.780288788564;5503.3395992481155;5443.7822487100075;5465.07093794048;5469.75386107634;5471.097268950579;5472.699001554953 19:55:43 INFO - PROCESS | 867 | |1;ext.html;523.8559396166054;544.4473859033079;555.3197333266747;557.2616283424461;589.6432658241764;35239.82380088099;36137.638623613755;36146.27707445849;36150.63849361506;36204;37045.44431833525;37567.812160939226;37593.62406375935;37607;37628.623713762856;8300.128486508906;8523.57382130894;8526.531040792754;8533.871991920127;8536.146385361446;8316.916830831675;8605.268552173073;8651.394402391836;8675.479471231714;8677.045524992245;8653.134686531359;8740.8688869667;8745.038045814956;8747.518886461274;8751.3436492263;8598.312135029182;8604.8709269361;8652.697155599586;8667.653293868238;8678.652853885837;8535.061143274235;8676.089010653917;8677.349198810114;8681.782955426102;8683.175098365646;36840.44739328912;37405.25189496195;37445;37471.81264093662;37486.06284842874;2357.9410514737096;3195.744340452758;3295.3244584860045;3409.897703068912;3433.5193072969805;27549.449011019668;27911.860440697666;28034.01880934178;28110.578341324897;28616.284592885135;3822.3310920588788;3844.961550384516;3871.8644847430487;3889.5138107736534;3930.862419815321;295875;300966;301723;303703;304133.9999999978;53591;55100.448995510334;55112.89774204494;59482.70258648679;61034.389656102874;49185.754071229414;66678.66660666763;67495.66252168806;67513.66243168851;67522.3247767516;14234.07478513914;14389.56831295042;14441.49454769078;14449.566513004627;14453.060551064147;11267.887321126684;11332.546698131982;11339.659810205707;11344.31934083941;11347.773044539063;19794.307199247956;20019.39941801748;20094.296699615737;20147.093380797898;20838.895805520875;8070.596470176468;8252.504849708917;8279.793005174919;8301.792455188668;8337.95831020841;922.5894476957824;940.0740270833223;1061.6390427254616;1067.8947289555429;1076.1390887290136;28804;28892.617784835977;28985.855070724512;29207;29395.118146455214;1054.8048611006834;1101.146611376174;1107.9279846809932;1130.2483848240993;1184.8459700239086;14492.275386230645;14869.702605947821;14990.175540345168;15032.549023529311;15105.848941510445;320746;323273;324685;325015;325425;52189.47810521922;52713;52742;52764.472355276725;52801.47198528043;1262.1291308996763;1292.9676758080934;1313.8160657507956;1314.0998416085013;1315.5066849931275;27387.31531711723;28119.156425307272;28707.425851482436;28753;28792.280192995342;45697;45742.313865292715;45975.77012114918;46025;46059.30911036404;305537;306582;307025;307632;307793;26634;27031.86484067646;32132.518012230303;32181.839090804395;32384.83807580947;37440.625593743716;38283.042923927125;38328.23343533058;39073;39467.605323946394;32023.755367704005;32615.673843261262;33026.33947321088;33603.15992100119;33651.15872103217;32571;32971;33271.83364083164;33421;33427;34745.47881781826;35309.29381412409;35535.644643553234;35535.64464355427;35627.28745425129;30255.848720756254;30882.845585771927;31070.22324441907;31225.531617026216;31380.215494612818;24178.637320439855;24718.629220561346;24932.875335623932;27644.308892277855;28215.71784282131 19:55:43 INFO - PROCESS | 867 | |2;jquery.html;355.8914531068025;358.49810265628116;367.10792773560246;368.6276860371024;373.8840959302618;16743;17059.488215353544;17211.225494852744;17337.82662173378;17441.82558174418;15014.549563513085;15528.844711552882;15532;15550.611234719137;15884.205789710497;4989.525995030466;4993.600511959044;5140.742962851861;5762.135679648065;5769.509591684712;5666.093425051992;5672.205891175238;5689.203511508392;5694.316681998145;5704.11586204137;5361.571074314045;5606.971965140189;5613.80351687691;5652.604317697763;5676.858078548028;5578.330600327967;5587.245721827542;5617.662940223599;5621.269234999444;5623.634463759883;5082.923756143661;5291.894162116736;5292.417834038252;5370.060239458079;5383.057964856134;13056.477740890354;13083.345832708326;13142.540011099662;13143.86856131436;13275.269860157687;1897.6299621573799;2009.357005758158;2036.2465887621527;2095.4970807006207;2129.95740085199;9501.192398646124;9711.465869377182;10523.78952420955;12120.696982575419;13148.408321625455;1777.5467255849676;1847.4919397165886;1853.8615478051365;1862.283021036897;1895;61001.69499152476;62802.37197628056;66302.33697663058;66522.66738666325;67398.66300668466;10277.075063244343;10303.505991631322;10438.530266138043;10478.947605262078;10651.680449586525;14099.647508812363;14158.50445234412;14179.858201417854;14196;14203.644908877153;7348.154962179311;7386.113666359964;7444.925550744531;7554.357879580188;7583.544987300779;6686.192510231243;6768;7079.00893874858;7244.239354867663;7303.926960730325;4505.48186958504;4578.88552786183;4605.907881842344;4643.628509719214;4656.650751193606;1855.7587513623412;1880.2948894164688;1884.8115188481042;1897.0704354866293;1916.0994332663627;931.2456909903;942.9528523573794;1049.4647729657777;1054.6625079974335;1073.7047311989265;16481.423150189687;16867.66264674724;17121;17189.14054297305;17546.649067018843;852.5268475995882;926.8470702334039;953.3750869867836;957.9952100239593;960.3661583354952;9579.616815327308;9888.901110988798;9890.159336456481;9961.302708810459;10029.247806414549;397489;402385;403873;403986;404855;66446.33553664401;67881;68222.31777682259;68227;70161;1028.377831411985;1035.7358873487212;1051.894810518942;1059.7721489879714;1060.0618452669444;15538.922305388853;15800.446984355493;15810.68378632398;15956.122413267381;15984;34468.65531344755;34762.65237347594;34872.65127348694;34991;35240.47139292964;46092.53907461017;49431.75284123556;50164;50436.747816260686;50528.24207636815;8098.75703728889;8101.675932962851;8115.513069215866;8121.431499794958;8209.83580328402;9753.707388778348;11984.700382490508;11996.58011969577;12581.182223155465;13156.276404797445;10585.682429527127;10700.625478108228;10715.410652414192;10780;10784.460776961278;10407.895921040692;10604.469776511298;10876.510557024794;10909.945450272699;11458.140639452242;10471.109955653856;10780.730481738019;10847.566097356017;11245.212835101463;11249.325040497597;7808.453408261367;7809.609519524115;7905.723299684483;8172.632231549714;8308.252257296872;11257.324560526395;11292.887071129184;11322.150838687296;11344.546218151512;11350.375729334966 19:55:43 INFO - PROCESS | 867 | |3;mootools.html;1374.3609221711902;1487;1503.9849601503986;1701.2854601067559;1853.3976457651268;7013.403860671842;7720.498167619108;7848.254415830487;7917.208279172094;7917.36661067114;7482.850342993137;7652.158262591124;7662.770116896502;7676.808079798008;7678.961605191967;2021.29254760834;2074.543600407915;2329.7204335479764;2331.8600883946933;2360.5514952159033;2353.329301149173;2363.917262895799;2367.869767162805;2368.1829768729763;2368.2539999899977;2316.2124877541632;2333.708286464192;2368.7275963264187;2372.2645979746335;2377.38188071101;2325.546518428907;2344.2615576093476;2356.3402247370764;2364.9408764780846;2373.2405630198346;2330.347502699247;2340.742518322983;2360.917367892133;2363.4445905212433;2378.5837478441204;8063.838723225503;8080.232377924088;8136.552489613069;8157.510549367057;8177.345812334999;4864.78108485119;4931.901361972777;4956.430010548797;4965.702057876539;4989.301497790312;3073.3545955349405;3087.058447173611;3093.752499800033;3135.4826453635123;3200.8719651213923;996.6362277768562;1006.5319626373771;1034.229499023225;1037.64719995202;1052.6841947415744;11081.335119892752;11089.05743011845;11091.389973551451;11111.222214444992;11125.944370278097;4435.467743870691;4532.478764942074;4584.3352713856975;4588.242939914943;4603.700759450625;9390.436573805593;9401.341906066646;9416.482093484925;9422.575984080733;9441.386309889835;4936.777844996984;4978.377702787152;4979.153543897546;4979.800807967713;4983.501649834988;3805.505284313077;4281.593248641374;4359.891002724958;4390.912181756347;4470.061287129674;3706.4440333950124;3759.793211373346;3780.0549862534367;3791.184895247535;3796.9430458543143;1243.9564615238423;1260.5525038611345;1266.069438962362;1273.2296960339047;1275.4069357748692;1013.8124446977333;1020.2144348851343;1210.2798834693344;1357.694518733297;1372.5607805502343;7567.091948966049;7678.846423071507;7712.5758083305955;7735.883961740466;7746.690132394754;1124.7525544380387;1174.8061569840881;1195.8146487294484;1195.9880401195876;1199.5141967503175;5831.504322132666;5955.37468565803;5989.790357337472;6002.039673652282;6006.789762358297;9239.861402078974;9699.224062075016;9896.55465504054;9901.108900199017;9911;9478.099580539838;9713.805723885484;9735.41587504752;9760.170385517311;9784.217262618973;7269.709211631475;7538.3215510604305;7693.076830780342;7704.999999999888;7706.38348932084;7369.078865141857;7372.889406659012;7415.777526674208;7462.253774622494;7463.17905030457;8521.190486903733;8609.268212202032;8696.130386961253;8833.558322083742;8866.024737278765;8465.95767021161;8933.419327743675;9057.501837399006;9115.498647574183;9149.542522873962;6170.259568851767;6795.150606174228;6827.658617069226;6893.827654308682;7013.614251216028;7631.427642926692;7655.961720191363;7674.577898215652;7694.192109828387;7702.653380597774;6825.931740682529;6835.4189893859575;6867.381935625817;6890.621015844176;7068.787936361918;6676.0987266718375;6694.263631000488;6767.39093481589;6798.898016529855;6941.826454338682;6831.658417079027;6873.415759660485;6912;6915.93084069173;7012.403945664676;6520.706568204537;6568.573042752206;6601.900971485527;6604.405603495708;6670.899936500859;6682.732690692513;6728.529002969745;6771.62756048422;6773.93226067733;6778.559393639398 19:55:43 INFO - PROCESS | 867 | |4;prototype.html;345.29215109026495;348.256472431359;349.20381530111354;349.755171380034;354.4665278755474;5709.086546152611;5732.942670573293;5765.711714414273;5778.653280803154;5798.565107616924;5731.770729170828;5736.942630573693;5738.0532212184935;5744.33940096889;5752.827415177551;4301.376300436435;4406.339049142638;4499.122671079141;4519.683622146451;4528.9094218115615;4471.552844715535;4502.279635258359;4510.503844577094;4518.683692141552;4526.388937493429;4270.402143699885;4467.441569803775;4479.686421950465;4481.619062379702;4487.214737420954;4348.412964249817;4421.801018954155;4421.955780442218;4422.380866678667;4439.023414848728;3954.7231693781446;3960.425738267964;3970.5830887756947;3973.36426171814;3978.8209530571194;5510;5527.364353099405;5541.0580201365865;5543.057680194376;5544.112941929272;5208.114620514521;5210.973945130288;5211.062008838408;5213.139831927728;5217.50433708797;6084.26988761347;6088.878222435571;6090.756369745205;6090.939090609081;6091.634501929899;4133.7106402551835;4277.97861010696;4291.935620965688;4298.78506074695;4419.955800441987;6276.623402595859;6341.207349081365;6359.9364006360265;6361.173047503795;6362.363763623647;4354.455693038371;4355.564443555619;4361.869143925687;4368.978155109204;4373.606375426163;4429.55704429561;4431.180231657154;4432.047109871393;4438.467383913951;4438.733675979452;5111.667741596784;5117.130087885069;5123.3339665843205;5128.461511541309;5131.076406246912;5976.820695379146;6129.2032035835055;6133.601315914451;6138.785142519991;6141.662208578571;1513.402206128595;1527.0990115831712;1534.2098819108169;1538.1002113763573;1539.0534821085175;989.5893204320271;1017.1557607186018;1037.8858325584179;1060.48566445274;1068.423051552153;5777.45114214149;5779.624324418899;5780.1907732917425;5780.219670344533;5783.94216057834;6109.8472538186015;6146.293176284695;6173.290071641819;6184.783532576338;6186.628802271878;5717.656940583578;5750.7987220447085;5752.050911599539;5759;5769.134629805562;3310.9503357449657;3365.781224220467;3387.5765529308837;3392.2876195999115;3392.9491057634154;6354.555181137369;6548.410643042149;6601.636909969901;6718.865622687519;6740.854054810694;6451.612903225821;6471.935280647133;6473.41739243461;6479.125318082093;6480.189976252968;6710.597364158069;6711.597304161766;6725.125733654593;6733.427658648971;6733.562318449285;6323.36766323364;6346.079818426395;6356.682165891594;6357.364263573606;6362.554621176473;6138.355472675305;6224.9377506224355;6278.529110316836;6282.623042617458;6286.65423401699;6718.093057437183;6736.528443008942;6738.2587915328295;6741;6755.189377274758;4310.956890431055;4358.4769827620885;4363.4109395231235;4365.781710914378;4366.585174408426;6356.618602883842;6359.332270111757;6361.045843123568;6364.6181229126405;6365.554411191172;6162.599431036968;6179.0422484514975;6180.227471566054;6181.690915454299;6183.907241391473;6003.549733769897;6152.538559607958;6174.598651087845;6189.84525386869;6198.0702894566175;6046.7581296749395;6076.422739839708;6077.513798896166;6078.027515597483;6092.9086063709965;6150.50795936333;6157.445829875153;6183.041628547582;6185.072239164161;6190.3190649029475;5839.182514447895;5880.705964701833;6039.063945088518;6058.636481811105;6062.696865156813 19:55:43 INFO - PROCESS | 867 | |5;yui.html;620.7392894984106;631.4821846086211;648.6659370424229;659.0970370592289;762.6065296946106;13177.934110329446;13250.734985300312;13264.270465124415;13295.46818127275;13695.863041369596;13128.934355328234;13220.074594778369;13276.137051091673;13279.668008299797;13293.867061329383;674.8751480976023;823.5017814222399;852.3735054734796;852.8081181734123;853.7566793463864;848.8047749017729;853.8676505141682;854.5855260198798;856.5289090999956;857.4769390671685;896.6547879066541;902.0753727429371;902.8329758994574;902.9458232506071;903;706.3219309462921;869.9217070463689;896.2068569316137;898.9775255618629;899.0515006667963;649.447969226154;653.5457856789533;653.9247986481521;654.0091760982068;654.9803505894831;13656;13729.588112356645;13738.175709457364;13765.105268157538;13822.516211932634;11544.307341559534;12048.638540843789;12086.456109475095;12200.328981905992;12339;10611.522481488351;10828.133749300037;10923.836142457869;10926.50830712612;11094.1124710023;3431.6396778338412;3513.437849944022;3560.8041557714314;3576.8748093816594;3628.256207477461;48415.75792121052;48430.27354589684;48665.75667121677;48753.04987800484;48959;10451.425171615481;10468.319559228627;10495.107915827088;10686.572537098584;11084.722881927855;19417.708734368996;19470.123844427035;19542.413727588195;19554.902225488782;19564.902175489315;7423.62881855905;7634.770956871303;7777.922220777833;7809.101953275333;7961.1242763295995;4435.112977404532;4448.888777780517;4490.057088011489;4535.523770004168;4593.104344652827;3061.969380306168;3111.4554952883154;3122.8126312421327;3124.2814152744995;3128.9217769555944;585.8418227078665;594.7561499785068;611.6910959965189;615.3630991923338;617.9876402471925;665.9933400666029;686.4885660183096;695.4109858972224;710.705057401183;713.2974020589714;7834.262534220566;8083.919160808434;8188.628956181981;8648.005479369953;8986.460812351279;640.7629177204465;646.2955378637308;675.7330854312519;697.5187120886573;698.9161300643854;3886.591907849635;4058.8782336529953;4064.5122585289955;4265.104328091135;4395.099004704028;56192.719036405375;56585;56854;57371.713141434026;57482.42517574855;49199.50800492021;49513.50486495089;50068;50374.244386334234;50392.24411633828;43207.35188972168;44069.77965110218;45824.312635310496;47109;47448.5255147451;8140.959295203486;8390.412671112963;8757.343199259954;8926.955365223132;8994.42345745642;34331;34608.30783384368;35171;35876.82061589675;36349.81825090964;41450.58549414588;42528.787356063025;43847.123057539306;44329.55670443254;44641.33038004497;10973.725656858323;10979.945100274448;11100.666979990614;11379.886201137882;12083.758324833278;10996.340219586851;11145.164112691418;12342.691432714253;12650.557230496888;12654.493820247088;8446.957765211135;9852.950735246279;11970.940145299217;12037.699057523632;12252.571160009356;11656.697318691824;11842.28946263227;11879.346635935106;12126.514939402325;12313.938430307791;10618.415987120783;10759.176462998781;10967.287126336763;11199.21605487608;11373.678964099707;9486.601602446439;9648.95175524146;10120;10209.693709188736;10387.37675739458;9451.243900487807;10145.84781228297;10319.019693129141;10341.121004714683;10488.947555262175 19:55:43 INFO - PROCESS | 867 | __end_tp_report 19:55:43 INFO - PROCESS | 867 | __start_cc_report 19:55:43 INFO - PROCESS | 867 | _x_x_mozilla_cycle_collect,765 19:55:43 INFO - PROCESS | 867 | __end_cc_report 19:55:43 INFO - PROCESS | 867 | __startTimestamp1458269743151__endTimestamp 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | ------- Summary: start ------- 19:55:43 INFO - PROCESS | 867 | Number of tests: 6 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | [#0] dojo.html Cycles:165 Average:5205.44 Median:5386.38 stddev:570.13 (10.6%) stddev-sans-first:549.05 19:55:43 INFO - PROCESS | 867 | Values: 3169.4 3201.0 3245.7 3253.3 3283.5 5022.2 5117.7 5119.0 5154.2 5206.9 5229.5 5255.4 5256.9 5281.8 5290.6 4695.8 4738.5 4761.3 4763.0 4938.4 4876.5 4902.3 4903.1 4925.1 4940.8 4618.9 4708.0 4800.6 4817.8 4850.3 4731.5 4734.8 4750.0 4756.5 4793.4 4711.1 4711.2 4725.8 4736.1 4777.0 4973.2 5087.9 5149.9 5160.7 5166.4 5553.7 5555.0 5562.4 5571.3 5578.6 5448.2 5598.9 5603.6 5611.2 5615.5 5207.4 5243.1 5260.2 5298.4 5305.9 5752.6 5759.5 5762.1 5766.0 5792.1 5435.2 5561.3 5562.6 5571.6 5576.3 5624.3 5625.4 5631.1 5649.5 5676.3 5607.9 5608.0 5611.4 5611.9 5612.2 5389.4 5517.4 5592.0 5607.9 5610.3 4267.6 4276.0 4281.2 4290.7 4320.7 3857.5 3869.2 3870.3 3898.0 3907.3 5074.5 5151.7 5225.0 5228.8 5229.5 5565.2 5582.9 5592.9 5597.1 5625.3 5241.5 5241.8 5246.8 5248.7 5291.0 4649.1 4771.2 4778.5 4837.2 4841.9 5924.9 5944.2 5946.2 5947.3 5949.6 5615.3 5624.5 5629.7 5630.5 5634.3 5701.4 5795.1 5905.8 5922.4 5930.0 5539.4 5546.9 5548.2 5550.1 5556.1 5575.1 5599.7 5611.3 5616.5 5619.4 5104.5 5442.9 5503.5 5542.2 5548.0 5377.5 5410.7 5422.3 5441.0 5446.2 5170.2 5327.8 5337.8 5338.1 5340.9 5386.4 5425.9 5469.3 5492.8 5503.3 5443.8 5465.1 5469.8 5471.1 5472.7 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | [#1] ext.html Cycles:180 Average:47151.17 Median:18530.53 stddev:81443.37 (439.5%) stddev-sans-first:81596.59 19:55:43 INFO - PROCESS | 867 | Values: 523.9 544.4 555.3 557.3 589.6 35239.8 36137.6 36146.3 36150.6 36204.0 37045.4 37567.8 37593.6 37607.0 37628.6 8300.1 8523.6 8526.5 8533.9 8536.1 8316.9 8605.3 8651.4 8675.5 8677.0 8653.1 8740.9 8745.0 8747.5 8751.3 8598.3 8604.9 8652.7 8667.7 8678.7 8535.1 8676.1 8677.3 8681.8 8683.2 36840.4 37405.3 37445.0 37471.8 37486.1 2357.9 3195.7 3295.3 3409.9 3433.5 27549.4 27911.9 28034.0 28110.6 28616.3 3822.3 3845.0 3871.9 3889.5 3930.9 295875.0 300966.0 301723.0 303703.0 304134.0 53591.0 55100.4 55112.9 59482.7 61034.4 49185.8 66678.7 67495.7 67513.7 67522.3 14234.1 14389.6 14441.5 14449.6 14453.1 11267.9 11332.5 11339.7 11344.3 11347.8 19794.3 20019.4 20094.3 20147.1 20838.9 8070.6 8252.5 8279.8 8301.8 8338.0 922.6 940.1 1061.6 1067.9 1076.1 28804.0 28892.6 28985.9 29207.0 29395.1 1054.8 1101.1 1107.9 1130.2 1184.8 14492.3 14869.7 14990.2 15032.5 15105.8 320746.0 323273.0 324685.0 325015.0 325425.0 52189.5 52713.0 52742.0 52764.5 52801.5 1262.1 1293.0 1313.8 1314.1 1315.5 27387.3 28119.2 28707.4 28753.0 28792.3 45697.0 45742.3 45975.8 46025.0 46059.3 305537.0 306582.0 307025.0 307632.0 307793.0 26634.0 27031.9 32132.5 32181.8 32384.8 37440.6 38283.0 38328.2 39073.0 39467.6 32023.8 32615.7 33026.3 33603.2 33651.2 32571.0 32971.0 33271.8 33421.0 33427.0 34745.5 35309.3 35535.6 35535.6 35627.3 30255.8 30882.8 31070.2 31225.5 31380.2 24178.6 24718.6 24932.9 27644.3 28215.7 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | [#2] jquery.html Cycles:180 Average:24204.04 Median:17798.18 stddev:66068.60 (371.2%) stddev-sans-first:66229.67 19:55:43 INFO - PROCESS | 867 | Values: 355.9 358.5 367.1 368.6 373.9 16743.0 17059.5 17211.2 17337.8 17441.8 15014.5 15528.8 15532.0 15550.6 15884.2 4989.5 4993.6 5140.7 5762.1 5769.5 5666.1 5672.2 5689.2 5694.3 5704.1 5361.6 5607.0 5613.8 5652.6 5676.9 5578.3 5587.2 5617.7 5621.3 5623.6 5082.9 5291.9 5292.4 5370.1 5383.1 13056.5 13083.3 13142.5 13143.9 13275.3 1897.6 2009.4 2036.2 2095.5 2130.0 9501.2 9711.5 10523.8 12120.7 13148.4 1777.5 1847.5 1853.9 1862.3 1895.0 61001.7 62802.4 66302.3 66522.7 67398.7 10277.1 10303.5 10438.5 10478.9 10651.7 14099.6 14158.5 14179.9 14196.0 14203.6 7348.2 7386.1 7444.9 7554.4 7583.5 6686.2 6768.0 7079.0 7244.2 7303.9 4505.5 4578.9 4605.9 4643.6 4656.7 1855.8 1880.3 1884.8 1897.1 1916.1 931.2 943.0 1049.5 1054.7 1073.7 16481.4 16867.7 17121.0 17189.1 17546.6 852.5 926.8 953.4 958.0 960.4 9579.6 9888.9 9890.2 9961.3 10029.2 397489.0 402385.0 403873.0 403986.0 404855.0 66446.3 67881.0 68222.3 68227.0 70161.0 1028.4 1035.7 1051.9 1059.8 1060.1 15538.9 15800.4 15810.7 15956.1 15984.0 34468.7 34762.7 34872.7 34991.0 35240.5 46092.5 49431.8 50164.0 50436.7 50528.2 8098.8 8101.7 8115.5 8121.4 8209.8 9753.7 11984.7 11996.6 12581.2 13156.3 10585.7 10700.6 10715.4 10780.0 10784.5 10407.9 10604.5 10876.5 10909.9 11458.1 10471.1 10780.7 10847.6 11245.2 11249.3 7808.5 7809.6 7905.7 8172.6 8308.3 11257.3 11292.9 11322.2 11344.5 11350.4 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | [#3] mootools.html Cycles:180 Average:5597.45 Median:6544.64 stddev:2898.58 (44.3%) stddev-sans-first:2889.32 19:55:43 INFO - PROCESS | 867 | Values: 1374.4 1487.0 1504.0 1701.3 1853.4 7013.4 7720.5 7848.3 7917.2 7917.4 7482.9 7652.2 7662.8 7676.8 7679.0 2021.3 2074.5 2329.7 2331.9 2360.6 2353.3 2363.9 2367.9 2368.2 2368.3 2316.2 2333.7 2368.7 2372.3 2377.4 2325.5 2344.3 2356.3 2364.9 2373.2 2330.3 2340.7 2360.9 2363.4 2378.6 8063.8 8080.2 8136.6 8157.5 8177.3 4864.8 4931.9 4956.4 4965.7 4989.3 3073.4 3087.1 3093.8 3135.5 3200.9 996.6 1006.5 1034.2 1037.6 1052.7 11081.3 11089.1 11091.4 11111.2 11125.9 4435.5 4532.5 4584.3 4588.2 4603.7 9390.4 9401.3 9416.5 9422.6 9441.4 4936.8 4978.4 4979.2 4979.8 4983.5 3805.5 4281.6 4359.9 4390.9 4470.1 3706.4 3759.8 3780.1 3791.2 3796.9 1244.0 1260.6 1266.1 1273.2 1275.4 1013.8 1020.2 1210.3 1357.7 1372.6 7567.1 7678.8 7712.6 7735.9 7746.7 1124.8 1174.8 1195.8 1196.0 1199.5 5831.5 5955.4 5989.8 6002.0 6006.8 9239.9 9699.2 9896.6 9901.1 9911.0 9478.1 9713.8 9735.4 9760.2 9784.2 7269.7 7538.3 7693.1 7705.0 7706.4 7369.1 7372.9 7415.8 7462.3 7463.2 8521.2 8609.3 8696.1 8833.6 8866.0 8466.0 8933.4 9057.5 9115.5 9149.5 6170.3 6795.2 6827.7 6893.8 7013.6 7631.4 7656.0 7674.6 7694.2 7702.7 6825.9 6835.4 6867.4 6890.6 7068.8 6676.1 6694.3 6767.4 6798.9 6941.8 6831.7 6873.4 6912.0 6915.9 7012.4 6520.7 6568.6 6601.9 6604.4 6670.9 6682.7 6728.5 6771.6 6773.9 6778.6 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | [#4] prototype.html Cycles:180 Average:5141.75 Median:5767.42 stddev:1546.29 (26.8%) stddev-sans-first:1508.13 19:55:43 INFO - PROCESS | 867 | Values: 345.3 348.3 349.2 349.8 354.5 5709.1 5732.9 5765.7 5778.7 5798.6 5731.8 5736.9 5738.1 5744.3 5752.8 4301.4 4406.3 4499.1 4519.7 4528.9 4471.6 4502.3 4510.5 4518.7 4526.4 4270.4 4467.4 4479.7 4481.6 4487.2 4348.4 4421.8 4422.0 4422.4 4439.0 3954.7 3960.4 3970.6 3973.4 3978.8 5510.0 5527.4 5541.1 5543.1 5544.1 5208.1 5211.0 5211.1 5213.1 5217.5 6084.3 6088.9 6090.8 6090.9 6091.6 4133.7 4278.0 4291.9 4298.8 4420.0 6276.6 6341.2 6359.9 6361.2 6362.4 4354.5 4355.6 4361.9 4369.0 4373.6 4429.6 4431.2 4432.0 4438.5 4438.7 5111.7 5117.1 5123.3 5128.5 5131.1 5976.8 6129.2 6133.6 6138.8 6141.7 1513.4 1527.1 1534.2 1538.1 1539.1 989.6 1017.2 1037.9 1060.5 1068.4 5777.5 5779.6 5780.2 5780.2 5783.9 6109.8 6146.3 6173.3 6184.8 6186.6 5717.7 5750.8 5752.1 5759.0 5769.1 3311.0 3365.8 3387.6 3392.3 3392.9 6354.6 6548.4 6601.6 6718.9 6740.9 6451.6 6471.9 6473.4 6479.1 6480.2 6710.6 6711.6 6725.1 6733.4 6733.6 6323.4 6346.1 6356.7 6357.4 6362.6 6138.4 6224.9 6278.5 6282.6 6286.7 6718.1 6736.5 6738.3 6741.0 6755.2 4311.0 4358.5 4363.4 4365.8 4366.6 6356.6 6359.3 6361.0 6364.6 6365.6 6162.6 6179.0 6180.2 6181.7 6183.9 6003.5 6152.5 6174.6 6189.8 6198.1 6046.8 6076.4 6077.5 6078.0 6092.9 6150.5 6157.4 6183.0 6185.1 6190.3 5839.2 5880.7 6039.1 6058.6 6062.7 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - PROCESS | 867 | [#5] yui.html Cycles:180 Average:13804.06 Median:24382.33 stddev:15735.87 (64.5%) stddev-sans-first:15748.86 19:55:43 INFO - PROCESS | 867 | Values: 620.7 631.5 648.7 659.1 762.6 13177.9 13250.7 13264.3 13295.5 13695.9 13128.9 13220.1 13276.1 13279.7 13293.9 674.9 823.5 852.4 852.8 853.8 848.8 853.9 854.6 856.5 857.5 896.7 902.1 902.8 902.9 903.0 706.3 869.9 896.2 899.0 899.1 649.4 653.5 653.9 654.0 655.0 13656.0 13729.6 13738.2 13765.1 13822.5 11544.3 12048.6 12086.5 12200.3 12339.0 10611.5 10828.1 10923.8 10926.5 11094.1 3431.6 3513.4 3560.8 3576.9 3628.3 48415.8 48430.3 48665.8 48753.0 48959.0 10451.4 10468.3 10495.1 10686.6 11084.7 19417.7 19470.1 19542.4 19554.9 19564.9 7423.6 7634.8 7777.9 7809.1 7961.1 4435.1 4448.9 4490.1 4535.5 4593.1 3062.0 3111.5 3122.8 3124.3 3128.9 585.8 594.8 611.7 615.4 618.0 666.0 686.5 695.4 710.7 713.3 7834.3 8083.9 8188.6 8648.0 8986.5 640.8 646.3 675.7 697.5 698.9 3886.6 4058.9 4064.5 4265.1 4395.1 56192.7 56585.0 56854.0 57371.7 57482.4 49199.5 49513.5 50068.0 50374.2 50392.2 43207.4 44069.8 45824.3 47109.0 47448.5 8141.0 8390.4 8757.3 8927.0 8994.4 34331.0 34608.3 35171.0 35876.8 36349.8 41450.6 42528.8 43847.1 44329.6 44641.3 10973.7 10979.9 11100.7 11379.9 12083.8 10996.3 11145.2 12342.7 12650.6 12654.5 8447.0 9853.0 11970.9 12037.7 12252.6 11656.7 11842.3 11879.3 12126.5 12313.9 10618.4 10759.2 10967.3 11199.2 11373.7 9486.6 9649.0 10120.0 10209.7 10387.4 9451.2 10145.8 10319.0 10341.1 10488.9 19:55:43 INFO - PROCESS | 867 | -------- Summary: end -------- 19:55:43 INFO - PROCESS | 867 | 19:55:43 INFO - TEST-INFO | 867: exit 0 19:55:43 INFO - TEST-OK | dromaeo_css | took 1112728ms 19:55:43 INFO - TEST-START | kraken 19:55:43 INFO - operating with platform_type : linux_ 19:55:43 INFO - Initialising browser for kraken test... 19:55:43 INFO - TEST-INFO | started process 1051 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxXfsQC/profile http://localhost:58834/getInfo.html) 19:55:47 INFO - PROCESS | 1051 | __metrics Screen width/height:1600/1200 19:55:47 INFO - PROCESS | 1051 | colorDepth:24 19:55:47 INFO - PROCESS | 1051 | Browser inner width/height: 1024/697 19:55:47 INFO - PROCESS | 1051 | __metrics 19:55:48 ERROR - PROCESS | 1051 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:55:48 INFO - PROCESS | 1051 | 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. 19:55:49 INFO - TEST-INFO | 1051: exit 0 19:55:49 INFO - Browser initialized. 19:55:49 INFO - Running cycle 1/1 for kraken test... 19:55:49 INFO - TEST-INFO | started process 1142 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxXfsQC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:01 INFO - PROCESS | 1142 | RSS: Main: 154771456 19:56:01 INFO - PROCESS | 1142 | 19:56:03 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:04 INFO - PROCESS | 1142 | RSS: Main: 195694592 19:56:04 INFO - PROCESS | 1142 | 19:56:07 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-dft) 19:56:07 INFO - PROCESS | 1142 | RSS: Main: 184737792 19:56:07 INFO - PROCESS | 1142 | 19:56:10 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-fft) 19:56:11 INFO - PROCESS | 1142 | RSS: Main: 172036096 19:56:11 INFO - PROCESS | 1142 | 19:56:13 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-oscillator) 19:56:13 INFO - PROCESS | 1142 | RSS: Main: 172822528 19:56:13 INFO - PROCESS | 1142 | 19:56:15 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58834/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:16 INFO - PROCESS | 1142 | RSS: Main: 173965312 19:56:16 INFO - PROCESS | 1142 | 19:56:19 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58834/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:20 INFO - PROCESS | 1142 | RSS: Main: 175738880 19:56:20 INFO - PROCESS | 1142 | 19:56:23 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58834/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:24 INFO - PROCESS | 1142 | RSS: Main: 176033792 19:56:24 INFO - PROCESS | 1142 | 19:56:26 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58834/tests/kraken/driver.html?testName=json-parse-financial) 19:56:27 INFO - PROCESS | 1142 | RSS: Main: 177152000 19:56:27 INFO - PROCESS | 1142 | 19:56:29 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58834/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:29 INFO - PROCESS | 1142 | RSS: Main: 184819712 19:56:29 INFO - PROCESS | 1142 | 19:56:31 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:32 INFO - PROCESS | 1142 | RSS: Main: 183812096 19:56:32 INFO - PROCESS | 1142 | 19:56:34 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:34 INFO - PROCESS | 1142 | RSS: Main: 193875968 19:56:34 INFO - PROCESS | 1142 | 19:56:37 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:37 INFO - PROCESS | 1142 | RSS: Main: 198324224 19:56:37 INFO - PROCESS | 1142 | 19:56:40 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:40 INFO - PROCESS | 1142 | RSS: Main: 197910528 19:56:40 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58834/tests/kraken/driver.html?testName=ai-astar) 19:56:42 INFO - PROCESS | 1142 | RSS: Main: 258420736 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | __start_tp_report 19:56:42 INFO - PROCESS | 1142 | _x_x_mozilla_page_load 19:56:42 INFO - PROCESS | 1142 | _x_x_mozilla_page_load_details 19:56:42 INFO - PROCESS | 1142 | |i|pagename|runs| 19:56:42 INFO - PROCESS | 1142 | |0;ai-astar;109;111;105;110;110;111;100;109;110;110 19:56:42 INFO - PROCESS | 1142 | |1;audio-beat-detection;152;125;151;170;128;151;162;127;176;126 19:56:42 INFO - PROCESS | 1142 | |2;audio-dft;163;160;160;160;161;160;160;164;160;161 19:56:42 INFO - PROCESS | 1142 | |3;audio-fft;76;76;94;101;72;75;75;112;95;75 19:56:42 INFO - PROCESS | 1142 | |4;audio-oscillator;94;94;136;94;94;93;144;93;92;143 19:56:42 INFO - PROCESS | 1142 | |5;imaging-gaussian-blur;118;117;117;117;117;117;116;117;117;117 19:56:42 INFO - PROCESS | 1142 | |6;imaging-darkroom;146;145;146;145;145;146;145;146;145;144 19:56:42 INFO - PROCESS | 1142 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;96 19:56:42 INFO - PROCESS | 1142 | |8;json-parse-financial;59;57;58;57;56;57;56;67;57;56 19:56:42 INFO - PROCESS | 1142 | |9;json-stringify-tinderbox;69;69;68;69;68;69;68;68;68;69 19:56:42 INFO - PROCESS | 1142 | |10;stanford-crypto-aes;83;82;82;81;82;82;84;82;83;86 19:56:42 INFO - PROCESS | 1142 | |11;stanford-crypto-ccm;124;125;114;124;115;122;116;117;115;115 19:56:42 INFO - PROCESS | 1142 | |12;stanford-crypto-pbkdf2;141;143;151;151;140;139;153;148;151;148 19:56:42 INFO - PROCESS | 1142 | |13;stanford-crypto-sha256-iterative;69;70;69;69;70;69;68;69;68;65 19:56:42 INFO - PROCESS | 1142 | __end_tp_report 19:56:42 INFO - PROCESS | 1142 | __start_cc_report 19:56:42 INFO - PROCESS | 1142 | _x_x_mozilla_cycle_collect,1069 19:56:42 INFO - PROCESS | 1142 | __end_cc_report 19:56:42 INFO - PROCESS | 1142 | __startTimestamp1458269802767__endTimestamp 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | ------- Summary: start ------- 19:56:42 INFO - PROCESS | 1142 | Number of tests: 14 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.44 (3.1%) stddev-sans-first:3.64 19:56:42 INFO - PROCESS | 1142 | Values: 109.0 111.0 105.0 110.0 110.0 111.0 100.0 109.0 110.0 110.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:151.50 stddev:19.26 (12.7%) stddev-sans-first:20.33 19:56:42 INFO - PROCESS | 1142 | Values: 152.0 125.0 151.0 170.0 128.0 151.0 162.0 127.0 176.0 126.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#2] audio-dft Cycles:10 Average:160.90 Median:160.50 stddev:1.45 (0.9%) stddev-sans-first:1.32 19:56:42 INFO - PROCESS | 1142 | Values: 163.0 160.0 160.0 160.0 161.0 160.0 160.0 164.0 160.0 161.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#3] audio-fft Cycles:10 Average:85.10 Median:75.50 stddev:14.13 (18.7%) stddev-sans-first:14.60 19:56:42 INFO - PROCESS | 1142 | Values: 76.0 76.0 94.0 101.0 72.0 75.0 75.0 112.0 95.0 75.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.50 stddev:23.08 (24.7%) stddev-sans-first:23.94 19:56:42 INFO - PROCESS | 1142 | Values: 94.0 94.0 136.0 94.0 94.0 93.0 144.0 93.0 92.0 143.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 19:56:42 INFO - PROCESS | 1142 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:56:42 INFO - PROCESS | 1142 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 144.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:56:42 INFO - PROCESS | 1142 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:3.30 (5.8%) stddev-sans-first:3.48 19:56:42 INFO - PROCESS | 1142 | Values: 59.0 57.0 58.0 57.0 56.0 57.0 56.0 67.0 57.0 56.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:56:42 INFO - PROCESS | 1142 | Values: 69.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 69.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:1.42 (1.7%) stddev-sans-first:1.50 19:56:42 INFO - PROCESS | 1142 | Values: 83.0 82.0 82.0 81.0 82.0 82.0 84.0 82.0 83.0 86.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:4.47 (3.7%) stddev-sans-first:4.31 19:56:42 INFO - PROCESS | 1142 | Values: 124.0 125.0 114.0 124.0 115.0 122.0 116.0 117.0 115.0 115.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:149.50 stddev:5.25 (3.5%) stddev-sans-first:5.18 19:56:42 INFO - PROCESS | 1142 | Values: 141.0 143.0 151.0 151.0 140.0 139.0 153.0 148.0 151.0 148.0 19:56:42 INFO - PROCESS | 1142 | 19:56:42 INFO - PROCESS | 1142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 19:56:42 INFO - PROCESS | 1142 | Values: 69.0 70.0 69.0 69.0 70.0 69.0 68.0 69.0 68.0 65.0 19:56:42 INFO - PROCESS | 1142 | -------- Summary: end -------- 19:56:42 INFO - PROCESS | 1142 | 19:56:43 INFO - TEST-INFO | 1142: exit 0 19:56:43 INFO - TEST-OK | kraken | took 59921ms 19:56:43 INFO - SUITE-END | took 1172s 19:56:43 INFO - Completed test suite (00:19:32) 19:56:43 INFO - javascript benchmark 19:56:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3169.3661267746447, 3200.9519857202163, 3245.6592057833927, 3253.300540383817, 3283.5238890360897, 5022.246663000552, 5117.711353892682, 5119.0, 5154.226865970101, 5206.9218961715505, 5229.477052294778, 5255.395629502608, 5256.894862102756, 5281.841544753654, 5290.603204759649, 4695.8356457524, 4738.45507766607, 4761.333413322138, 4762.952370476286, 4938.407391113072, 4876.536729010738, 4902.289168070628, 4903.117438861003, 4925.064237794825, 4940.7776650050655, 4618.884527886813, 4707.952920470786, 4800.615950723934, 4817.759112044384, 4850.320955066276, 4731.455882573514, 4734.763261836894, 4749.976250118727, 4756.476787553366, 4793.352897358846, 4711.128441238382, 4711.222648263032, 4725.834595789131, 4736.076465089309, 4777.0, 4973.154563724175, 5087.8982420351385, 5149.871253218662, 5160.741962901878, 5166.43169251382, 5553.666779993173, 5555.0, 5562.3881373048935, 5571.331440227158, 5578.609497335188, 5448.237246785453, 5598.888022239533, 5603.579731520112, 5611.186377975171, 5615.466530679579, 5207.3751149862255, 5243.108671525773, 5260.158374660036, 5298.443663415324, 5305.946940530584, 5752.597318187771, 5759.481646651738, 5762.1068734346245, 5765.971170144123, 5792.1311803229855, 5435.239066530688, 5561.277033985556, 5562.554995600342, 5571.554275657938, 5576.330840299109, 5624.268845050199, 5625.381208067191, 5631.1271752878365, 5649.519790817826, 5676.318841739017, 5607.859803504945, 5608.0, 5611.382747897728, 5611.859703507445, 5612.1581762735095, 5389.407165211824, 5517.393086760453, 5591.9720401397735, 5607.859803504945, 5610.326760788732, 4267.594578515036, 4276.0, 4281.207976524353, 4290.721103128287, 4320.675949303752, 3857.5370955485523, 3869.245497128033, 3870.3033453978555, 3898.044978980168, 3907.33575292201, 5074.4671809460215, 5151.665141765773, 5225.007248622749, 5228.7908483660985, 5229.450907654717, 5565.2486914266865, 5582.944170558242, 5592.888142237132, 5597.104463285855, 5625.324961004706, 5241.50205730455, 5241.842744717665, 5246.842594722164, 5248.685078895279, 5291.047611429903, 4649.070185962753, 4771.165046116985, 4778.450478194983, 4837.177679794443, 4841.903161936812, 5924.8815023700145, 5944.227250457413, 5946.167536544887, 5947.316058653224, 5949.553783466257, 5615.2700148980375, 5624.521915637217, 5629.662220266797, 5630.493255607015, 5634.32388113429, 5701.4298570142655, 5795.072788353843, 5905.763769449174, 5922.378150294329, 5930.0, 5539.418361072029, 5546.889062218814, 5548.195511650707, 5550.08423610116, 5556.055470569932, 5575.080111781511, 5599.664020158803, 5611.326640802967, 5616.466435688603, 5619.353774316006, 5104.540591346797, 5442.945570544244, 5503.532199763065, 5542.168674698827, 5547.972260138674, 5377.516023557899, 5410.729463526886, 5422.295101636762, 5441.0, 5446.1558458439, 5170.224466330081, 5327.760250788801, 5337.759800808895, 5338.145896656516, 5340.866478338073, 5386.380566234933, 5425.945740542544, 5469.288992430958, 5492.780288788564, 5503.3395992481155, 5443.7822487100075, 5465.07093794048, 5469.75386107634, 5471.097268950579, 5472.699001554953], "unit": "score", "name": "dojo.html", "value": 5169.669138814696}, {"lowerIsBetter": false, "replicates": [523.8559396166054, 544.4473859033079, 555.3197333266747, 557.2616283424461, 589.6432658241764, 35239.82380088099, 36137.638623613755, 36146.27707445849, 36150.63849361506, 36204.0, 37045.44431833525, 37567.812160939226, 37593.62406375935, 37607.0, 37628.623713762856, 8300.128486508906, 8523.57382130894, 8526.531040792754, 8533.871991920127, 8536.146385361446, 8316.916830831675, 8605.268552173073, 8651.394402391836, 8675.479471231714, 8677.045524992245, 8653.134686531359, 8740.8688869667, 8745.038045814956, 8747.518886461274, 8751.3436492263, 8598.312135029182, 8604.8709269361, 8652.697155599586, 8667.653293868238, 8678.652853885837, 8535.061143274235, 8676.089010653917, 8677.349198810114, 8681.782955426102, 8683.175098365646, 36840.44739328912, 37405.25189496195, 37445.0, 37471.81264093662, 37486.06284842874, 2357.9410514737096, 3195.744340452758, 3295.3244584860045, 3409.897703068912, 3433.5193072969805, 27549.449011019668, 27911.860440697666, 28034.01880934178, 28110.578341324897, 28616.284592885135, 3822.3310920588788, 3844.961550384516, 3871.8644847430487, 3889.5138107736534, 3930.862419815321, 295875.0, 300966.0, 301723.0, 303703.0, 304133.9999999978, 53591.0, 55100.448995510334, 55112.89774204494, 59482.70258648679, 61034.389656102874, 49185.754071229414, 66678.66660666763, 67495.66252168806, 67513.66243168851, 67522.3247767516, 14234.07478513914, 14389.56831295042, 14441.49454769078, 14449.566513004627, 14453.060551064147, 11267.887321126684, 11332.546698131982, 11339.659810205707, 11344.31934083941, 11347.773044539063, 19794.307199247956, 20019.39941801748, 20094.296699615737, 20147.093380797898, 20838.895805520875, 8070.596470176468, 8252.504849708917, 8279.793005174919, 8301.792455188668, 8337.95831020841, 922.5894476957824, 940.0740270833223, 1061.6390427254616, 1067.8947289555429, 1076.1390887290136, 28804.0, 28892.617784835977, 28985.855070724512, 29207.0, 29395.118146455214, 1054.8048611006834, 1101.146611376174, 1107.9279846809932, 1130.2483848240993, 1184.8459700239086, 14492.275386230645, 14869.702605947821, 14990.175540345168, 15032.549023529311, 15105.848941510445, 320746.0, 323273.0, 324685.0, 325015.0, 325425.0, 52189.47810521922, 52713.0, 52742.0, 52764.472355276725, 52801.47198528043, 1262.1291308996763, 1292.9676758080934, 1313.8160657507956, 1314.0998416085013, 1315.5066849931275, 27387.31531711723, 28119.156425307272, 28707.425851482436, 28753.0, 28792.280192995342, 45697.0, 45742.313865292715, 45975.77012114918, 46025.0, 46059.30911036404, 305537.0, 306582.0, 307025.0, 307632.0, 307793.0, 26634.0, 27031.86484067646, 32132.518012230303, 32181.839090804395, 32384.83807580947, 37440.625593743716, 38283.042923927125, 38328.23343533058, 39073.0, 39467.605323946394, 32023.755367704005, 32615.673843261262, 33026.33947321088, 33603.15992100119, 33651.15872103217, 32571.0, 32971.0, 33271.83364083164, 33421.0, 33427.0, 34745.47881781826, 35309.29381412409, 35535.644643553234, 35535.64464355427, 35627.28745425129, 30255.848720756254, 30882.845585771927, 31070.22324441907, 31225.531617026216, 31380.215494612818, 24178.637320439855, 24718.629220561346, 24932.875335623932, 27644.308892277855, 28215.71784282131], "unit": "score", "name": "ext.html", "value": 18151.120275063997}, {"lowerIsBetter": false, "replicates": [355.8914531068025, 358.49810265628116, 367.10792773560246, 368.6276860371024, 373.8840959302618, 16743.0, 17059.488215353544, 17211.225494852744, 17337.82662173378, 17441.82558174418, 15014.549563513085, 15528.844711552882, 15532.0, 15550.611234719137, 15884.205789710497, 4989.525995030466, 4993.600511959044, 5140.742962851861, 5762.135679648065, 5769.509591684712, 5666.093425051992, 5672.205891175238, 5689.203511508392, 5694.316681998145, 5704.11586204137, 5361.571074314045, 5606.971965140189, 5613.80351687691, 5652.604317697763, 5676.858078548028, 5578.330600327967, 5587.245721827542, 5617.662940223599, 5621.269234999444, 5623.634463759883, 5082.923756143661, 5291.894162116736, 5292.417834038252, 5370.060239458079, 5383.057964856134, 13056.477740890354, 13083.345832708326, 13142.540011099662, 13143.86856131436, 13275.269860157687, 1897.6299621573799, 2009.357005758158, 2036.2465887621527, 2095.4970807006207, 2129.95740085199, 9501.192398646124, 9711.465869377182, 10523.78952420955, 12120.696982575419, 13148.408321625455, 1777.5467255849676, 1847.4919397165886, 1853.8615478051365, 1862.283021036897, 1895.0, 61001.69499152476, 62802.37197628056, 66302.33697663058, 66522.66738666325, 67398.66300668466, 10277.075063244343, 10303.505991631322, 10438.530266138043, 10478.947605262078, 10651.680449586525, 14099.647508812363, 14158.50445234412, 14179.858201417854, 14196.0, 14203.644908877153, 7348.154962179311, 7386.113666359964, 7444.925550744531, 7554.357879580188, 7583.544987300779, 6686.192510231243, 6768.0, 7079.00893874858, 7244.239354867663, 7303.926960730325, 4505.48186958504, 4578.88552786183, 4605.907881842344, 4643.628509719214, 4656.650751193606, 1855.7587513623412, 1880.2948894164688, 1884.8115188481042, 1897.0704354866293, 1916.0994332663627, 931.2456909903, 942.9528523573794, 1049.4647729657777, 1054.6625079974335, 1073.7047311989265, 16481.423150189687, 16867.66264674724, 17121.0, 17189.14054297305, 17546.649067018843, 852.5268475995882, 926.8470702334039, 953.3750869867836, 957.9952100239593, 960.3661583354952, 9579.616815327308, 9888.901110988798, 9890.159336456481, 9961.302708810459, 10029.247806414549, 397489.0, 402385.0, 403873.0, 403986.0, 404855.0, 66446.33553664401, 67881.0, 68222.31777682259, 68227.0, 70161.0, 1028.377831411985, 1035.7358873487212, 1051.894810518942, 1059.7721489879714, 1060.0618452669444, 15538.922305388853, 15800.446984355493, 15810.68378632398, 15956.122413267381, 15984.0, 34468.65531344755, 34762.65237347594, 34872.65127348694, 34991.0, 35240.47139292964, 46092.53907461017, 49431.75284123556, 50164.0, 50436.747816260686, 50528.24207636815, 8098.75703728889, 8101.675932962851, 8115.513069215866, 8121.431499794958, 8209.83580328402, 9753.707388778348, 11984.700382490508, 11996.58011969577, 12581.182223155465, 13156.276404797445, 10585.682429527127, 10700.625478108228, 10715.410652414192, 10780.0, 10784.460776961278, 10407.895921040692, 10604.469776511298, 10876.510557024794, 10909.945450272699, 11458.140639452242, 10471.109955653856, 10780.730481738019, 10847.566097356017, 11245.212835101463, 11249.325040497597, 7808.453408261367, 7809.609519524115, 7905.723299684483, 8172.632231549714, 8308.252257296872, 11257.324560526395, 11292.887071129184, 11322.150838687296, 11344.546218151512, 11350.375729334966], "unit": "score", "name": "jquery.html", "value": 8360.65999309964}, {"lowerIsBetter": false, "replicates": [1374.3609221711902, 1487.0, 1503.9849601503986, 1701.2854601067559, 1853.3976457651268, 7013.403860671842, 7720.498167619108, 7848.254415830487, 7917.208279172094, 7917.36661067114, 7482.850342993137, 7652.158262591124, 7662.770116896502, 7676.808079798008, 7678.961605191967, 2021.29254760834, 2074.543600407915, 2329.7204335479764, 2331.8600883946933, 2360.5514952159033, 2353.329301149173, 2363.917262895799, 2367.869767162805, 2368.1829768729763, 2368.2539999899977, 2316.2124877541632, 2333.708286464192, 2368.7275963264187, 2372.2645979746335, 2377.38188071101, 2325.546518428907, 2344.2615576093476, 2356.3402247370764, 2364.9408764780846, 2373.2405630198346, 2330.347502699247, 2340.742518322983, 2360.917367892133, 2363.4445905212433, 2378.5837478441204, 8063.838723225503, 8080.232377924088, 8136.552489613069, 8157.510549367057, 8177.345812334999, 4864.78108485119, 4931.901361972777, 4956.430010548797, 4965.702057876539, 4989.301497790312, 3073.3545955349405, 3087.058447173611, 3093.752499800033, 3135.4826453635123, 3200.8719651213923, 996.6362277768562, 1006.5319626373771, 1034.229499023225, 1037.64719995202, 1052.6841947415744, 11081.335119892752, 11089.05743011845, 11091.389973551451, 11111.222214444992, 11125.944370278097, 4435.467743870691, 4532.478764942074, 4584.3352713856975, 4588.242939914943, 4603.700759450625, 9390.436573805593, 9401.341906066646, 9416.482093484925, 9422.575984080733, 9441.386309889835, 4936.777844996984, 4978.377702787152, 4979.153543897546, 4979.800807967713, 4983.501649834988, 3805.505284313077, 4281.593248641374, 4359.891002724958, 4390.912181756347, 4470.061287129674, 3706.4440333950124, 3759.793211373346, 3780.0549862534367, 3791.184895247535, 3796.9430458543143, 1243.9564615238423, 1260.5525038611345, 1266.069438962362, 1273.2296960339047, 1275.4069357748692, 1013.8124446977333, 1020.2144348851343, 1210.2798834693344, 1357.694518733297, 1372.5607805502343, 7567.091948966049, 7678.846423071507, 7712.5758083305955, 7735.883961740466, 7746.690132394754, 1124.7525544380387, 1174.8061569840881, 1195.8146487294484, 1195.9880401195876, 1199.5141967503175, 5831.504322132666, 5955.37468565803, 5989.790357337472, 6002.039673652282, 6006.789762358297, 9239.861402078974, 9699.224062075016, 9896.55465504054, 9901.108900199017, 9911.0, 9478.099580539838, 9713.805723885484, 9735.41587504752, 9760.170385517311, 9784.217262618973, 7269.709211631475, 7538.3215510604305, 7693.076830780342, 7704.999999999888, 7706.38348932084, 7369.078865141857, 7372.889406659012, 7415.777526674208, 7462.253774622494, 7463.17905030457, 8521.190486903733, 8609.268212202032, 8696.130386961253, 8833.558322083742, 8866.024737278765, 8465.95767021161, 8933.419327743675, 9057.501837399006, 9115.498647574183, 9149.542522873962, 6170.259568851767, 6795.150606174228, 6827.658617069226, 6893.827654308682, 7013.614251216028, 7631.427642926692, 7655.961720191363, 7674.577898215652, 7694.192109828387, 7702.653380597774, 6825.931740682529, 6835.4189893859575, 6867.381935625817, 6890.621015844176, 7068.787936361918, 6676.0987266718375, 6694.263631000488, 6767.39093481589, 6798.898016529855, 6941.826454338682, 6831.658417079027, 6873.415759660485, 6912.0, 6915.93084069173, 7012.403945664676, 6520.706568204537, 6568.573042752206, 6601.900971485527, 6604.405603495708, 6670.899936500859, 6682.732690692513, 6728.529002969745, 6771.62756048422, 6773.93226067733, 6778.559393639398], "unit": "score", "name": "mootools.html", "value": 4609.164849262457}, {"lowerIsBetter": false, "replicates": [345.29215109026495, 348.256472431359, 349.20381530111354, 349.755171380034, 354.4665278755474, 5709.086546152611, 5732.942670573293, 5765.711714414273, 5778.653280803154, 5798.565107616924, 5731.770729170828, 5736.942630573693, 5738.0532212184935, 5744.33940096889, 5752.827415177551, 4301.376300436435, 4406.339049142638, 4499.122671079141, 4519.683622146451, 4528.9094218115615, 4471.552844715535, 4502.279635258359, 4510.503844577094, 4518.683692141552, 4526.388937493429, 4270.402143699885, 4467.441569803775, 4479.686421950465, 4481.619062379702, 4487.214737420954, 4348.412964249817, 4421.801018954155, 4421.955780442218, 4422.380866678667, 4439.023414848728, 3954.7231693781446, 3960.425738267964, 3970.5830887756947, 3973.36426171814, 3978.8209530571194, 5510.0, 5527.364353099405, 5541.0580201365865, 5543.057680194376, 5544.112941929272, 5208.114620514521, 5210.973945130288, 5211.062008838408, 5213.139831927728, 5217.50433708797, 6084.26988761347, 6088.878222435571, 6090.756369745205, 6090.939090609081, 6091.634501929899, 4133.7106402551835, 4277.97861010696, 4291.935620965688, 4298.78506074695, 4419.955800441987, 6276.623402595859, 6341.207349081365, 6359.9364006360265, 6361.173047503795, 6362.363763623647, 4354.455693038371, 4355.564443555619, 4361.869143925687, 4368.978155109204, 4373.606375426163, 4429.55704429561, 4431.180231657154, 4432.047109871393, 4438.467383913951, 4438.733675979452, 5111.667741596784, 5117.130087885069, 5123.3339665843205, 5128.461511541309, 5131.076406246912, 5976.820695379146, 6129.2032035835055, 6133.601315914451, 6138.785142519991, 6141.662208578571, 1513.402206128595, 1527.0990115831712, 1534.2098819108169, 1538.1002113763573, 1539.0534821085175, 989.5893204320271, 1017.1557607186018, 1037.8858325584179, 1060.48566445274, 1068.423051552153, 5777.45114214149, 5779.624324418899, 5780.1907732917425, 5780.219670344533, 5783.94216057834, 6109.8472538186015, 6146.293176284695, 6173.290071641819, 6184.783532576338, 6186.628802271878, 5717.656940583578, 5750.7987220447085, 5752.050911599539, 5759.0, 5769.134629805562, 3310.9503357449657, 3365.781224220467, 3387.5765529308837, 3392.2876195999115, 3392.9491057634154, 6354.555181137369, 6548.410643042149, 6601.636909969901, 6718.865622687519, 6740.854054810694, 6451.612903225821, 6471.935280647133, 6473.41739243461, 6479.125318082093, 6480.189976252968, 6710.597364158069, 6711.597304161766, 6725.125733654593, 6733.427658648971, 6733.562318449285, 6323.36766323364, 6346.079818426395, 6356.682165891594, 6357.364263573606, 6362.554621176473, 6138.355472675305, 6224.9377506224355, 6278.529110316836, 6282.623042617458, 6286.65423401699, 6718.093057437183, 6736.528443008942, 6738.2587915328295, 6741.0, 6755.189377274758, 4310.956890431055, 4358.4769827620885, 4363.4109395231235, 4365.781710914378, 4366.585174408426, 6356.618602883842, 6359.332270111757, 6361.045843123568, 6364.6181229126405, 6365.554411191172, 6162.599431036968, 6179.0422484514975, 6180.227471566054, 6181.690915454299, 6183.907241391473, 6003.549733769897, 6152.538559607958, 6174.598651087845, 6189.84525386869, 6198.0702894566175, 6046.7581296749395, 6076.422739839708, 6077.513798896166, 6078.027515597483, 6092.9086063709965, 6150.50795936333, 6157.445829875153, 6183.041628547582, 6185.072239164161, 6190.3190649029475, 5839.182514447895, 5880.705964701833, 6039.063945088518, 6058.636481811105, 6062.696865156813], "unit": "score", "name": "prototype.html", "value": 4644.852717139973}, {"lowerIsBetter": false, "replicates": [620.7392894984106, 631.4821846086211, 648.6659370424229, 659.0970370592289, 762.6065296946106, 13177.934110329446, 13250.734985300312, 13264.270465124415, 13295.46818127275, 13695.863041369596, 13128.934355328234, 13220.074594778369, 13276.137051091673, 13279.668008299797, 13293.867061329383, 674.8751480976023, 823.5017814222399, 852.3735054734796, 852.8081181734123, 853.7566793463864, 848.8047749017729, 853.8676505141682, 854.5855260198798, 856.5289090999956, 857.4769390671685, 896.6547879066541, 902.0753727429371, 902.8329758994574, 902.9458232506071, 903.0, 706.3219309462921, 869.9217070463689, 896.2068569316137, 898.9775255618629, 899.0515006667963, 649.447969226154, 653.5457856789533, 653.9247986481521, 654.0091760982068, 654.9803505894831, 13656.0, 13729.588112356645, 13738.175709457364, 13765.105268157538, 13822.516211932634, 11544.307341559534, 12048.638540843789, 12086.456109475095, 12200.328981905992, 12339.0, 10611.522481488351, 10828.133749300037, 10923.836142457869, 10926.50830712612, 11094.1124710023, 3431.6396778338412, 3513.437849944022, 3560.8041557714314, 3576.8748093816594, 3628.256207477461, 48415.75792121052, 48430.27354589684, 48665.75667121677, 48753.04987800484, 48959.0, 10451.425171615481, 10468.319559228627, 10495.107915827088, 10686.572537098584, 11084.722881927855, 19417.708734368996, 19470.123844427035, 19542.413727588195, 19554.902225488782, 19564.902175489315, 7423.62881855905, 7634.770956871303, 7777.922220777833, 7809.101953275333, 7961.1242763295995, 4435.112977404532, 4448.888777780517, 4490.057088011489, 4535.523770004168, 4593.104344652827, 3061.969380306168, 3111.4554952883154, 3122.8126312421327, 3124.2814152744995, 3128.9217769555944, 585.8418227078665, 594.7561499785068, 611.6910959965189, 615.3630991923338, 617.9876402471925, 665.9933400666029, 686.4885660183096, 695.4109858972224, 710.705057401183, 713.2974020589714, 7834.262534220566, 8083.919160808434, 8188.628956181981, 8648.005479369953, 8986.460812351279, 640.7629177204465, 646.2955378637308, 675.7330854312519, 697.5187120886573, 698.9161300643854, 3886.591907849635, 4058.8782336529953, 4064.5122585289955, 4265.104328091135, 4395.099004704028, 56192.719036405375, 56585.0, 56854.0, 57371.713141434026, 57482.42517574855, 49199.50800492021, 49513.50486495089, 50068.0, 50374.244386334234, 50392.24411633828, 43207.35188972168, 44069.77965110218, 45824.312635310496, 47109.0, 47448.5255147451, 8140.959295203486, 8390.412671112963, 8757.343199259954, 8926.955365223132, 8994.42345745642, 34331.0, 34608.30783384368, 35171.0, 35876.82061589675, 36349.81825090964, 41450.58549414588, 42528.787356063025, 43847.123057539306, 44329.55670443254, 44641.33038004497, 10973.725656858323, 10979.945100274448, 11100.666979990614, 11379.886201137882, 12083.758324833278, 10996.340219586851, 11145.164112691418, 12342.691432714253, 12650.557230496888, 12654.493820247088, 8446.957765211135, 9852.950735246279, 11970.940145299217, 12037.699057523632, 12252.571160009356, 11656.697318691824, 11842.28946263227, 11879.346635935106, 12126.514939402325, 12313.938430307791, 10618.415987120783, 10759.176462998781, 10967.287126336763, 11199.21605487608, 11373.678964099707, 9486.601602446439, 9648.95175524146, 10120.0, 10209.693709188736, 10387.37675739458, 9451.243900487807, 10145.84781228297, 10319.019693129141, 10341.121004714683, 10488.947555262175], "unit": "score", "name": "yui.html", "value": 6379.446868772565}], "name": "dromaeo_css", "value": 6891.8675567205055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 110.0, 111.0, 100.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 151.0, 170.0, 128.0, 151.0, 162.0, 127.0, 176.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 164.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 94.0, 101.0, 72.0, 75.0, 75.0, 112.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 94.0, 94.0, 93.0, 144.0, 93.0, 92.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 57.0, 56.0, 57.0, 56.0, 67.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 81.0, 82.0, 82.0, 84.0, 82.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [124.0, 125.0, 114.0, 124.0, 115.0, 122.0, 116.0, 117.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 151.0, 151.0, 140.0, 139.0, 153.0, 148.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1509.6000000000001}]} 19:56:44 INFO - Return code: 0 19:56:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:56:44 ERROR - # TBPL SUCCESS # 19:56:44 INFO - Running post-action listener: _resource_record_post_action 19:56:44 INFO - Running post-run listener: _resource_record_post_run 19:56:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535752704; Read time: 20; Write time: 496844 19:56:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240685056; Read time: 0; Write time: 260068 19:56:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294895616; Read time: 20; Write time: 236752 19:56:45 INFO - Running post-run listener: _upload_blobber_files 19:56:45 INFO - Blob upload gear active. 19:56:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:56:45 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:56:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:56:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:56:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:46 INFO - (blobuploader) - INFO - Done attempting. 19:56:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:56:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:47 INFO - (blobuploader) - INFO - Done attempting. 19:56:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:47 INFO - Return code: 0 19:56:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:56:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1adc0cfaf8002715f7532cef5e2f8644b1d7f033a70e04c55c6bf658ac1332d0d2b11968a60fddeb71c8c1e1d94b94b710d227a03eb6bdca69d0d6c5f864ca9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c639a2dc7022ce65bf0ab1087d73c8bfd7b3cc09ae5e62630e96aa1890fc5097e23ce4582f787d01da1eedc9475f0458afea85084c7a6e7d74e474d181e62ce"} 19:56:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:56:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:56:47 INFO - Contents: 19:56:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1adc0cfaf8002715f7532cef5e2f8644b1d7f033a70e04c55c6bf658ac1332d0d2b11968a60fddeb71c8c1e1d94b94b710d227a03eb6bdca69d0d6c5f864ca9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c639a2dc7022ce65bf0ab1087d73c8bfd7b3cc09ae5e62630e96aa1890fc5097e23ce4582f787d01da1eedc9475f0458afea85084c7a6e7d74e474d181e62ce"} 19:56:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:47 INFO - Copying logs to upload dir... 19:56:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:56:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.680209 ========= master_lag: 6.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-17 19:56:53.285890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 19:56:53.289448) ========= 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1adc0cfaf8002715f7532cef5e2f8644b1d7f033a70e04c55c6bf658ac1332d0d2b11968a60fddeb71c8c1e1d94b94b710d227a03eb6bdca69d0d6c5f864ca9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c639a2dc7022ce65bf0ab1087d73c8bfd7b3cc09ae5e62630e96aa1890fc5097e23ce4582f787d01da1eedc9475f0458afea85084c7a6e7d74e474d181e62ce"} build_url:https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/GjNa2CJFSSutkGrmmxshNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1adc0cfaf8002715f7532cef5e2f8644b1d7f033a70e04c55c6bf658ac1332d0d2b11968a60fddeb71c8c1e1d94b94b710d227a03eb6bdca69d0d6c5f864ca9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c639a2dc7022ce65bf0ab1087d73c8bfd7b3cc09ae5e62630e96aa1890fc5097e23ce4582f787d01da1eedc9475f0458afea85084c7a6e7d74e474d181e62ce"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 19:56:53.418981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-03-17 19:56:53.419321) ========= 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=db0483c52d987ecb441a263b000001ad-1458267641.533703-1631834944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 2.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-03-17 19:56:55.676641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 19:56:55.680027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 19:56:55.820953) ========= ========= Total master_lag: 8.58 =========