builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1455022749.42 results: success (0) buildid: 20160209023007 builduid: f0bd44fdcf0b4fb8b74a8ddfdbac322d revision: e0be6880f8e00767529ba5562ae862b7f29d66c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.423118) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.423813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.424116) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006396 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.454736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.455033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.481997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.482374) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.532173) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.532490) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.532851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.533142) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 04:59:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2016-02-09 04:59:10 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.736620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.736964) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:09.786181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 04:59:09.786541) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0be6880f8e00767529ba5562ae862b7f29d66c2 --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/fx-team --rev e0be6880f8e00767529ba5562ae862b7f29d66c2 --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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 04:59:10,320 truncating revision to first 12 chars 2016-02-09 04:59:10,320 Setting DEBUG logging. 2016-02-09 04:59:10,320 attempt 1/10 2016-02-09 04:59:10,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0be6880f8e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 04:59:11,087 unpacking tar archive at: fx-team-e0be6880f8e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.057218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 04:59:10.856505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:10.856843) ========= echo e0be6880f8e00767529ba5562ae862b7f29d66c2 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e0be6880f8e00767529ba5562ae862b7f29d66c2'] 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e0be6880f8e00767529ba5562ae862b7f29d66c2 program finished with exit code 0 elapsedTime=0.003439 script_repo_revision: 'e0be6880f8e00767529ba5562ae862b7f29d66c2' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:10.905151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:10.905473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:10.915267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-09 04:59:10.915603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:11 INFO - MultiFileLogger online at 20160209 04:59:11 in /builds/slave/test-pgo 04:59:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:59:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:59:11 INFO - {'append_to_log': False, 04:59:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:59:11 INFO - 'blob_upload_branch': 'Fx-Team', 04:59:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:59:11 INFO - 'branch': 'Fx-Team', 04:59:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:11 INFO - 'config_files': ('talos/linux_config.py',), 04:59:11 INFO - 'default_actions': ('clobber', 04:59:11 INFO - 'read-buildbot-config', 04:59:11 INFO - 'download-and-extract', 04:59:11 INFO - 'populate-webroot', 04:59:11 INFO - 'create-virtualenv', 04:59:11 INFO - 'install', 04:59:11 INFO - 'run-tests'), 04:59:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:11 INFO - 'download_minidump_stackwalk': True, 04:59:11 INFO - 'download_symbols': 'ondemand', 04:59:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:11 INFO - 'installer_path': 'installer.exe', 04:59:11 INFO - 'log_level': 'info', 04:59:11 INFO - 'log_name': 'talos', 04:59:11 INFO - 'log_to_console': True, 04:59:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:11 INFO - 'opt_config_files': (), 04:59:11 INFO - 'pip_index': False, 04:59:11 INFO - 'sps_profile': False, 04:59:11 INFO - 'sps_profile_interval': 0, 04:59:11 INFO - 'suite': 'dromaeojs', 04:59:11 INFO - 'system_bits': '32', 04:59:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:11 INFO - 'title': 'talos-linux64-ix-060', 04:59:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:11 INFO - 'use_talos_json': True, 04:59:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:59:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:11 INFO - 'work_dir': 'build'} 04:59:11 INFO - ##### 04:59:11 INFO - ##### Running clobber step. 04:59:11 INFO - ##### 04:59:11 INFO - Running pre-action listener: _resource_record_pre_action 04:59:11 INFO - Running main action method: clobber 04:59:11 INFO - rmtree: /builds/slave/test-pgo/build 04:59:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:59:12 INFO - Running post-action listener: _resource_record_post_action 04:59:12 INFO - ##### 04:59:12 INFO - ##### Running read-buildbot-config step. 04:59:12 INFO - ##### 04:59:12 INFO - Running pre-action listener: _resource_record_pre_action 04:59:12 INFO - Running main action method: read_buildbot_config 04:59:12 INFO - Using buildbot properties: 04:59:12 INFO - { 04:59:12 INFO - "project": "", 04:59:12 INFO - "product": "firefox", 04:59:12 INFO - "script_repo_revision": "production", 04:59:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:59:12 INFO - "repository": "", 04:59:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:59:12 INFO - "buildid": "20160209023007", 04:59:12 INFO - "pgo_build": "True", 04:59:12 INFO - "basedir": "/builds/slave/test-pgo", 04:59:12 INFO - "buildnumber": 928, 04:59:12 INFO - "slavename": "talos-linux64-ix-060", 04:59:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:59:12 INFO - "platform": "ubuntu64_hw", 04:59:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:59:12 INFO - "branch": "fx-team", 04:59:12 INFO - "repo_path": "integration/fx-team", 04:59:12 INFO - "revision": "e0be6880f8e00767529ba5562ae862b7f29d66c2", 04:59:12 INFO - "stage_platform": "linux64-pgo", 04:59:12 INFO - "builduid": "f0bd44fdcf0b4fb8b74a8ddfdbac322d", 04:59:12 INFO - "slavebuilddir": "test" 04:59:12 INFO - } 04:59:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:59:12 INFO - Running post-action listener: _resource_record_post_action 04:59:12 INFO - ##### 04:59:12 INFO - ##### Running download-and-extract step. 04:59:12 INFO - ##### 04:59:12 INFO - Running pre-action listener: _resource_record_pre_action 04:59:12 INFO - Running main action method: download_and_extract 04:59:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:12 INFO - https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:59:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/test_packages.json 04:59:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/test_packages.json 04:59:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:59:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:59:20 INFO - Downloaded 1448 bytes. 04:59:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:59:20 INFO - Using the following test package requirements: 04:59:20 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:59:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:59:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'jsshell-linux-x86_64.zip'], 04:59:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:59:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:59:20 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:59:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:59:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:59:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:20 INFO - https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:59:24 INFO - Downloaded 23575404 bytes. 04:59:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:59:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:59:25 INFO - Return code: 0 04:59:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:59: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')]} 04:59:25 INFO - https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:59:28 INFO - Downloaded 23575404 bytes. 04:59:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:59:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:59:30 INFO - Return code: 0 04:59:30 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')]} 04:59:30 INFO - https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:59:31 INFO - Downloaded 10706547 bytes. 04:59:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:59:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:59:31 INFO - Return code: 0 04:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:31 INFO - https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:59:33 INFO - Downloaded 56585702 bytes. 04:59:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:59:33 INFO - mkdir: /builds/slave/test-pgo/properties 04:59:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:59:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:59:33 INFO - Contents: 04:59:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:59:34 INFO - Running post-action listener: _resource_record_post_action 04:59:34 INFO - Running post-action listener: set_extra_try_arguments 04:59:34 INFO - ##### 04:59:34 INFO - ##### Running populate-webroot step. 04:59:34 INFO - ##### 04:59:34 INFO - Running pre-action listener: _resource_record_pre_action 04:59:34 INFO - Running main action method: populate_webroot 04:59:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:34 INFO - '--tppagecycles', 04:59:34 INFO - '7'], 04:59:34 INFO - 'tests': ['tsvgm']}}, 04:59:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:59:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:59:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:59:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'tests': ['damp', 'tps']}, 04:59:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['damp', 'tps']}, 04:59:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:59:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:34 INFO - 'other': {'tests': ['a11yr', 04:59:34 INFO - 'ts_paint', 04:59:34 INFO - 'tpaint', 04:59:34 INFO - 'sessionrestore', 04:59:34 INFO - 'sessionrestore_no_auto_restore']}, 04:59:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['a11yr', 04:59:34 INFO - 'ts_paint', 04:59:34 INFO - 'tpaint', 04:59:34 INFO - 'sessionrestore', 04:59:34 INFO - 'sessionrestore_no_auto_restore']}, 04:59:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['a11yr', 04:59:34 INFO - 'ts_paint', 04:59:34 INFO - 'tpaint', 04:59:34 INFO - 'sessionrestore', 04:59:34 INFO - 'sessionrestore_no_auto_restore']}, 04:59:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['a11yr', 04:59:34 INFO - 'ts_paint', 04:59:34 INFO - 'tpaint', 04:59:34 INFO - 'sessionrestore', 04:59:34 INFO - 'sessionrestore_no_auto_restore']}, 04:59:34 INFO - 'other_l64': {'tests': ['a11yr', 04:59:34 INFO - 'ts_paint', 04:59:34 INFO - 'tpaint', 04:59:34 INFO - 'sessionrestore', 04:59:34 INFO - 'sessionrestore_no_auto_restore']}, 04:59:34 INFO - 'other_nol64': {'tests': ['a11yr', 04:59:34 INFO - 'ts_paint', 04:59:34 INFO - 'tpaint', 04:59:34 INFO - 'sessionrestore', 04:59:34 INFO - 'sessionrestore_no_auto_restore']}, 04:59:34 INFO - 'svgr': {'tests': ['tsvgx', 04:59:34 INFO - 'tsvgr_opacity', 04:59:34 INFO - 'tart', 04:59:34 INFO - 'tscrollx', 04:59:34 INFO - 'cart']}, 04:59:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['tsvgx', 04:59:34 INFO - 'tsvgr_opacity', 04:59:34 INFO - 'tart', 04:59:34 INFO - 'tscrollx', 04:59:34 INFO - 'cart']}, 04:59:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'tests': ['tp5o']}, 04:59:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'talos_options': ['--e10s'], 04:59:34 INFO - 'tests': ['tp5o']}, 04:59:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'talos_options': ['--xperf_path', 04:59:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:34 INFO - 'tests': ['tp5n']}, 04:59:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:34 INFO - 'talos_options': ['--e10s', 04:59:34 INFO - '--xperf_path', 04:59:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:34 INFO - 'tests': ['tp5n']}}, 04:59:34 INFO - 'talos.zip': {'path': '', 04:59:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:34 INFO - Running post-action listener: _resource_record_post_action 04:59:34 INFO - ##### 04:59:34 INFO - ##### Running create-virtualenv step. 04:59:34 INFO - ##### 04:59:34 INFO - Running pre-action listener: _resource_record_pre_action 04:59:34 INFO - Running main action method: create_virtualenv 04:59:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:59:34 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 04:59:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:59:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:34 INFO - Using real prefix '/usr' 04:59:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:59:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:36 INFO - Installing pip.................done. 04:59:36 INFO - Return code: 0 04:59:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:36 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:36 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 04:59:36 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 04:59:36 INFO - Using env: {'DISPLAY': ':0', 04:59:36 INFO - 'HOME': '/home/cltbld', 04:59:36 INFO - 'LANG': 'en_US.UTF-8', 04:59:36 INFO - 'LANGUAGE': 'en_US:en', 04:59:36 INFO - 'LOGNAME': 'cltbld', 04:59:36 INFO - 'MAIL': '/var/mail/cltbld', 04:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:36 INFO - 'MOZ_NO_REMOTE': '1', 04:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:36 INFO - 'NO_EM_RESTART': '1', 04:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:36 INFO - 'SHELL': '/bin/bash', 04:59:36 INFO - 'SHLVL': '1', 04:59:36 INFO - 'TERM': 'linux', 04:59:36 INFO - 'TMOUT': '86400', 04:59:36 INFO - 'USER': 'cltbld', 04:59:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:36 INFO - '_': '/tools/buildbot/bin/python'} 04:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:37 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 04:59:37 INFO - Cleaning up... 04:59:37 INFO - Return code: 0 04:59:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:59: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')]} 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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', '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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:59: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 psutil>=0.7.1 04:59:37 INFO - Using env: {'DISPLAY': ':0', 04:59:37 INFO - 'HOME': '/home/cltbld', 04:59:37 INFO - 'LANG': 'en_US.UTF-8', 04:59:37 INFO - 'LANGUAGE': 'en_US:en', 04:59:37 INFO - 'LOGNAME': 'cltbld', 04:59:37 INFO - 'MAIL': '/var/mail/cltbld', 04:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:37 INFO - 'MOZ_NO_REMOTE': '1', 04:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:37 INFO - 'NO_EM_RESTART': '1', 04:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:37 INFO - 'SHELL': '/bin/bash', 04:59:37 INFO - 'SHLVL': '1', 04:59:37 INFO - 'TERM': 'linux', 04:59:37 INFO - 'TMOUT': '86400', 04:59:37 INFO - 'USER': 'cltbld', 04:59:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:37 INFO - '_': '/tools/buildbot/bin/python'} 04:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:37 INFO - Downloading/unpacking psutil>=0.7.1 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:39 INFO - Installing collected packages: psutil 04:59:39 INFO - Running setup.py install for psutil 04:59:39 INFO - building 'psutil._psutil_linux' extension 04:59:39 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 04:59:39 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 04:59:39 INFO - building 'psutil._psutil_posix' extension 04:59:39 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 04:59:39 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 04:59:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:39 INFO - Successfully installed psutil 04:59:39 INFO - Cleaning up... 04:59:39 INFO - Return code: 0 04:59:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:39 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:39 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 04:59:39 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 04:59:39 INFO - Using env: {'DISPLAY': ':0', 04:59:39 INFO - 'HOME': '/home/cltbld', 04:59:39 INFO - 'LANG': 'en_US.UTF-8', 04:59:39 INFO - 'LANGUAGE': 'en_US:en', 04:59:39 INFO - 'LOGNAME': 'cltbld', 04:59:39 INFO - 'MAIL': '/var/mail/cltbld', 04:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:39 INFO - 'MOZ_NO_REMOTE': '1', 04:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:39 INFO - 'NO_EM_RESTART': '1', 04:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:39 INFO - 'SHELL': '/bin/bash', 04:59:39 INFO - 'SHLVL': '1', 04:59:39 INFO - 'TERM': 'linux', 04:59:39 INFO - 'TMOUT': '86400', 04:59:39 INFO - 'USER': 'cltbld', 04:59:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:39 INFO - '_': '/tools/buildbot/bin/python'} 04:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:59:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:59:41 INFO - Installing collected packages: mozsystemmonitor 04:59:41 INFO - Running setup.py install for mozsystemmonitor 04:59:41 INFO - Successfully installed mozsystemmonitor 04:59:41 INFO - Cleaning up... 04:59:42 INFO - Return code: 0 04:59:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:59:42 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')]} 04:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:42 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')]} 04:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:42 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:42 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 04:59:42 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 04:59:42 INFO - Using env: {'DISPLAY': ':0', 04:59:42 INFO - 'HOME': '/home/cltbld', 04:59:42 INFO - 'LANG': 'en_US.UTF-8', 04:59:42 INFO - 'LANGUAGE': 'en_US:en', 04:59:42 INFO - 'LOGNAME': 'cltbld', 04:59:42 INFO - 'MAIL': '/var/mail/cltbld', 04:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:42 INFO - 'MOZ_NO_REMOTE': '1', 04:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:42 INFO - 'NO_EM_RESTART': '1', 04:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:42 INFO - 'SHELL': '/bin/bash', 04:59:42 INFO - 'SHLVL': '1', 04:59:42 INFO - 'TERM': 'linux', 04:59:42 INFO - 'TMOUT': '86400', 04:59:42 INFO - 'USER': 'cltbld', 04:59:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:42 INFO - '_': '/tools/buildbot/bin/python'} 04:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 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 04:59:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:59:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:44 INFO - Downloading docopt-0.6.1.tar.gz 04:59:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:44 INFO - Running setup.py install for blobuploader 04:59:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:59:44 INFO - Running setup.py install for requests 04:59:45 INFO - Running setup.py install for docopt 04:59:45 INFO - Successfully installed blobuploader requests docopt 04:59:45 INFO - Cleaning up... 04:59:45 INFO - Return code: 0 04:59:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:45 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:45 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 04:59:45 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 04:59:45 INFO - Using env: {'DISPLAY': ':0', 04:59:45 INFO - 'HOME': '/home/cltbld', 04:59:45 INFO - 'LANG': 'en_US.UTF-8', 04:59:45 INFO - 'LANGUAGE': 'en_US:en', 04:59:45 INFO - 'LOGNAME': 'cltbld', 04:59:45 INFO - 'MAIL': '/var/mail/cltbld', 04:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:45 INFO - 'MOZ_NO_REMOTE': '1', 04:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:45 INFO - 'NO_EM_RESTART': '1', 04:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:45 INFO - 'SHELL': '/bin/bash', 04:59:45 INFO - 'SHLVL': '1', 04:59:45 INFO - 'TERM': 'linux', 04:59:45 INFO - 'TMOUT': '86400', 04:59:45 INFO - 'USER': 'cltbld', 04:59:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:45 INFO - '_': '/tools/buildbot/bin/python'} 04:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:45 INFO - Running setup.py (path:/tmp/pip-aSUcoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:45 INFO - Running setup.py (path:/tmp/pip-LPXjMI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:45 INFO - Running setup.py (path:/tmp/pip-VhHlWr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:45 INFO - Running setup.py (path:/tmp/pip-khcqeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:45 INFO - Running setup.py (path:/tmp/pip-R5NzCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:45 INFO - Running setup.py (path:/tmp/pip-3ks1dW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:46 INFO - Running setup.py (path:/tmp/pip-LH2PUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:46 INFO - Running setup.py (path:/tmp/pip-IEgenL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:46 INFO - Running setup.py (path:/tmp/pip-nsQ7th-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:46 INFO - Running setup.py (path:/tmp/pip-QJhKjB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:46 INFO - Running setup.py (path:/tmp/pip-zHlkZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:46 INFO - Running setup.py (path:/tmp/pip-wcBBLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:46 INFO - Running setup.py (path:/tmp/pip-3yeoax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:46 INFO - Running setup.py (path:/tmp/pip-_XGHWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:46 INFO - Running setup.py (path:/tmp/pip-ZwmdxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:46 INFO - Running setup.py (path:/tmp/pip-h82sge-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:46 INFO - Running setup.py (path:/tmp/pip-BMiIZh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:46 INFO - Running setup.py install for manifestparser 04:59:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:59:46 INFO - Running setup.py install for mozcrash 04:59:47 INFO - Running setup.py install for mozdebug 04:59:47 INFO - Running setup.py install for mozdevice 04:59:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Running setup.py install for mozfile 04:59:47 INFO - Running setup.py install for mozhttpd 04:59:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Running setup.py install for mozinfo 04:59:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Running setup.py install for mozInstall 04:59:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Running setup.py install for mozleak 04:59:47 INFO - Running setup.py install for mozlog 04:59:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Running setup.py install for moznetwork 04:59:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:59:47 INFO - Running setup.py install for mozprocess 04:59:48 INFO - Running setup.py install for mozprofile 04:59:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:59:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:59:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:59:48 INFO - Running setup.py install for mozrunner 04:59:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:59:48 INFO - Running setup.py install for mozscreenshot 04:59:48 INFO - Running setup.py install for moztest 04:59:48 INFO - Running setup.py install for mozversion 04:59:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:59:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:48 INFO - Cleaning up... 04:59:48 INFO - Return code: 0 04:59:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:48 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:48 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 04:59:48 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 04:59:48 INFO - Using env: {'DISPLAY': ':0', 04:59:48 INFO - 'HOME': '/home/cltbld', 04:59:48 INFO - 'LANG': 'en_US.UTF-8', 04:59:48 INFO - 'LANGUAGE': 'en_US:en', 04:59:48 INFO - 'LOGNAME': 'cltbld', 04:59:48 INFO - 'MAIL': '/var/mail/cltbld', 04:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:48 INFO - 'MOZ_NO_REMOTE': '1', 04:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:48 INFO - 'NO_EM_RESTART': '1', 04:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:48 INFO - 'SHELL': '/bin/bash', 04:59:48 INFO - 'SHLVL': '1', 04:59:48 INFO - 'TERM': 'linux', 04:59:48 INFO - 'TMOUT': '86400', 04:59:48 INFO - 'USER': 'cltbld', 04:59:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:48 INFO - '_': '/tools/buildbot/bin/python'} 04:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:48 INFO - Running setup.py (path:/tmp/pip-6tKglN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:48 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)) 04:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:48 INFO - Running setup.py (path:/tmp/pip-OJORkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:48 INFO - Running setup.py (path:/tmp/pip-lAfoNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:49 INFO - Running setup.py (path:/tmp/pip-67yKvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:49 INFO - Running setup.py (path:/tmp/pip-dsRuaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:49 INFO - Running setup.py (path:/tmp/pip-tXX41v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:49 INFO - Running setup.py (path:/tmp/pip-DQBtTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:49 INFO - Running setup.py (path:/tmp/pip-778SFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:49 INFO - Running setup.py (path:/tmp/pip-4YvpJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:49 INFO - Running setup.py (path:/tmp/pip-q8BoUP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:49 INFO - Running setup.py (path:/tmp/pip-ttZkPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:49 INFO - Running setup.py (path:/tmp/pip-GBchM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:49 INFO - Running setup.py (path:/tmp/pip-rP8cMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:49 INFO - Running setup.py (path:/tmp/pip-LAeCxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:49 INFO - Running setup.py (path:/tmp/pip-F6HpDk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:49 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)) 04:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:49 INFO - Running setup.py (path:/tmp/pip-s4tmRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:50 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)) 04:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:50 INFO - Running setup.py (path:/tmp/pip-kcdpqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:50 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)) 04:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:50 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)) 04:59:50 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)) 04:59:50 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)) 04:59:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:51 INFO - Downloading blessings-1.6.tar.gz 04:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:51 INFO - Installing collected packages: blessings 04:59:51 INFO - Running setup.py install for blessings 04:59:52 INFO - Successfully installed blessings 04:59:52 INFO - Cleaning up... 04:59:52 INFO - Return code: 0 04:59:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:59:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:59:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:59:52 INFO - Reading from file tmpfile_stdout 04:59:52 INFO - Current package versions: 04:59:52 INFO - argparse == 1.2.1 04:59:52 INFO - blessings == 1.6 04:59:52 INFO - blobuploader == 1.2.4 04:59:52 INFO - docopt == 0.6.1 04:59:52 INFO - manifestparser == 1.1 04:59:52 INFO - mozInstall == 1.12 04:59:52 INFO - mozcrash == 0.16 04:59:52 INFO - mozdebug == 0.1 04:59:52 INFO - mozdevice == 0.48 04:59:52 INFO - mozfile == 1.2 04:59:52 INFO - mozhttpd == 0.7 04:59:52 INFO - mozinfo == 0.9 04:59:52 INFO - mozleak == 0.1 04:59:52 INFO - mozlog == 3.1 04:59:52 INFO - moznetwork == 0.27 04:59:52 INFO - mozprocess == 0.22 04:59:52 INFO - mozprofile == 0.28 04:59:52 INFO - mozrunner == 6.11 04:59:52 INFO - mozscreenshot == 0.1 04:59:52 INFO - mozsystemmonitor == 0.0 04:59:52 INFO - moztest == 0.7 04:59:52 INFO - mozversion == 1.4 04:59:52 INFO - psutil == 3.1.1 04:59:52 INFO - requests == 1.2.3 04:59:52 INFO - wsgiref == 0.1.2 04:59:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:59:52 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')]} 04:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:52 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')]} 04:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:52 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:52 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 04:59:52 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 04:59:52 INFO - Using env: {'DISPLAY': ':0', 04:59:52 INFO - 'HOME': '/home/cltbld', 04:59:52 INFO - 'LANG': 'en_US.UTF-8', 04:59:52 INFO - 'LANGUAGE': 'en_US:en', 04:59:52 INFO - 'LOGNAME': 'cltbld', 04:59:52 INFO - 'MAIL': '/var/mail/cltbld', 04:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:52 INFO - 'MOZ_NO_REMOTE': '1', 04:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:52 INFO - 'NO_EM_RESTART': '1', 04:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:52 INFO - 'SHELL': '/bin/bash', 04:59:52 INFO - 'SHLVL': '1', 04:59:52 INFO - 'TERM': 'linux', 04:59:52 INFO - 'TMOUT': '86400', 04:59:52 INFO - 'USER': 'cltbld', 04:59:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:52 INFO - '_': '/tools/buildbot/bin/python'} 04:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 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)) 04:59:52 INFO - Cleaning up... 04:59:52 INFO - Return code: 0 04:59:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:59:52 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')]} 04:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:52 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')]} 04:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:52 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:52 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 04:59:52 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 04:59:52 INFO - Using env: {'DISPLAY': ':0', 04:59:52 INFO - 'HOME': '/home/cltbld', 04:59:52 INFO - 'LANG': 'en_US.UTF-8', 04:59:52 INFO - 'LANGUAGE': 'en_US:en', 04:59:52 INFO - 'LOGNAME': 'cltbld', 04:59:52 INFO - 'MAIL': '/var/mail/cltbld', 04:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:52 INFO - 'MOZ_NO_REMOTE': '1', 04:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:52 INFO - 'NO_EM_RESTART': '1', 04:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:52 INFO - 'SHELL': '/bin/bash', 04:59:52 INFO - 'SHLVL': '1', 04:59:52 INFO - 'TERM': 'linux', 04:59:52 INFO - 'TMOUT': '86400', 04:59:52 INFO - 'USER': 'cltbld', 04:59:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:52 INFO - '_': '/tools/buildbot/bin/python'} 04:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:52 INFO - Downloading/unpacking jsonschema 04:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:59:54 INFO - Downloading/unpacking functools32 (from jsonschema) 04:59:54 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 04:59:54 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 04:59:54 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 04:59:54 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 04:59:54 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 04:59:54 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 04:59:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:59:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:59:54 INFO - warning: no files found matching '*.txt' 04:59:54 INFO - no previously-included directories found matching 'build' 04:59:54 INFO - no previously-included directories found matching 'dist' 04:59:54 INFO - no previously-included directories found matching '.git*' 04:59:54 INFO - Installing collected packages: jsonschema, functools32 04:59:54 INFO - Running setup.py install for functools32 04:59:54 INFO - warning: no files found matching '*.txt' 04:59:54 INFO - no previously-included directories found matching 'build' 04:59:54 INFO - no previously-included directories found matching 'dist' 04:59:54 INFO - no previously-included directories found matching '.git*' 04:59:54 INFO - Successfully installed jsonschema functools32 04:59:54 INFO - Cleaning up... 04:59:55 INFO - Return code: 0 04:59:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:59:55 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')]} 04:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:55 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')]} 04:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:55 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 0x7fd724496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, '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': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', '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 04:59:55 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 04:59:55 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 04:59:55 INFO - Using env: {'DISPLAY': ':0', 04:59:55 INFO - 'HOME': '/home/cltbld', 04:59:55 INFO - 'LANG': 'en_US.UTF-8', 04:59:55 INFO - 'LANGUAGE': 'en_US:en', 04:59:55 INFO - 'LOGNAME': 'cltbld', 04:59:55 INFO - 'MAIL': '/var/mail/cltbld', 04:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:55 INFO - 'MOZ_NO_REMOTE': '1', 04:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:55 INFO - 'NO_EM_RESTART': '1', 04:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:55 INFO - 'SHELL': '/bin/bash', 04:59:55 INFO - 'SHLVL': '1', 04:59:55 INFO - 'TERM': 'linux', 04:59:55 INFO - 'TMOUT': '86400', 04:59:55 INFO - 'USER': 'cltbld', 04:59:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 04:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:55 INFO - '_': '/tools/buildbot/bin/python'} 04:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:55 INFO - Downloading/unpacking flake8 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:59:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:59:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:59:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:57 INFO - no previously-included directories found matching 'docs/_build' 04:59:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:59:57 INFO - Running setup.py install for pep8 04:59:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:57 INFO - no previously-included directories found matching 'docs/_build' 04:59:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:59:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:59:57 INFO - Cleaning up... 04:59:57 INFO - Return code: 0 04:59:57 INFO - Running post-action listener: _resource_record_post_action 04:59:57 INFO - Running post-action listener: _start_resource_monitoring 04:59:57 INFO - Starting resource monitoring. 04:59:57 INFO - ##### 04:59:57 INFO - ##### Running install step. 04:59:57 INFO - ##### 04:59:57 INFO - Running pre-action listener: _resource_record_pre_action 04:59:57 INFO - Running main action method: install 04:59:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:59:58 INFO - Reading from file tmpfile_stdout 04:59:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:59:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:59:58 INFO - Reading from file tmpfile_stdout 04:59:58 INFO - Output received: 04:59:58 INFO - Usage: mozinstall [options] installer 04:59:58 INFO - Options: 04:59:58 INFO - -h, --help show this help message and exit 04:59:58 INFO - -d DEST, --destination=DEST 04:59:58 INFO - Directory to install application into. [default: 04:59:58 INFO - "/builds/slave/test-pgo"] 04:59:58 INFO - --app=APP Application being installed. [default: firefox] 04:59:58 INFO - mkdir: /builds/slave/test-pgo/build/application 04:59:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:59:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:00:14 INFO - Reading from file tmpfile_stdout 05:00:14 INFO - Output received: 05:00:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:00:14 INFO - Running post-action listener: _resource_record_post_action 05:00:14 INFO - ##### 05:00:14 INFO - ##### Running run-tests step. 05:00:14 INFO - ##### 05:00:14 INFO - Running pre-action listener: _resource_record_pre_action 05:00:14 INFO - Running main action method: run_tests 05:00:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:00:14 INFO - Python 2.7.3 05:00:14 INFO - Return code: 0 05:00:14 INFO - grabbing minidump binary from tooltool 05:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:14 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 0x23be8c0>, '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 0x23bf7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bfc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:00:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:00:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:00:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:14 INFO - Return code: 0 05:00:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:00:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:00:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:00:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:00:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:00:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:00:15 INFO - Return code: 0 05:00:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:00:15 INFO - Using env: {'DISPLAY': ':0', 05:00:15 INFO - 'HOME': '/home/cltbld', 05:00:15 INFO - 'LANG': 'en_US.UTF-8', 05:00:15 INFO - 'LANGUAGE': 'en_US:en', 05:00:15 INFO - 'LOGNAME': 'cltbld', 05:00:15 INFO - 'MAIL': '/var/mail/cltbld', 05:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:15 INFO - 'MOZ_NO_REMOTE': '1', 05:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:15 INFO - 'NO_EM_RESTART': '1', 05:00:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:00:15 INFO - 'SHELL': '/bin/bash', 05:00:15 INFO - 'SHLVL': '1', 05:00:15 INFO - 'TERM': 'linux', 05:00:15 INFO - 'TMOUT': '86400', 05:00:15 INFO - 'USER': 'cltbld', 05:00:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248', 05:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:15 INFO - '_': '/tools/buildbot/bin/python'} 05:00:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:00:15 INFO - mozversion application_buildid: 20160209023007 05:00:15 INFO - mozversion application_changeset: e0be6880f8e00767529ba5562ae862b7f29d66c2 05:00:15 INFO - mozversion application_display_name: Nightly 05:00:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:15 INFO - mozversion application_name: Firefox 05:00:15 INFO - mozversion application_remotingname: firefox 05:00:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:00:15 INFO - mozversion application_vendor: Mozilla 05:00:15 INFO - mozversion application_version: 47.0a1 05:00:15 INFO - mozversion platform_buildid: 20160209023007 05:00:15 INFO - mozversion platform_changeset: e0be6880f8e00767529ba5562ae862b7f29d66c2 05:00:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:00:15 INFO - mozversion platform_version: 47.0a1 05:00:15 INFO - using testdate: 1455022815 05:00:15 INFO - actual date: 1455022815 05:00:15 INFO - starting webserver on 'localhost:34574' 05:00:15 INFO - SUITE-START | Running 2 tests 05:00:15 INFO - TEST-START | dromaeo_css 05:00:15 INFO - operating with platform_type : linux_ 05:00:15 INFO - Initialising browser for dromaeo_css test... 05:00:15 INFO - TEST-INFO | started process 19514 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXfBiJc/profile http://localhost:34574/getInfo.html) 05:00:19 INFO - PROCESS | 19514 | __metrics Screen width/height:1600/1200 05:00:19 INFO - PROCESS | 19514 | colorDepth:24 05:00:19 INFO - PROCESS | 19514 | Browser inner width/height: 1024/697 05:00:19 INFO - PROCESS | 19514 | __metrics 05:00:20 INFO - PROCESS | 19514 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:00:20 INFO - TEST-INFO | 19514: exit 0 05:00:20 INFO - Browser initialized. 05:00:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:20 INFO - TEST-INFO | started process 19610 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXfBiJc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:32 INFO - PROCESS | 19610 | RSS: Main: 150614016 05:00:32 INFO - PROCESS | 19610 | 05:01:24 INFO - PROCESS | 19610 | 1455022884255 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:03:32 INFO - PROCESS | 19610 | Cycle 1(1): loaded http://localhost:34574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34574/tests/dromaeo/cssquery-ext.html) 05:03:33 INFO - PROCESS | 19610 | RSS: Main: 249147392 05:03:33 INFO - PROCESS | 19610 | 05:06:35 INFO - PROCESS | 19610 | Cycle 1(1): loaded http://localhost:34574/tests/dromaeo/cssquery-ext.html (next: http://localhost:34574/tests/dromaeo/cssquery-jquery.html) 05:06:36 INFO - PROCESS | 19610 | RSS: Main: 238419968 05:06:36 INFO - PROCESS | 19610 | 05:09:38 INFO - PROCESS | 19610 | Cycle 1(1): loaded http://localhost:34574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34574/tests/dromaeo/cssquery-mootools.html) 05:09:38 INFO - PROCESS | 19610 | RSS: Main: 237768704 05:09:38 INFO - PROCESS | 19610 | 05:12:40 INFO - PROCESS | 19610 | Cycle 1(1): loaded http://localhost:34574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34574/tests/dromaeo/cssquery-prototype.html) 05:12:41 INFO - PROCESS | 19610 | RSS: Main: 216137728 05:12:41 INFO - PROCESS | 19610 | 05:15:44 INFO - PROCESS | 19610 | Cycle 1(1): loaded http://localhost:34574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34574/tests/dromaeo/cssquery-yui.html) 05:15:44 INFO - PROCESS | 19610 | RSS: Main: 218324992 05:15:44 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | Cycle 1(1): loaded http://localhost:34574/tests/dromaeo/cssquery-yui.html (next: http://localhost:34574/tests/dromaeo/cssquery-dojo.html) 05:18:47 INFO - PROCESS | 19610 | RSS: Main: 276250624 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | __start_tp_report 05:18:47 INFO - PROCESS | 19610 | _x_x_mozilla_page_load 05:18:47 INFO - PROCESS | 19610 | _x_x_mozilla_page_load_details 05:18:47 INFO - PROCESS | 19610 | |i|pagename|runs| 05:18:47 INFO - PROCESS | 19610 | |0;dojo.html;3170.175754303881;3187.5856138701993;3227.225465888186;3229.337985712929;3261.6575259597744;5161.225816127583;5188.7405629718505;5192.065428222918;5234.345706786652;5283.603729720267;5070.518300761431;5138.100832354342;5170.224466330053;5174.275601415805;5277.076511610462;4732.1245569569655;4745.928811067837;4752.144613969484;4753.02334348556;4895.510448955111;4786.042791441726;4819.662623616331;4834.854954351375;4872.731999740013;4913.31213630092;4671.88320291992;4716.764161791931;4758;4763.928541071869;4835.371401717754;4769.57073863354;4770.045990801819;4777.928331075037;4786.042791441726;4816.759162041884;4755.096531658974;4755.262934245197;4759.095771803346;4776.402949631296;4783.617310615143;4897.657163998521;4986.775595098229;5035.2195409711185;5127.7948882044675;5161.354830646169;5639.125935480007;5652.208690783253;5654.180143879155;5656.660600363992;5667.603267771257;5535.58483113764;5679.176519404663;5682.431756824326;5687.488126068673;5690.829275121753;5216.8695782605355;5253.842384728464;5266.631335806534;5288.9735551322;5338;5734.197212390269;5744.396838331915;5753.626014309057;5757.913631295534;5760.683162426023;5400.216968539618;5495.752691128909;5529.861753456115;5552.278203833475;5566.805161819317;5587.329520457572;5664.405237450009;5666.9716651416475;5668.149777533403;5704.486596206279;5596.384397716248;5605.299337582802;5612;5612.831615051555;5613.129964855454;5454.10007348791;5558;5606.327240731139;5609.326880774333;5627.071533196977;4380.6057454829215;4381.9342709859375;4387.758673273001;4412.889677758018;4428.357888106207;3908.394198899175;3924.6860251179837;3926.8232929517667;3943.073377756225;3951;5111.87220319495;5120.590352771769;5174.223866420067;5204.115300398941;5277.577793776489;5650.067738823131;5654.886902261932;5668.971655141698;5680.289963754531;5688.577855536116;5225.608079394061;5252.264682944391;5259.474052594786;5260.053190425683;5282.1548552232225;4731.361266229083;4780.259059845729;4816.325714399987;4832.323474713543;4863.878403039952;5831.854203644943;5841.795537156179;5846.824595262149;5851.941480585225;5853.268341457318;5546.306711661043;5623.606347555632;5639.915401268902;5642.717864106696;5650.915236271377;5693.430656934273;5763.135529670583;5828.446297601721;5877.764889404376;5897.911531326948;5505.532029777513;5506.394296627288;5512.200730893917;5525.4474552544425;5540.058190107772;5560.666360018412;5567.109262517978;5613.635113717595;5629.127485239795;5652.915206271827;5434.076207044733;5520.558355331484;5522.2544956430365;5524.171374293888;5568.081266590967;5477.75350109238;5494.928488944617;5495.175723641486;5495.505404513613;5496.862578435571;5212.687238765686;5323.228131920927;5324.9733751331;5406.189071639285;5457.399686034453;5516.806911758069;5558.666480011212;5559.054960656617;5603.8879222416135;5607.186957891001;5411.269478620336;5428.511433970962;5458.563314934875;5459.454054594509;5474.890502190014 05:18:47 INFO - PROCESS | 19610 | |1;ext.html;506.2482213912339;518.458211169328;521.7260938007547;530.9097453432915;549.170752164232;27085.322866928338;27620.447591048167;34972.32790556993;35457.82271088641;35477.82261088691;37939.24121517568;38326.808365958204;38423;38474.615253847456;38629.613703863026;8325.958370208156;8422.410431269813;8424.326053915673;8495.065542790318;8520.233179013887;8419.07390187079;8533.232009119178;8549.358798090137;8552.871706924401;8561.44350617211;8768;8824;8842.159994800484;8850.822983540325;8851.77870553238;8730.956345218297;8751.34364922627;8792.692255771017;8821.691240806573;8824.073472285414;8550.486970781772;8689.869651955225;8697.347698922606;8700.564971751388;8706.129387061306;38015;38369.61630383688;38485.23029539421;38519;38566.42150367747;3367.747418943589;3406.9148271293416;3431.605365382963;3566.661167189113;3883.456316115746;26955.595666065026;27663.723362766315;28192.85903570469;29090.563641545396;29192.562111568343;3204.4712622417273;3234;3279.2785587171024;3317.2204531934976;3377.662233776627;196947;203837;204502;205280;205299;53041;56880;64872.35127648758;66617;66985;61227.08159377613;61379.693101534205;61737.07394389088;61738.382616173265;61775.38224617786;14731.410743570352;15829;15832.92083539598;15847.603809904615;15854.524364269091;12216.20594661362;12308.753824923631;12340.691482712824;12347.38263086842;12359.50561977511;20586;20934.790652093285;20944.581108377748;20953;21064.578708425746;8067.298752566644;8315.542645154575;8315.8336833263;8323.66705331792;8447.704330348532;1002.1882275356838;1010.2120346130031;1013.2755080117752;1019.0573719309609;1139.2879450343535;29567.965121220655;29581.85209073941;29738.851305743334;29941.700582994326;32117.35765284728;1031.9948400258102;1069.7806949575318;1071.3732466507024;1085.625459216569;1151.7120719820045;14924.925375373054;14946.918047863779;15557.377704891678;15567.688646227012;15889;363850;367324;371619;371702;372979;50991;51261.231081533806;51349.48650513522;51476.742616287425;51660.22509662358;1310.043668122257;1325.8001508634702;1326.3898606641053;1333.0335506757524;1460.306354481634;29203;30098.3980320388;31679.84160079185;32416.513752294206;34095.48856767101;49282.26076608782;49947;49950;49961;49980.500194997585;263709;278866;389621;395310;397631;40747.18505629811;41043.384349235384;41427;41464.79267603643;41626.1674766509;44527.77736111299;44559.10881782282;44844.55155448534;45149.54850451585;45172;36954.26091478209;37284.62715372811;37871.43192852165;38384;38876.6112338873;37216.44175337426;37347.439788402655;37731;37969.24061518699;38142.80928595339;33389.83305083459;39424.21151576895;39768;40483.79758101191;40609.59390406176;28892.711072889004;32714.672853271164;33313.500297496044;33350.33299334048;33403;25198;25959.740402595733;26383.34041648974;27284.181474555797;28010.89918256098 05:18:47 INFO - PROCESS | 19610 | |2;jquery.html;362.19773202356794;364.56616626214804;367.40663827917916;370.6404787356265;374.76577139287946;13458.1925084495;13628.114172578775;15744.212789360528;16477;16903.830961690364;14473.42106315746;15417.383304667828;15814.525564233092;15824.604384890383;15967.760483592727;5205.661631993928;5417.756200970965;5425.050616142179;5427;5427.402985671573;3990.1221731219084;5322.148456247001;5369.087255166631;5653.180288858113;5896.145058966447;5947.553933454987;6022.8494287642725;6035.849103772397;6085.604435711687;6093.964026115549;5732.627379220337;5813.302403711539;5871.853203669943;5875.647461152324;5969.820905372824;5131.461196574343;5150.819721309736;5172.043172013189;5263.815766448156;5265.341832270966;19120.61758764817;19176.137073831713;19266.32567860118;19275.710864337045;19653.901730491256;2189.5511420158828;2334.976650233493;2520.823542352036;2714.1586108306487;2943.7792165587666;12394.938025309906;12492.375381230993;12522.123451358408;12767.680807979876;12960.287184204864;1773.866959977994;1839.5217243516647;1843.8524918006526;1852.944411667652;1879.6710575649206;54345.456545434834;55089;55101.72449137729;55225.171622425696;55422.722886385716;9498.477583732962;9676.322657414054;9843.557039933221;9866.161376283097;9927.851082233772;12692.936535317449;12872.420741066675;12914.160579562486;12921.741565168832;12928.935355323163;7476.588787616624;7477.289657482531;7527.548347099191;7687.769366919001;7693.807654808675;7271.41828653717;7276.96361518189;7301.780946571611;7315.122185337794;7335;5187.170052791535;5866.882662346729;5901.17383566301;5920.230370051866;5931.11033344993;1666.4000959654516;1731.3507434711983;1763.1173032092365;1769.938052168168;1781.9376321828674;949.6248981652209;979.7011911367101;991;1069.8930106989394;1123.7808627317595;12216.694582635328;15592.610184745472;15735.763963540556;16109.19454027294;16163.43427980015;921.3964853021282;943;949.0841338108759;980.4558470049049;981.239539357004;8215.876761848576;9211;9466.621335146654;10032.849507257397;10074.647387341407;476559;515824;516798;520392;537893;67202;73445.63277183687;76765.61617191878;78826.60586697144;80205.19794801978;500.07735727582553;510.52521155325906;512.8487096306599;513.3941948500805;514.8352527191338;9833.704988850346;10179.236557258384;10272.845907311546;10374.896251037393;10502.949705029436;30952.380952381278;31201;33862.66137338595;34266.48600271048;34922.82538587291;42154.94612634709;42720;43001.354979675954;43581.128377432906;43719;7415.962920185365;7629.961850190713;7637.312641862259;7758.7672369829;7824.256695613907;10130.94934525352;11847.111466640208;11996.58011969577;12042.157049006486;12090.395480226129;10239.48802559854;10342.810576783766;10464.790704186025;10491.265611407129;10542.8418573723;10171.100761558426;10231.755912848605;10363.533640986023;10486.94756526243;10652.254342196282;10185.541650625592;10224.897751022394;10520;10536.420496872746;10542.525586348786;7667.386609071373;7710.344620707303;7752.7674169775;7755.650995705094;7760.379169666526;7393.667284972082;8737.781555461164;9526.45686488644;10245.74385640365;10433.791324173322 05:18:47 INFO - PROCESS | 19610 | |3;mootools.html;1302.719915218228;1436.683929535502;1454.4036944852612;1593.3308010635533;1771.2295151609044;6719.260881303053;7374.815629609262;7533.397328213737;7533.811654708635;7557.433192510556;7566.772996810091;7712.730054448096;7712.807179820507;7717.228277172294;7719.72980945667;2001.4996250937265;2056.722342483768;2057.701633263176;2310.445493081661;2335.0776443304885;2089.89550522474;2291.5302363015544;2347.5187586544803;2352.752960939102;2353.3881190890406;2247.202243203664;2283.6917016202765;2292.862428254302;2307.238611258289;2307.4462129089065;2170.1644866726265;2179.193698331612;2185.4317877351923;2185.967210491844;2331.9300420987397;2172.6197915364905;2173.413178441812;2173.4349069241953;2177.9782202177935;2180.531185795062;7737.8452430951065;7754.9224507755325;7762.408706215212;7795.532268063877;7801.726939557088;4804.303376010494;4880.877978050542;4881.731504767236;4884.3650325457465;4913.484084171147;3048.512238041925;3069.109958112145;3159.620845498555;3162.509810979302;3188.9681103188905;934.3272843552631;957.899420560845;973.474323865112;975.9609615615367;982.1946004276496;10895.455227238686;10912;10923.563057477691;10932.672019839418;10935.28920620157;4388.100439409914;4424.7123936944;4476.395686582335;4488.12481566098;4489.820407183676;9379.155875971195;9382.48396338208;9387.5306234688;9409.529523523797;9413.717588472357;4891.682040667345;4899.779509921991;4903.141950158708;4906.533879281463;4908.312836202935;4430.977845110754;4435.622972047412;4441.133978874089;4442.400275962768;4446.577575130357;3471.4966329882027;3594.299111673251;3684.6315368463474;3687.94468082979;3742.2328422673286;1204.6506513111099;1208.6192849252457;1209.498058305811;1223.070466445508;1230.7476967221698;1039.7036844499282;1056.498163372392;1057.841323801436;1209.5464200924653;1353.3233383308345;7279.308465695751;7433.219511951275;7435.219301973323;7450.850982980419;7464.85070298591;1089.1824156332007;1092.4919912240846;1095.8904109588977;1097.926691972774;1099.7855418193376;5850.23946886902;5897.0269905465975;5904.409559044061;5905.055191169392;5907.054871220584;9020.368574199743;9114.908850911539;9659.420434773936;9667.27495437845;9769.120779129913;9559.330846840794;9579.521023948913;9580.95209523948;9657.951710241405;9659.178969787507;7345.853082938312;7394.704211831467;7548.924510754932;7561.9243807562325;7612.733554325572;7300.12398512182;7336.339729424378;7341.3392794648735;7352.4485663576515;7364.374028207662;8384;8516.105808889977;8617.267532259828;8640.438371506083;8804.86792698123;8732.214100730966;8870.822583548423;8909.821803563762;8917.063708310794;8932.86600701003;6704.966475167593;6795.3204679531655;6813.148356455443;6822.351876571718;6835.760748373783;6711.932880671131;6866.279040700654;7251.311125443074;7390.667419966222;7633.389328853789;7140.892886606601;7229.7469588564145;7252.38354739853;7287.092638155223;7304.488685791944;7145.17830449505;7172.892406613801;7184.13790345141;7201.747938822116;7236.38490728273;6961.477889158435;7233.276672332725;7276.30875066889;7277.163126240338;7287.781366559012;6565.048068030013;6608.43828274602;6608.570442921387;6612.107365505595;6624.701888414937;6644.767433139817;6669.166354205724;6681.098051763144;6687.09724187248;6687.799366019027 05:18:47 INFO - PROCESS | 19610 | |4;prototype.html;317.46348670746437;341.7812599936041;343.03948942959704;343.5998306899386;350.6843840543509;5745.224394706714;5884.911726324103;5911.615744976579;5914.970425147879;5950.613210141349;5686;5809.7385617647205;5812.4768770810615;5820.912686309709;5836.124581312794;4569.086182763453;4578.793954272066;4582.221022426179;4607.7004994675235;4612.8385506507275;4399.714018588797;4443.400140980974;4586.931196032062;4598.8620341389815;4626.768661566925;4555.817767289304;4561.749103799306;4568.086382723452;4577.748223847687;4583.1062942726185;4564.269716845305;4576.0161565263625;4585.518520555327;4587.816487340502;4594.632429405639;4012.1574469361467;4053.797310134511;4055.188962207541;4055.655269302113;4062.6952978526433;5488.121900495901;5598.608097433182;5626.015447296707;5664.716764161817;5677.40387259336;5304.045271851065;5311.389190243094;5318.468153184651;5320.866978325535;5321.547668448186;5940.079287710412;6293.874122517524;6294.842628934268;6299.748010079591;6303.180586523768;4371.388005679208;4454.933176002362;4462.709923854939;4501.977490112561;4520.660950428731;6468.644224567647;6520.739170433177;6521.15225020749;6529.804105876831;6538.150040494753;4590.931136032962;4592.3800286961505;4595.4025976622825;4595.977020114878;4596.954030459719;4512.684112112186;4650;4653.162430762495;4660.114578230193;4687.296905464208;5301.257823904656;5307.946920530822;5310.60170487215;5314.601404894648;5319.175527793198;6315.305316415191;6318.273398559225;6327.557071004985;6337.873242535124;6338.049292606146;1627.1376170629585;1649.686559553681;1649.892756970793;1650.306871114135;1650.8596769274745;1117.53063713239;1122.1639878290562;1129.9039581635652;1133.7505748735266;1158.1603337580186;5923.644581325134;5943.5839491236065;5947.881042379128;5948.970255148696;5950.19672344228;6456.967715161488;6464.0627109069865;6473.708683109271;6476.870462590722;6477.935220647827;5830.8542286442325;5911.408859114054;5953.315368732565;5961.731722072517;5968.432998865101;3402.3705614461405;3458.6714262145056;3474.6351633078666;3501.9824900875333;3504.123969007748;6708.6310252936555;6719.865602687919;6754.155730533684;6758.594484330956;6760.932390676128;6586.6377349245295;6591.571547849375;6595.703193356215;6600.405963463311;6612.636305003175;6538.509611779135;6708.664566771642;6725.8654826903185;6734.696938637773;6743.157105361928;6230.501559875109;6385.489160867027;6422.582532135583;6434.871302574016;6498.642574658439;6410.423061924449;6438.034294855809;6442.226932768098;6446.806595802133;6451.645159516272;6775.796726098225;6783.491238157059;6787.524873258824;6788.898166527407;6801.149856267966;4442.511323754449;4542.250528662866;4545.159145558082;4550.6359491239955;4551.795169217327;6493.8701225976165;6511.088447617432;6511.576747511396;6517.185351831021;6523.804285871432;6316.778912738032;6328.715207815567;6335.493160547053;6340.682965851781;6342.143810585512;6166.414190651881;6320.778772742932;6325.652089135142;6326.114343991753;6329.841753956188;6217.782377616762;6220.533459990428;6221.9377806223165;6223.657698826608;6230.408111229426;6351.745930162741;6355.110284560073;6360.840978975562;6360.968195158995;6375.107484952203;6072.787452439144;6171.783987560414;6179.474744646755;6234.2830574484515;6238.220222472191 05:18:47 INFO - PROCESS | 19610 | |5;yui.html;705.717712914834;724.6050902258269;787.5707739282091;812.2851890336503;814.588632740466;12399;12489.313087780169;12512.686167952359;12526.874731252685;12535.373231338443;12945.482180712761;14270.357833897473;14827;14852.55442336729;14862.108273503598;668.7291646882995;819.2503858969036;829.7759604906671;832.0306842528447;832.966681332749;681.4310051107307;810.4367464612097;826.7395770332326;826.9545175015372;828.3456069704926;861.2679222660751;868.4181598329135;868.8392647360226;869.2741560796711;869.4696235296495;694.402813580323;860.3031544448985;863.2532859076916;871.825634873028;883.9204471597587;628.6353914729445;630.9148264984215;631.3465563142172;631.987360252797;632.317097534666;13330.666733331647;13423.194608323533;13444.86555134446;13510.121842080332;13516.729665406638;12590.937045314806;12811.615651530376;12901.419436125398;12940.870591294155;13150.736985260337;9865.11213990737;9884.505774711308;9930.702078937644;10454.895451045468;10923.726906827313;3691.280200360931;3741.4387841823673;3771.9434208486896;3793.7534060285993;3865.4588357629955;49199.26201106986;49594.50405495971;49641.510754677416;50043;50080.74959625215;9980.251481138943;9986.101250887456;10142.695719128438;10254.692359229235;10700.946495267473;19170.233190672217;19177;19178.232870685297;19185;19201.903990479957;7390.593517356597;7466.552006879605;7609.239076092457;7722.961385193151;7746.806329841686;4334.046509767846;4346.956530434719;4381.3427985801745;4384.210842048462;4446.577575130357;3156.4160630283013;3182.5226216067313;3193.0420873737785;3199;3202.759793015533;578.9160571717077;590.2326974932571;599.9130126131773;606.0364021206215;608.6256951974503;604.7671646416161;635.2313700422541;675.7972608217614;695.8295217671703;706.7950294414665;7858.44990850635;7881.960590197013;7924.286814186751;8124.187581241947;8124.959375203086;572.6621293436892;608.2913405882186;650.8437974885993;656.1306269193337;710.2471380336859;3831.8658846940225;3913.3934240192816;3928.4696565963227;4048.3725022621543;4057.776822274744;53368.73315633475;54152.72923635357;54377.1843422349;54505.45494545083;54861;46865.5313446868;47938.280925786145;48226.27660585094;48261.75869120702;48300.5169948296;43438.13123737508;44342.11315773666;44566.55433445689;44720.77639611846;44826.55173448289;7619.4285428594185;7828.765137045898;8405.537695426565;8546.615402306787;8557.015943166616;32259;32286.515702264016;32393.352132956737;32915.83542082274;33855.66144338525;40338.798306008284;40996.59003410047;41056.178876421705;41470;41569.1686166281;10598.15214782831;10691.679249622524;11013.559457621606;11046.281991670516;11213.215074944676;12059.15585908978;12265.57070502528;12313.507459701512;12420;12650.430730617329;11189.776204476027;11195.552177913118;11418.486168122288;11476.942615286871;11722.94138529302;11099.944500277446;11280;11555.711107222387;11635.41822908868;11738.90892380849;8336.583170841312;10077.596896124072;10081.445520496443;10712.73218169552;11002.394868282321;7307.671154798153;8029;8169.183081691784;8913.039131391084;9259.861102083609;9289.581968811284;9328.813423731623;9345.579448924678;9349.672761453316;9491.762705932408 05:18:47 INFO - PROCESS | 19610 | __end_tp_report 05:18:47 INFO - PROCESS | 19610 | __start_cc_report 05:18:47 INFO - PROCESS | 19610 | _x_x_mozilla_cycle_collect,787 05:18:47 INFO - PROCESS | 19610 | __end_cc_report 05:18:47 INFO - PROCESS | 19610 | __startTimestamp1455023927603__endTimestamp 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | ------- Summary: start ------- 05:18:47 INFO - PROCESS | 19610 | Number of tests: 6 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | [#0] dojo.html Cycles:165 Average:5219.29 Median:5434.08 stddev:565.47 (10.4%) stddev-sans-first:543.88 05:18:47 INFO - PROCESS | 19610 | Values: 3170.2 3187.6 3227.2 3229.3 3261.7 5161.2 5188.7 5192.1 5234.3 5283.6 5070.5 5138.1 5170.2 5174.3 5277.1 4732.1 4745.9 4752.1 4753.0 4895.5 4786.0 4819.7 4834.9 4872.7 4913.3 4671.9 4716.8 4758.0 4763.9 4835.4 4769.6 4770.0 4777.9 4786.0 4816.8 4755.1 4755.3 4759.1 4776.4 4783.6 4897.7 4986.8 5035.2 5127.8 5161.4 5639.1 5652.2 5654.2 5656.7 5667.6 5535.6 5679.2 5682.4 5687.5 5690.8 5216.9 5253.8 5266.6 5289.0 5338.0 5734.2 5744.4 5753.6 5757.9 5760.7 5400.2 5495.8 5529.9 5552.3 5566.8 5587.3 5664.4 5667.0 5668.1 5704.5 5596.4 5605.3 5612.0 5612.8 5613.1 5454.1 5558.0 5606.3 5609.3 5627.1 4380.6 4381.9 4387.8 4412.9 4428.4 3908.4 3924.7 3926.8 3943.1 3951.0 5111.9 5120.6 5174.2 5204.1 5277.6 5650.1 5654.9 5669.0 5680.3 5688.6 5225.6 5252.3 5259.5 5260.1 5282.2 4731.4 4780.3 4816.3 4832.3 4863.9 5831.9 5841.8 5846.8 5851.9 5853.3 5546.3 5623.6 5639.9 5642.7 5650.9 5693.4 5763.1 5828.4 5877.8 5897.9 5505.5 5506.4 5512.2 5525.4 5540.1 5560.7 5567.1 5613.6 5629.1 5652.9 5434.1 5520.6 5522.3 5524.2 5568.1 5477.8 5494.9 5495.2 5495.5 5496.9 5212.7 5323.2 5325.0 5406.2 5457.4 5516.8 5558.7 5559.1 5603.9 5607.2 5411.3 5428.5 5458.6 5459.5 5474.9 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | [#1] ext.html Cycles:180 Average:47965.39 Median:37539.22 stddev:83317.59 (221.9%) stddev-sans-first:83475.11 05:18:47 INFO - PROCESS | 19610 | Values: 506.2 518.5 521.7 530.9 549.2 27085.3 27620.4 34972.3 35457.8 35477.8 37939.2 38326.8 38423.0 38474.6 38629.6 8326.0 8422.4 8424.3 8495.1 8520.2 8419.1 8533.2 8549.4 8552.9 8561.4 8768.0 8824.0 8842.2 8850.8 8851.8 8731.0 8751.3 8792.7 8821.7 8824.1 8550.5 8689.9 8697.3 8700.6 8706.1 38015.0 38369.6 38485.2 38519.0 38566.4 3367.7 3406.9 3431.6 3566.7 3883.5 26955.6 27663.7 28192.9 29090.6 29192.6 3204.5 3234.0 3279.3 3317.2 3377.7 196947.0 203837.0 204502.0 205280.0 205299.0 53041.0 56880.0 64872.4 66617.0 66985.0 61227.1 61379.7 61737.1 61738.4 61775.4 14731.4 15829.0 15832.9 15847.6 15854.5 12216.2 12308.8 12340.7 12347.4 12359.5 20586.0 20934.8 20944.6 20953.0 21064.6 8067.3 8315.5 8315.8 8323.7 8447.7 1002.2 1010.2 1013.3 1019.1 1139.3 29568.0 29581.9 29738.9 29941.7 32117.4 1032.0 1069.8 1071.4 1085.6 1151.7 14924.9 14946.9 15557.4 15567.7 15889.0 363850.0 367324.0 371619.0 371702.0 372979.0 50991.0 51261.2 51349.5 51476.7 51660.2 1310.0 1325.8 1326.4 1333.0 1460.3 29203.0 30098.4 31679.8 32416.5 34095.5 49282.3 49947.0 49950.0 49961.0 49980.5 263709.0 278866.0 389621.0 395310.0 397631.0 40747.2 41043.4 41427.0 41464.8 41626.2 44527.8 44559.1 44844.6 45149.5 45172.0 36954.3 37284.6 37871.4 38384.0 38876.6 37216.4 37347.4 37731.0 37969.2 38142.8 33389.8 39424.2 39768.0 40483.8 40609.6 28892.7 32714.7 33313.5 33350.3 33403.0 25198.0 25959.7 26383.3 27284.2 28010.9 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | [#2] jquery.html Cycles:180 Average:26799.54 Median:260139.00 stddev:83993.07 (32.3%) stddev-sans-first:84205.23 05:18:47 INFO - PROCESS | 19610 | Values: 362.2 364.6 367.4 370.6 374.8 13458.2 13628.1 15744.2 16477.0 16903.8 14473.4 15417.4 15814.5 15824.6 15967.8 5205.7 5417.8 5425.1 5427.0 5427.4 3990.1 5322.1 5369.1 5653.2 5896.1 5947.6 6022.8 6035.8 6085.6 6094.0 5732.6 5813.3 5871.9 5875.6 5969.8 5131.5 5150.8 5172.0 5263.8 5265.3 19120.6 19176.1 19266.3 19275.7 19653.9 2189.6 2335.0 2520.8 2714.2 2943.8 12394.9 12492.4 12522.1 12767.7 12960.3 1773.9 1839.5 1843.9 1852.9 1879.7 54345.5 55089.0 55101.7 55225.2 55422.7 9498.5 9676.3 9843.6 9866.2 9927.9 12692.9 12872.4 12914.2 12921.7 12928.9 7476.6 7477.3 7527.5 7687.8 7693.8 7271.4 7277.0 7301.8 7315.1 7335.0 5187.2 5866.9 5901.2 5920.2 5931.1 1666.4 1731.4 1763.1 1769.9 1781.9 949.6 979.7 991.0 1069.9 1123.8 12216.7 15592.6 15735.8 16109.2 16163.4 921.4 943.0 949.1 980.5 981.2 8215.9 9211.0 9466.6 10032.8 10074.6 476559.0 515824.0 516798.0 520392.0 537893.0 67202.0 73445.6 76765.6 78826.6 80205.2 500.1 510.5 512.8 513.4 514.8 9833.7 10179.2 10272.8 10374.9 10502.9 30952.4 31201.0 33862.7 34266.5 34922.8 42154.9 42720.0 43001.4 43581.1 43719.0 7416.0 7630.0 7637.3 7758.8 7824.3 10130.9 11847.1 11996.6 12042.2 12090.4 10239.5 10342.8 10464.8 10491.3 10542.8 10171.1 10231.8 10363.5 10486.9 10652.3 10185.5 10224.9 10520.0 10536.4 10542.5 7667.4 7710.3 7752.8 7755.7 7760.4 7393.7 8737.8 9526.5 10245.7 10433.8 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | [#3] mootools.html Cycles:180 Average:5531.22 Median:6656.97 stddev:2883.91 (43.3%) stddev-sans-first:2874.48 05:18:47 INFO - PROCESS | 19610 | Values: 1302.7 1436.7 1454.4 1593.3 1771.2 6719.3 7374.8 7533.4 7533.8 7557.4 7566.8 7712.7 7712.8 7717.2 7719.7 2001.5 2056.7 2057.7 2310.4 2335.1 2089.9 2291.5 2347.5 2352.8 2353.4 2247.2 2283.7 2292.9 2307.2 2307.4 2170.2 2179.2 2185.4 2186.0 2331.9 2172.6 2173.4 2173.4 2178.0 2180.5 7737.8 7754.9 7762.4 7795.5 7801.7 4804.3 4880.9 4881.7 4884.4 4913.5 3048.5 3069.1 3159.6 3162.5 3189.0 934.3 957.9 973.5 976.0 982.2 10895.5 10912.0 10923.6 10932.7 10935.3 4388.1 4424.7 4476.4 4488.1 4489.8 9379.2 9382.5 9387.5 9409.5 9413.7 4891.7 4899.8 4903.1 4906.5 4908.3 4431.0 4435.6 4441.1 4442.4 4446.6 3471.5 3594.3 3684.6 3687.9 3742.2 1204.7 1208.6 1209.5 1223.1 1230.7 1039.7 1056.5 1057.8 1209.5 1353.3 7279.3 7433.2 7435.2 7450.9 7464.9 1089.2 1092.5 1095.9 1097.9 1099.8 5850.2 5897.0 5904.4 5905.1 5907.1 9020.4 9114.9 9659.4 9667.3 9769.1 9559.3 9579.5 9581.0 9658.0 9659.2 7345.9 7394.7 7548.9 7561.9 7612.7 7300.1 7336.3 7341.3 7352.4 7364.4 8384.0 8516.1 8617.3 8640.4 8804.9 8732.2 8870.8 8909.8 8917.1 8932.9 6705.0 6795.3 6813.1 6822.4 6835.8 6711.9 6866.3 7251.3 7390.7 7633.4 7140.9 7229.7 7252.4 7287.1 7304.5 7145.2 7172.9 7184.1 7201.7 7236.4 6961.5 7233.3 7276.3 7277.2 7287.8 6565.0 6608.4 6608.6 6612.1 6624.7 6644.8 6669.2 6681.1 6687.1 6687.8 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | [#4] prototype.html Cycles:180 Average:5277.47 Median:5919.31 stddev:1564.39 (26.4%) stddev-sans-first:1523.84 05:18:47 INFO - PROCESS | 19610 | Values: 317.5 341.8 343.0 343.6 350.7 5745.2 5884.9 5911.6 5915.0 5950.6 5686.0 5809.7 5812.5 5820.9 5836.1 4569.1 4578.8 4582.2 4607.7 4612.8 4399.7 4443.4 4586.9 4598.9 4626.8 4555.8 4561.7 4568.1 4577.7 4583.1 4564.3 4576.0 4585.5 4587.8 4594.6 4012.2 4053.8 4055.2 4055.7 4062.7 5488.1 5598.6 5626.0 5664.7 5677.4 5304.0 5311.4 5318.5 5320.9 5321.5 5940.1 6293.9 6294.8 6299.7 6303.2 4371.4 4454.9 4462.7 4502.0 4520.7 6468.6 6520.7 6521.2 6529.8 6538.2 4590.9 4592.4 4595.4 4596.0 4597.0 4512.7 4650.0 4653.2 4660.1 4687.3 5301.3 5307.9 5310.6 5314.6 5319.2 6315.3 6318.3 6327.6 6337.9 6338.0 1627.1 1649.7 1649.9 1650.3 1650.9 1117.5 1122.2 1129.9 1133.8 1158.2 5923.6 5943.6 5947.9 5949.0 5950.2 6457.0 6464.1 6473.7 6476.9 6477.9 5830.9 5911.4 5953.3 5961.7 5968.4 3402.4 3458.7 3474.6 3502.0 3504.1 6708.6 6719.9 6754.2 6758.6 6760.9 6586.6 6591.6 6595.7 6600.4 6612.6 6538.5 6708.7 6725.9 6734.7 6743.2 6230.5 6385.5 6422.6 6434.9 6498.6 6410.4 6438.0 6442.2 6446.8 6451.6 6775.8 6783.5 6787.5 6788.9 6801.1 4442.5 4542.3 4545.2 4550.6 4551.8 6493.9 6511.1 6511.6 6517.2 6523.8 6316.8 6328.7 6335.5 6340.7 6342.1 6166.4 6320.8 6325.7 6326.1 6329.8 6217.8 6220.5 6221.9 6223.7 6230.4 6351.7 6355.1 6360.8 6361.0 6375.1 6072.8 6171.8 6179.5 6234.3 6238.2 05:18:47 INFO - PROCESS | 19610 | 05:18:47 INFO - PROCESS | 19610 | [#5] yui.html Cycles:180 Average:13399.20 Median:48082.28 stddev:15235.14 (31.7%) stddev-sans-first:15248.05 05:18:47 INFO - PROCESS | 19610 | Values: 705.7 724.6 787.6 812.3 814.6 12399.0 12489.3 12512.7 12526.9 12535.4 12945.5 14270.4 14827.0 14852.6 14862.1 668.7 819.3 829.8 832.0 833.0 681.4 810.4 826.7 827.0 828.3 861.3 868.4 868.8 869.3 869.5 694.4 860.3 863.3 871.8 883.9 628.6 630.9 631.3 632.0 632.3 13330.7 13423.2 13444.9 13510.1 13516.7 12590.9 12811.6 12901.4 12940.9 13150.7 9865.1 9884.5 9930.7 10454.9 10923.7 3691.3 3741.4 3771.9 3793.8 3865.5 49199.3 49594.5 49641.5 50043.0 50080.7 9980.3 9986.1 10142.7 10254.7 10700.9 19170.2 19177.0 19178.2 19185.0 19201.9 7390.6 7466.6 7609.2 7723.0 7746.8 4334.0 4347.0 4381.3 4384.2 4446.6 3156.4 3182.5 3193.0 3199.0 3202.8 578.9 590.2 599.9 606.0 608.6 604.8 635.2 675.8 695.8 706.8 7858.4 7882.0 7924.3 8124.2 8125.0 572.7 608.3 650.8 656.1 710.2 3831.9 3913.4 3928.5 4048.4 4057.8 53368.7 54152.7 54377.2 54505.5 54861.0 46865.5 47938.3 48226.3 48261.8 48300.5 43438.1 44342.1 44566.6 44720.8 44826.6 7619.4 7828.8 8405.5 8546.6 8557.0 32259.0 32286.5 32393.4 32915.8 33855.7 40338.8 40996.6 41056.2 41470.0 41569.2 10598.2 10691.7 11013.6 11046.3 11213.2 12059.2 12265.6 12313.5 12420.0 12650.4 11189.8 11195.6 11418.5 11476.9 11722.9 11099.9 11280.0 11555.7 11635.4 11738.9 8336.6 10077.6 10081.4 10712.7 11002.4 7307.7 8029.0 8169.2 8913.0 9259.9 9289.6 9328.8 9345.6 9349.7 9491.8 05:18:47 INFO - PROCESS | 19610 | -------- Summary: end -------- 05:18:47 INFO - PROCESS | 19610 | 05:18:48 INFO - TEST-INFO | 19610: exit 0 05:18:48 INFO - TEST-OK | dromaeo_css | took 1112443ms 05:18:48 INFO - TEST-START | kraken 05:18:48 INFO - operating with platform_type : linux_ 05:18:48 INFO - Initialising browser for kraken test... 05:18:48 INFO - TEST-INFO | started process 19792 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbjyAqE/profile http://localhost:34574/getInfo.html) 05:18:52 INFO - PROCESS | 19792 | __metrics Screen width/height:1600/1200 05:18:52 INFO - PROCESS | 19792 | colorDepth:24 05:18:52 INFO - PROCESS | 19792 | Browser inner width/height: 1024/697 05:18:52 INFO - PROCESS | 19792 | __metrics 05:18:52 INFO - PROCESS | 19792 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:53 INFO - TEST-INFO | 19792: exit 0 05:18:53 INFO - Browser initialized. 05:18:53 INFO - Running cycle 1/1 for kraken test... 05:18:53 INFO - TEST-INFO | started process 19877 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbjyAqE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:05 INFO - PROCESS | 19877 | RSS: Main: 152039424 05:19:05 INFO - PROCESS | 19877 | 05:19:07 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34574/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:08 INFO - PROCESS | 19877 | RSS: Main: 191459328 05:19:08 INFO - PROCESS | 19877 | 05:19:10 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34574/tests/kraken/driver.html?testName=audio-dft) 05:19:11 INFO - PROCESS | 19877 | RSS: Main: 181805056 05:19:11 INFO - PROCESS | 19877 | 05:19:14 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34574/tests/kraken/driver.html?testName=audio-fft) 05:19:15 INFO - PROCESS | 19877 | RSS: Main: 166727680 05:19:15 INFO - PROCESS | 19877 | 05:19:17 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34574/tests/kraken/driver.html?testName=audio-oscillator) 05:19:17 INFO - PROCESS | 19877 | RSS: Main: 168972288 05:19:17 INFO - PROCESS | 19877 | 05:19:19 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:20 INFO - PROCESS | 19877 | RSS: Main: 169168896 05:19:20 INFO - PROCESS | 19877 | 05:19:23 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34574/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:24 INFO - PROCESS | 19877 | RSS: Main: 169308160 05:19:24 INFO - PROCESS | 19877 | 05:19:27 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34574/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:28 INFO - PROCESS | 19877 | RSS: Main: 172027904 05:19:28 INFO - PROCESS | 19877 | 05:19:30 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34574/tests/kraken/driver.html?testName=json-parse-financial) 05:19:31 INFO - PROCESS | 19877 | RSS: Main: 171556864 05:19:31 INFO - PROCESS | 19877 | 05:19:32 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:33 INFO - PROCESS | 19877 | RSS: Main: 183275520 05:19:33 INFO - PROCESS | 19877 | 05:19:35 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:35 INFO - PROCESS | 19877 | RSS: Main: 180228096 05:19:35 INFO - PROCESS | 19877 | 05:19:37 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:38 INFO - PROCESS | 19877 | RSS: Main: 191164416 05:19:38 INFO - PROCESS | 19877 | 05:19:40 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:41 INFO - PROCESS | 19877 | RSS: Main: 197627904 05:19:41 INFO - PROCESS | 19877 | 05:19:44 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:44 INFO - PROCESS | 19877 | RSS: Main: 196075520 05:19:44 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | Cycle 1(1): loaded http://localhost:34574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34574/tests/kraken/driver.html?testName=ai-astar) 05:19:46 INFO - PROCESS | 19877 | RSS: Main: 256770048 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | __start_tp_report 05:19:46 INFO - PROCESS | 19877 | _x_x_mozilla_page_load 05:19:46 INFO - PROCESS | 19877 | _x_x_mozilla_page_load_details 05:19:46 INFO - PROCESS | 19877 | |i|pagename|runs| 05:19:46 INFO - PROCESS | 19877 | |0;ai-astar;110;113;106;110;113;110;100;111;110;111 05:19:46 INFO - PROCESS | 19877 | |1;audio-beat-detection;160;124;149;184;127;154;154;126;165;130 05:19:46 INFO - PROCESS | 19877 | |2;audio-dft;161;162;161;162;162;159;160;162;161;162 05:19:46 INFO - PROCESS | 19877 | |3;audio-fft;76;73;95;93;72;77;75;130;98;76 05:19:46 INFO - PROCESS | 19877 | |4;audio-oscillator;96;96;139;97;96;96;140;96;97;136 05:19:46 INFO - PROCESS | 19877 | |5;imaging-gaussian-blur;120;116;115;115;115;114;114;115;114;115 05:19:46 INFO - PROCESS | 19877 | |6;imaging-darkroom;145;145;145;146;145;144;145;145;145;146 05:19:46 INFO - PROCESS | 19877 | |7;imaging-desaturate;96;96;98;96;96;97;96;95;96;96 05:19:46 INFO - PROCESS | 19877 | |8;json-parse-financial;57;56;55;55;55;65;55;64;53;55 05:19:46 INFO - PROCESS | 19877 | |9;json-stringify-tinderbox;67;66;67;66;66;66;66;67;67;67 05:19:46 INFO - PROCESS | 19877 | |10;stanford-crypto-aes;84;84;85;85;92;85;85;85;86;85 05:19:46 INFO - PROCESS | 19877 | |11;stanford-crypto-ccm;126;115;117;115;114;115;117;124;127;118 05:19:46 INFO - PROCESS | 19877 | |12;stanford-crypto-pbkdf2;143;146;150;154;141;141;151;160;153;154 05:19:46 INFO - PROCESS | 19877 | |13;stanford-crypto-sha256-iterative;69;71;71;71;67;69;67;74;68;69 05:19:46 INFO - PROCESS | 19877 | __end_tp_report 05:19:46 INFO - PROCESS | 19877 | __start_cc_report 05:19:46 INFO - PROCESS | 19877 | _x_x_mozilla_cycle_collect,992 05:19:46 INFO - PROCESS | 19877 | __end_cc_report 05:19:46 INFO - PROCESS | 19877 | __startTimestamp1455023986669__endTimestamp 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | ------- Summary: start ------- 05:19:46 INFO - PROCESS | 19877 | Number of tests: 14 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.84 (3.5%) stddev-sans-first:4.06 05:19:46 INFO - PROCESS | 19877 | Values: 110.0 113.0 106.0 110.0 113.0 110.0 100.0 111.0 110.0 111.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.00 stddev:20.06 (13.0%) stddev-sans-first:20.75 05:19:46 INFO - PROCESS | 19877 | Values: 160.0 124.0 149.0 184.0 127.0 154.0 154.0 126.0 165.0 130.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 05:19:46 INFO - PROCESS | 19877 | Values: 161.0 162.0 161.0 162.0 162.0 159.0 160.0 162.0 161.0 162.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#3] audio-fft Cycles:10 Average:86.50 Median:76.50 stddev:18.18 (23.8%) stddev-sans-first:18.88 05:19:46 INFO - PROCESS | 19877 | Values: 76.0 73.0 95.0 93.0 72.0 77.0 75.0 130.0 98.0 76.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:20.34 (21.2%) stddev-sans-first:21.03 05:19:46 INFO - PROCESS | 19877 | Values: 96.0 96.0 139.0 97.0 96.0 96.0 140.0 96.0 97.0 136.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.77 (1.5%) stddev-sans-first:0.67 05:19:46 INFO - PROCESS | 19877 | Values: 120.0 116.0 115.0 115.0 115.0 114.0 114.0 115.0 114.0 115.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:19:46 INFO - PROCESS | 19877 | Values: 145.0 145.0 145.0 146.0 145.0 144.0 145.0 145.0 145.0 146.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 05:19:46 INFO - PROCESS | 19877 | Values: 96.0 96.0 98.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.50 stddev:4.08 (7.4%) stddev-sans-first:4.33 05:19:46 INFO - PROCESS | 19877 | Values: 57.0 56.0 55.0 55.0 55.0 65.0 55.0 64.0 53.0 55.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:19:46 INFO - PROCESS | 19877 | Values: 67.0 66.0 67.0 66.0 66.0 66.0 66.0 67.0 67.0 67.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.32 (2.7%) stddev-sans-first:2.39 05:19:46 INFO - PROCESS | 19877 | Values: 84.0 84.0 85.0 85.0 92.0 85.0 85.0 85.0 86.0 85.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:117.50 stddev:4.94 (4.2%) stddev-sans-first:4.50 05:19:46 INFO - PROCESS | 19877 | Values: 126.0 115.0 117.0 115.0 114.0 115.0 117.0 124.0 127.0 118.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:152.00 stddev:6.36 (4.2%) stddev-sans-first:6.32 05:19:46 INFO - PROCESS | 19877 | Values: 143.0 146.0 150.0 154.0 141.0 141.0 151.0 160.0 153.0 154.0 05:19:46 INFO - PROCESS | 19877 | 05:19:46 INFO - PROCESS | 19877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:2.17 (3.1%) stddev-sans-first:2.29 05:19:46 INFO - PROCESS | 19877 | Values: 69.0 71.0 71.0 71.0 67.0 69.0 67.0 74.0 68.0 69.0 05:19:46 INFO - PROCESS | 19877 | -------- Summary: end -------- 05:19:46 INFO - PROCESS | 19877 | 05:19:47 INFO - TEST-INFO | 19877: exit 0 05:19:47 INFO - TEST-OK | kraken | took 59292ms 05:19:47 INFO - SUITE-END | took 1171s 05:19:47 INFO - Completed test suite (00:19:31) 05:19:47 INFO - Working with test: dromaeo_css 05:19:47 INFO - Generating results file: dromaeo_css 05:19:47 INFO - Working with test: kraken 05:19:47 INFO - Generating results file: kraken 05:19:47 INFO - javascript benchmark 05:19:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:19:47 INFO - process_Request line: dromaeo_css 6879.76 graph.html#tests=[[72,64,35]] 05:19:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:47 INFO - process_Request line: kraken 1516.70 graph.html#tests=[[232,64,35]] 05:19:47 INFO - RETURN: dromaeo_css: 6879.76 05:19:47 INFO - RETURN: kraken: 1516.70 05:19:47 INFO - javascript benchmark 05:19:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3170.175754303881, 3187.5856138701993, 3227.225465888186, 3229.337985712929, 3261.6575259597744, 5161.225816127583, 5188.7405629718505, 5192.065428222918, 5234.345706786652, 5283.603729720267, 5070.518300761431, 5138.100832354342, 5170.224466330053, 5174.275601415805, 5277.076511610462, 4732.1245569569655, 4745.928811067837, 4752.144613969484, 4753.02334348556, 4895.510448955111, 4786.042791441726, 4819.662623616331, 4834.854954351375, 4872.731999740013, 4913.31213630092, 4671.88320291992, 4716.764161791931, 4758.0, 4763.928541071869, 4835.371401717754, 4769.57073863354, 4770.045990801819, 4777.928331075037, 4786.042791441726, 4816.759162041884, 4755.096531658974, 4755.262934245197, 4759.095771803346, 4776.402949631296, 4783.617310615143, 4897.657163998521, 4986.775595098229, 5035.2195409711185, 5127.7948882044675, 5161.354830646169, 5639.125935480007, 5652.208690783253, 5654.180143879155, 5656.660600363992, 5667.603267771257, 5535.58483113764, 5679.176519404663, 5682.431756824326, 5687.488126068673, 5690.829275121753, 5216.8695782605355, 5253.842384728464, 5266.631335806534, 5288.9735551322, 5338.0, 5734.197212390269, 5744.396838331915, 5753.626014309057, 5757.913631295534, 5760.683162426023, 5400.216968539618, 5495.752691128909, 5529.861753456115, 5552.278203833475, 5566.805161819317, 5587.329520457572, 5664.405237450009, 5666.9716651416475, 5668.149777533403, 5704.486596206279, 5596.384397716248, 5605.299337582802, 5612.0, 5612.831615051555, 5613.129964855454, 5454.10007348791, 5558.0, 5606.327240731139, 5609.326880774333, 5627.071533196977, 4380.6057454829215, 4381.9342709859375, 4387.758673273001, 4412.889677758018, 4428.357888106207, 3908.394198899175, 3924.6860251179837, 3926.8232929517667, 3943.073377756225, 3951.0, 5111.87220319495, 5120.590352771769, 5174.223866420067, 5204.115300398941, 5277.577793776489, 5650.067738823131, 5654.886902261932, 5668.971655141698, 5680.289963754531, 5688.577855536116, 5225.608079394061, 5252.264682944391, 5259.474052594786, 5260.053190425683, 5282.1548552232225, 4731.361266229083, 4780.259059845729, 4816.325714399987, 4832.323474713543, 4863.878403039952, 5831.854203644943, 5841.795537156179, 5846.824595262149, 5851.941480585225, 5853.268341457318, 5546.306711661043, 5623.606347555632, 5639.915401268902, 5642.717864106696, 5650.915236271377, 5693.430656934273, 5763.135529670583, 5828.446297601721, 5877.764889404376, 5897.911531326948, 5505.532029777513, 5506.394296627288, 5512.200730893917, 5525.4474552544425, 5540.058190107772, 5560.666360018412, 5567.109262517978, 5613.635113717595, 5629.127485239795, 5652.915206271827, 5434.076207044733, 5520.558355331484, 5522.2544956430365, 5524.171374293888, 5568.081266590967, 5477.75350109238, 5494.928488944617, 5495.175723641486, 5495.505404513613, 5496.862578435571, 5212.687238765686, 5323.228131920927, 5324.9733751331, 5406.189071639285, 5457.399686034453, 5516.806911758069, 5558.666480011212, 5559.054960656617, 5603.8879222416135, 5607.186957891001, 5411.269478620336, 5428.511433970962, 5458.563314934875, 5459.454054594509, 5474.890502190014], "unit": "score", "name": "dojo.html", "value": 5183.979481585976}, {"lowerIsBetter": false, "replicates": [506.2482213912339, 518.458211169328, 521.7260938007547, 530.9097453432915, 549.170752164232, 27085.322866928338, 27620.447591048167, 34972.32790556993, 35457.82271088641, 35477.82261088691, 37939.24121517568, 38326.808365958204, 38423.0, 38474.615253847456, 38629.613703863026, 8325.958370208156, 8422.410431269813, 8424.326053915673, 8495.065542790318, 8520.233179013887, 8419.07390187079, 8533.232009119178, 8549.358798090137, 8552.871706924401, 8561.44350617211, 8768.0, 8824.0, 8842.159994800484, 8850.822983540325, 8851.77870553238, 8730.956345218297, 8751.34364922627, 8792.692255771017, 8821.691240806573, 8824.073472285414, 8550.486970781772, 8689.869651955225, 8697.347698922606, 8700.564971751388, 8706.129387061306, 38015.0, 38369.61630383688, 38485.23029539421, 38519.0, 38566.42150367747, 3367.747418943589, 3406.9148271293416, 3431.605365382963, 3566.661167189113, 3883.456316115746, 26955.595666065026, 27663.723362766315, 28192.85903570469, 29090.563641545396, 29192.562111568343, 3204.4712622417273, 3234.0, 3279.2785587171024, 3317.2204531934976, 3377.662233776627, 196947.0, 203837.0, 204502.0, 205280.0, 205299.0, 53041.0, 56880.0, 64872.35127648758, 66617.0, 66985.0, 61227.08159377613, 61379.693101534205, 61737.07394389088, 61738.382616173265, 61775.38224617786, 14731.410743570352, 15829.0, 15832.92083539598, 15847.603809904615, 15854.524364269091, 12216.20594661362, 12308.753824923631, 12340.691482712824, 12347.38263086842, 12359.50561977511, 20586.0, 20934.790652093285, 20944.581108377748, 20953.0, 21064.578708425746, 8067.298752566644, 8315.542645154575, 8315.8336833263, 8323.66705331792, 8447.704330348532, 1002.1882275356838, 1010.2120346130031, 1013.2755080117752, 1019.0573719309609, 1139.2879450343535, 29567.965121220655, 29581.85209073941, 29738.851305743334, 29941.700582994326, 32117.35765284728, 1031.9948400258102, 1069.7806949575318, 1071.3732466507024, 1085.625459216569, 1151.7120719820045, 14924.925375373054, 14946.918047863779, 15557.377704891678, 15567.688646227012, 15889.0, 363850.0, 367324.0, 371619.0, 371702.0, 372979.0, 50991.0, 51261.231081533806, 51349.48650513522, 51476.742616287425, 51660.22509662358, 1310.043668122257, 1325.8001508634702, 1326.3898606641053, 1333.0335506757524, 1460.306354481634, 29203.0, 30098.3980320388, 31679.84160079185, 32416.513752294206, 34095.48856767101, 49282.26076608782, 49947.0, 49950.0, 49961.0, 49980.500194997585, 263709.0, 278866.0, 389621.0, 395310.0, 397631.0, 40747.18505629811, 41043.384349235384, 41427.0, 41464.79267603643, 41626.1674766509, 44527.77736111299, 44559.10881782282, 44844.55155448534, 45149.54850451585, 45172.0, 36954.26091478209, 37284.62715372811, 37871.43192852165, 38384.0, 38876.6112338873, 37216.44175337426, 37347.439788402655, 37731.0, 37969.24061518699, 38142.80928595339, 33389.83305083459, 39424.21151576895, 39768.0, 40483.79758101191, 40609.59390406176, 28892.711072889004, 32714.672853271164, 33313.500297496044, 33350.33299334048, 33403.0, 25198.0, 25959.740402595733, 26383.34041648974, 27284.181474555797, 28010.89918256098], "unit": "score", "name": "ext.html", "value": 18727.919373396868}, {"lowerIsBetter": false, "replicates": [362.19773202356794, 364.56616626214804, 367.40663827917916, 370.6404787356265, 374.76577139287946, 13458.1925084495, 13628.114172578775, 15744.212789360528, 16477.0, 16903.830961690364, 14473.42106315746, 15417.383304667828, 15814.525564233092, 15824.604384890383, 15967.760483592727, 5205.661631993928, 5417.756200970965, 5425.050616142179, 5427.0, 5427.402985671573, 3990.1221731219084, 5322.148456247001, 5369.087255166631, 5653.180288858113, 5896.145058966447, 5947.553933454987, 6022.8494287642725, 6035.849103772397, 6085.604435711687, 6093.964026115549, 5732.627379220337, 5813.302403711539, 5871.853203669943, 5875.647461152324, 5969.820905372824, 5131.461196574343, 5150.819721309736, 5172.043172013189, 5263.815766448156, 5265.341832270966, 19120.61758764817, 19176.137073831713, 19266.32567860118, 19275.710864337045, 19653.901730491256, 2189.5511420158828, 2334.976650233493, 2520.823542352036, 2714.1586108306487, 2943.7792165587666, 12394.938025309906, 12492.375381230993, 12522.123451358408, 12767.680807979876, 12960.287184204864, 1773.866959977994, 1839.5217243516647, 1843.8524918006526, 1852.944411667652, 1879.6710575649206, 54345.456545434834, 55089.0, 55101.72449137729, 55225.171622425696, 55422.722886385716, 9498.477583732962, 9676.322657414054, 9843.557039933221, 9866.161376283097, 9927.851082233772, 12692.936535317449, 12872.420741066675, 12914.160579562486, 12921.741565168832, 12928.935355323163, 7476.588787616624, 7477.289657482531, 7527.548347099191, 7687.769366919001, 7693.807654808675, 7271.41828653717, 7276.96361518189, 7301.780946571611, 7315.122185337794, 7335.0, 5187.170052791535, 5866.882662346729, 5901.17383566301, 5920.230370051866, 5931.11033344993, 1666.4000959654516, 1731.3507434711983, 1763.1173032092365, 1769.938052168168, 1781.9376321828674, 949.6248981652209, 979.7011911367101, 991.0, 1069.8930106989394, 1123.7808627317595, 12216.694582635328, 15592.610184745472, 15735.763963540556, 16109.19454027294, 16163.43427980015, 921.3964853021282, 943.0, 949.0841338108759, 980.4558470049049, 981.239539357004, 8215.876761848576, 9211.0, 9466.621335146654, 10032.849507257397, 10074.647387341407, 476559.0, 515824.0, 516798.0, 520392.0, 537893.0, 67202.0, 73445.63277183687, 76765.61617191878, 78826.60586697144, 80205.19794801978, 500.07735727582553, 510.52521155325906, 512.8487096306599, 513.3941948500805, 514.8352527191338, 9833.704988850346, 10179.236557258384, 10272.845907311546, 10374.896251037393, 10502.949705029436, 30952.380952381278, 31201.0, 33862.66137338595, 34266.48600271048, 34922.82538587291, 42154.94612634709, 42720.0, 43001.354979675954, 43581.128377432906, 43719.0, 7415.962920185365, 7629.961850190713, 7637.312641862259, 7758.7672369829, 7824.256695613907, 10130.94934525352, 11847.111466640208, 11996.58011969577, 12042.157049006486, 12090.395480226129, 10239.48802559854, 10342.810576783766, 10464.790704186025, 10491.265611407129, 10542.8418573723, 10171.100761558426, 10231.755912848605, 10363.533640986023, 10486.94756526243, 10652.254342196282, 10185.541650625592, 10224.897751022394, 10520.0, 10536.420496872746, 10542.525586348786, 7667.386609071373, 7710.344620707303, 7752.7674169775, 7755.650995705094, 7760.379169666526, 7393.667284972082, 8737.781555461164, 9526.45686488644, 10245.74385640365, 10433.791324173322], "unit": "score", "name": "jquery.html", "value": 8125.014730077933}, {"lowerIsBetter": false, "replicates": [1302.719915218228, 1436.683929535502, 1454.4036944852612, 1593.3308010635533, 1771.2295151609044, 6719.260881303053, 7374.815629609262, 7533.397328213737, 7533.811654708635, 7557.433192510556, 7566.772996810091, 7712.730054448096, 7712.807179820507, 7717.228277172294, 7719.72980945667, 2001.4996250937265, 2056.722342483768, 2057.701633263176, 2310.445493081661, 2335.0776443304885, 2089.89550522474, 2291.5302363015544, 2347.5187586544803, 2352.752960939102, 2353.3881190890406, 2247.202243203664, 2283.6917016202765, 2292.862428254302, 2307.238611258289, 2307.4462129089065, 2170.1644866726265, 2179.193698331612, 2185.4317877351923, 2185.967210491844, 2331.9300420987397, 2172.6197915364905, 2173.413178441812, 2173.4349069241953, 2177.9782202177935, 2180.531185795062, 7737.8452430951065, 7754.9224507755325, 7762.408706215212, 7795.532268063877, 7801.726939557088, 4804.303376010494, 4880.877978050542, 4881.731504767236, 4884.3650325457465, 4913.484084171147, 3048.512238041925, 3069.109958112145, 3159.620845498555, 3162.509810979302, 3188.9681103188905, 934.3272843552631, 957.899420560845, 973.474323865112, 975.9609615615367, 982.1946004276496, 10895.455227238686, 10912.0, 10923.563057477691, 10932.672019839418, 10935.28920620157, 4388.100439409914, 4424.7123936944, 4476.395686582335, 4488.12481566098, 4489.820407183676, 9379.155875971195, 9382.48396338208, 9387.5306234688, 9409.529523523797, 9413.717588472357, 4891.682040667345, 4899.779509921991, 4903.141950158708, 4906.533879281463, 4908.312836202935, 4430.977845110754, 4435.622972047412, 4441.133978874089, 4442.400275962768, 4446.577575130357, 3471.4966329882027, 3594.299111673251, 3684.6315368463474, 3687.94468082979, 3742.2328422673286, 1204.6506513111099, 1208.6192849252457, 1209.498058305811, 1223.070466445508, 1230.7476967221698, 1039.7036844499282, 1056.498163372392, 1057.841323801436, 1209.5464200924653, 1353.3233383308345, 7279.308465695751, 7433.219511951275, 7435.219301973323, 7450.850982980419, 7464.85070298591, 1089.1824156332007, 1092.4919912240846, 1095.8904109588977, 1097.926691972774, 1099.7855418193376, 5850.23946886902, 5897.0269905465975, 5904.409559044061, 5905.055191169392, 5907.054871220584, 9020.368574199743, 9114.908850911539, 9659.420434773936, 9667.27495437845, 9769.120779129913, 9559.330846840794, 9579.521023948913, 9580.95209523948, 9657.951710241405, 9659.178969787507, 7345.853082938312, 7394.704211831467, 7548.924510754932, 7561.9243807562325, 7612.733554325572, 7300.12398512182, 7336.339729424378, 7341.3392794648735, 7352.4485663576515, 7364.374028207662, 8384.0, 8516.105808889977, 8617.267532259828, 8640.438371506083, 8804.86792698123, 8732.214100730966, 8870.822583548423, 8909.821803563762, 8917.063708310794, 8932.86600701003, 6704.966475167593, 6795.3204679531655, 6813.148356455443, 6822.351876571718, 6835.760748373783, 6711.932880671131, 6866.279040700654, 7251.311125443074, 7390.667419966222, 7633.389328853789, 7140.892886606601, 7229.7469588564145, 7252.38354739853, 7287.092638155223, 7304.488685791944, 7145.17830449505, 7172.892406613801, 7184.13790345141, 7201.747938822116, 7236.38490728273, 6961.477889158435, 7233.276672332725, 7276.30875066889, 7277.163126240338, 7287.781366559012, 6565.048068030013, 6608.43828274602, 6608.570442921387, 6612.107365505595, 6624.701888414937, 6644.767433139817, 6669.166354205724, 6681.098051763144, 6687.09724187248, 6687.799366019027], "unit": "score", "name": "mootools.html", "value": 4521.649463811143}, {"lowerIsBetter": false, "replicates": [317.46348670746437, 341.7812599936041, 343.03948942959704, 343.5998306899386, 350.6843840543509, 5745.224394706714, 5884.911726324103, 5911.615744976579, 5914.970425147879, 5950.613210141349, 5686.0, 5809.7385617647205, 5812.4768770810615, 5820.912686309709, 5836.124581312794, 4569.086182763453, 4578.793954272066, 4582.221022426179, 4607.7004994675235, 4612.8385506507275, 4399.714018588797, 4443.400140980974, 4586.931196032062, 4598.8620341389815, 4626.768661566925, 4555.817767289304, 4561.749103799306, 4568.086382723452, 4577.748223847687, 4583.1062942726185, 4564.269716845305, 4576.0161565263625, 4585.518520555327, 4587.816487340502, 4594.632429405639, 4012.1574469361467, 4053.797310134511, 4055.188962207541, 4055.655269302113, 4062.6952978526433, 5488.121900495901, 5598.608097433182, 5626.015447296707, 5664.716764161817, 5677.40387259336, 5304.045271851065, 5311.389190243094, 5318.468153184651, 5320.866978325535, 5321.547668448186, 5940.079287710412, 6293.874122517524, 6294.842628934268, 6299.748010079591, 6303.180586523768, 4371.388005679208, 4454.933176002362, 4462.709923854939, 4501.977490112561, 4520.660950428731, 6468.644224567647, 6520.739170433177, 6521.15225020749, 6529.804105876831, 6538.150040494753, 4590.931136032962, 4592.3800286961505, 4595.4025976622825, 4595.977020114878, 4596.954030459719, 4512.684112112186, 4650.0, 4653.162430762495, 4660.114578230193, 4687.296905464208, 5301.257823904656, 5307.946920530822, 5310.60170487215, 5314.601404894648, 5319.175527793198, 6315.305316415191, 6318.273398559225, 6327.557071004985, 6337.873242535124, 6338.049292606146, 1627.1376170629585, 1649.686559553681, 1649.892756970793, 1650.306871114135, 1650.8596769274745, 1117.53063713239, 1122.1639878290562, 1129.9039581635652, 1133.7505748735266, 1158.1603337580186, 5923.644581325134, 5943.5839491236065, 5947.881042379128, 5948.970255148696, 5950.19672344228, 6456.967715161488, 6464.0627109069865, 6473.708683109271, 6476.870462590722, 6477.935220647827, 5830.8542286442325, 5911.408859114054, 5953.315368732565, 5961.731722072517, 5968.432998865101, 3402.3705614461405, 3458.6714262145056, 3474.6351633078666, 3501.9824900875333, 3504.123969007748, 6708.6310252936555, 6719.865602687919, 6754.155730533684, 6758.594484330956, 6760.932390676128, 6586.6377349245295, 6591.571547849375, 6595.703193356215, 6600.405963463311, 6612.636305003175, 6538.509611779135, 6708.664566771642, 6725.8654826903185, 6734.696938637773, 6743.157105361928, 6230.501559875109, 6385.489160867027, 6422.582532135583, 6434.871302574016, 6498.642574658439, 6410.423061924449, 6438.034294855809, 6442.226932768098, 6446.806595802133, 6451.645159516272, 6775.796726098225, 6783.491238157059, 6787.524873258824, 6788.898166527407, 6801.149856267966, 4442.511323754449, 4542.250528662866, 4545.159145558082, 4550.6359491239955, 4551.795169217327, 6493.8701225976165, 6511.088447617432, 6511.576747511396, 6517.185351831021, 6523.804285871432, 6316.778912738032, 6328.715207815567, 6335.493160547053, 6340.682965851781, 6342.143810585512, 6166.414190651881, 6320.778772742932, 6325.652089135142, 6326.114343991753, 6329.841753956188, 6217.782377616762, 6220.533459990428, 6221.9377806223165, 6223.657698826608, 6230.408111229426, 6351.745930162741, 6355.110284560073, 6360.840978975562, 6360.968195158995, 6375.107484952203, 6072.787452439144, 6171.783987560414, 6179.474744646755, 6234.2830574484515, 6238.220222472191], "unit": "score", "name": "prototype.html", "value": 4775.066305231269}, {"lowerIsBetter": false, "replicates": [705.717712914834, 724.6050902258269, 787.5707739282091, 812.2851890336503, 814.588632740466, 12399.0, 12489.313087780169, 12512.686167952359, 12526.874731252685, 12535.373231338443, 12945.482180712761, 14270.357833897473, 14827.0, 14852.55442336729, 14862.108273503598, 668.7291646882995, 819.2503858969036, 829.7759604906671, 832.0306842528447, 832.966681332749, 681.4310051107307, 810.4367464612097, 826.7395770332326, 826.9545175015372, 828.3456069704926, 861.2679222660751, 868.4181598329135, 868.8392647360226, 869.2741560796711, 869.4696235296495, 694.402813580323, 860.3031544448985, 863.2532859076916, 871.825634873028, 883.9204471597587, 628.6353914729445, 630.9148264984215, 631.3465563142172, 631.987360252797, 632.317097534666, 13330.666733331647, 13423.194608323533, 13444.86555134446, 13510.121842080332, 13516.729665406638, 12590.937045314806, 12811.615651530376, 12901.419436125398, 12940.870591294155, 13150.736985260337, 9865.11213990737, 9884.505774711308, 9930.702078937644, 10454.895451045468, 10923.726906827313, 3691.280200360931, 3741.4387841823673, 3771.9434208486896, 3793.7534060285993, 3865.4588357629955, 49199.26201106986, 49594.50405495971, 49641.510754677416, 50043.0, 50080.74959625215, 9980.251481138943, 9986.101250887456, 10142.695719128438, 10254.692359229235, 10700.946495267473, 19170.233190672217, 19177.0, 19178.232870685297, 19185.0, 19201.903990479957, 7390.593517356597, 7466.552006879605, 7609.239076092457, 7722.961385193151, 7746.806329841686, 4334.046509767846, 4346.956530434719, 4381.3427985801745, 4384.210842048462, 4446.577575130357, 3156.4160630283013, 3182.5226216067313, 3193.0420873737785, 3199.0, 3202.759793015533, 578.9160571717077, 590.2326974932571, 599.9130126131773, 606.0364021206215, 608.6256951974503, 604.7671646416161, 635.2313700422541, 675.7972608217614, 695.8295217671703, 706.7950294414665, 7858.44990850635, 7881.960590197013, 7924.286814186751, 8124.187581241947, 8124.959375203086, 572.6621293436892, 608.2913405882186, 650.8437974885993, 656.1306269193337, 710.2471380336859, 3831.8658846940225, 3913.3934240192816, 3928.4696565963227, 4048.3725022621543, 4057.776822274744, 53368.73315633475, 54152.72923635357, 54377.1843422349, 54505.45494545083, 54861.0, 46865.5313446868, 47938.280925786145, 48226.27660585094, 48261.75869120702, 48300.5169948296, 43438.13123737508, 44342.11315773666, 44566.55433445689, 44720.77639611846, 44826.55173448289, 7619.4285428594185, 7828.765137045898, 8405.537695426565, 8546.615402306787, 8557.015943166616, 32259.0, 32286.515702264016, 32393.352132956737, 32915.83542082274, 33855.66144338525, 40338.798306008284, 40996.59003410047, 41056.178876421705, 41470.0, 41569.1686166281, 10598.15214782831, 10691.679249622524, 11013.559457621606, 11046.281991670516, 11213.215074944676, 12059.15585908978, 12265.57070502528, 12313.507459701512, 12420.0, 12650.430730617329, 11189.776204476027, 11195.552177913118, 11418.486168122288, 11476.942615286871, 11722.94138529302, 11099.944500277446, 11280.0, 11555.711107222387, 11635.41822908868, 11738.90892380849, 8336.583170841312, 10077.596896124072, 10081.445520496443, 10712.73218169552, 11002.394868282321, 7307.671154798153, 8029.0, 8169.183081691784, 8913.039131391084, 9259.861102083609, 9289.581968811284, 9328.813423731623, 9345.579448924678, 9349.672761453316, 9491.762705932408], "unit": "score", "name": "yui.html", "value": 6225.129729499011}], "name": "dromaeo_css", "value": 6879.760920830497}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 110.0, 113.0, 110.0, 100.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [160.0, 124.0, 149.0, 184.0, 127.0, 154.0, 154.0, 126.0, 165.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 159.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 95.0, 93.0, 72.0, 77.0, 75.0, 130.0, 98.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 97.0, 96.0, 96.0, 140.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 144.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 55.0, 55.0, 65.0, 55.0, 64.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 85.0, 92.0, 85.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [126.0, 115.0, 117.0, 115.0, 114.0, 115.0, 117.0, 124.0, 127.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [143.0, 146.0, 150.0, 154.0, 141.0, 141.0, 151.0, 160.0, 153.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 71.0, 67.0, 69.0, 67.0, 74.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1516.6999999999998}]} 05:19:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1516.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6879.76"}}} 05:19:47 INFO - Return code: 0 05:19:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:19:48 INFO - # TBPL SUCCESS # 05:19:48 INFO - Running post-action listener: _resource_record_post_action 05:19:48 INFO - Running post-run listener: _resource_record_post_run 05:19:49 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 540327936; Read time: 0; Write time: 382920 05:19:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 241184768; Read time: 0; Write time: 194748 05:19:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 299143168; Read time: 0; Write time: 188172 05:19:49 INFO - Running post-run listener: _upload_blobber_files 05:19:49 INFO - Blob upload gear active. 05:19:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:19:49 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:19:49 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:19:49 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:19:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:50 INFO - (blobuploader) - INFO - Done attempting. 05:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:51 INFO - (blobuploader) - INFO - Done attempting. 05:19:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:19:51 INFO - Return code: 0 05:19:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:19:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:19:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0665c374a351db60d2a11e2462220e5cfb0d75cb1511e994c7a565c144077207e6cf68a78a44c391ecb8b2ae64067c242945ded8d2c1caf879178808a3c20f99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32ec7b4e94cecc1331a421c07b07f22f2b0377cb978200a32714a6f8005877e2799286ceeccd9f3a842d511f6d20e2e876010d32ca6c68e4e02d4655d57f5083"} 05:19:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:19:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:19:51 INFO - Contents: 05:19:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0665c374a351db60d2a11e2462220e5cfb0d75cb1511e994c7a565c144077207e6cf68a78a44c391ecb8b2ae64067c242945ded8d2c1caf879178808a3c20f99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32ec7b4e94cecc1331a421c07b07f22f2b0377cb978200a32714a6f8005877e2799286ceeccd9f3a842d511f6d20e2e876010d32ca6c68e4e02d4655d57f5083"} 05:19:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:19:51 INFO - Copying logs to upload dir... 05:19:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:19:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.861326 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-09 05:19:50.806597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:19:50.810189) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0665c374a351db60d2a11e2462220e5cfb0d75cb1511e994c7a565c144077207e6cf68a78a44c391ecb8b2ae64067c242945ded8d2c1caf879178808a3c20f99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32ec7b4e94cecc1331a421c07b07f22f2b0377cb978200a32714a6f8005877e2799286ceeccd9f3a842d511f6d20e2e876010d32ca6c68e4e02d4655d57f5083"} build_url:https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/Kjlm9HFPRIWHYQTH9OLfhw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0665c374a351db60d2a11e2462220e5cfb0d75cb1511e994c7a565c144077207e6cf68a78a44c391ecb8b2ae64067c242945ded8d2c1caf879178808a3c20f99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32ec7b4e94cecc1331a421c07b07f22f2b0377cb978200a32714a6f8005877e2799286ceeccd9f3a842d511f6d20e2e876010d32ca6c68e4e02d4655d57f5083"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:19:50.835835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:19:50.836218) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455021989.724564-204825248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:19:50.919311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:19:50.919705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:19:50.920056) ========= ========= Total master_lag: 0.30 =========