builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1455433438.76 results: success (0) buildid: 20160213203426 builduid: 5b64ddbf85ce4002b39c22db648c0e08 revision: 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.761505) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.761925) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.762200) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.798540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.798854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.823301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.823556) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.875940) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.876208) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.876560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:58.876820) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-13 23:03:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 62.8M=0s 2016-02-13 23:03:59 (62.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108604 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.005293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.005625) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.116766 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.133334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.133633) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b --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 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b --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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-13 23:03:59,309 truncating revision to first 12 chars 2016-02-13 23:03:59,309 Setting DEBUG logging. 2016-02-13 23:03:59,309 attempt 1/10 2016-02-13 23:03:59,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29246bfbc091?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-13 23:03:59,572 unpacking tar archive at: fx-team-29246bfbc091/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.720991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.721383) ========= echo 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b'] 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b program finished with exit code 0 elapsedTime=0.003566 script_repo_revision: '29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.769288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.769554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 23:03:59.780745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-13 23:03:59.781007) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:04:00 INFO - MultiFileLogger online at 20160213 23:04:00 in /builds/slave/test-pgo 23:04:00 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 23:04:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:04:00 INFO - {'append_to_log': False, 23:04:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:04:00 INFO - 'blob_upload_branch': 'Fx-Team', 23:04:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:04:00 INFO - 'branch': 'Fx-Team', 23:04:00 INFO - 'buildbot_json_path': 'buildprops.json', 23:04:00 INFO - 'config_files': ('talos/linux_config.py',), 23:04:00 INFO - 'default_actions': ('clobber', 23:04:00 INFO - 'read-buildbot-config', 23:04:00 INFO - 'download-and-extract', 23:04:00 INFO - 'populate-webroot', 23:04:00 INFO - 'create-virtualenv', 23:04:00 INFO - 'install', 23:04:00 INFO - 'run-tests'), 23:04:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:04:00 INFO - 'download_minidump_stackwalk': True, 23:04:00 INFO - 'download_symbols': 'ondemand', 23:04:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:04:00 INFO - 'tooltool.py': '/tools/tooltool.py', 23:04:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:04:00 INFO - '/tools/misc-python/virtualenv.py')}, 23:04:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:04:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:04:00 INFO - 'installer_path': 'installer.exe', 23:04:00 INFO - 'log_level': 'info', 23:04:00 INFO - 'log_name': 'talos', 23:04:00 INFO - 'log_to_console': True, 23:04:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:04:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:04:00 INFO - 'opt_config_files': (), 23:04:00 INFO - 'pip_index': False, 23:04:00 INFO - 'sps_profile': False, 23:04:00 INFO - 'sps_profile_interval': 0, 23:04:00 INFO - 'suite': 'dromaeojs', 23:04:00 INFO - 'system_bits': '32', 23:04:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:04:00 INFO - 'title': 'talos-linux64-ix-007', 23:04:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:04:00 INFO - 'use_talos_json': True, 23:04:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:04:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:04:00 INFO - 'work_dir': 'build'} 23:04:00 INFO - ##### 23:04:00 INFO - ##### Running clobber step. 23:04:00 INFO - ##### 23:04:00 INFO - Running pre-action listener: _resource_record_pre_action 23:04:00 INFO - Running main action method: clobber 23:04:00 INFO - rmtree: /builds/slave/test-pgo/build 23:04:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:04:04 INFO - Running post-action listener: _resource_record_post_action 23:04:04 INFO - ##### 23:04:04 INFO - ##### Running read-buildbot-config step. 23:04:04 INFO - ##### 23:04:04 INFO - Running pre-action listener: _resource_record_pre_action 23:04:04 INFO - Running main action method: read_buildbot_config 23:04:04 INFO - Using buildbot properties: 23:04:04 INFO - { 23:04:04 INFO - "project": "", 23:04:04 INFO - "product": "firefox", 23:04:04 INFO - "script_repo_revision": "production", 23:04:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:04:04 INFO - "repository": "", 23:04:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:04:04 INFO - "buildid": "20160213203426", 23:04:04 INFO - "pgo_build": "True", 23:04:04 INFO - "basedir": "/builds/slave/test-pgo", 23:04:04 INFO - "buildnumber": 642, 23:04:04 INFO - "slavename": "talos-linux64-ix-007", 23:04:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:04:04 INFO - "platform": "ubuntu64_hw", 23:04:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:04:04 INFO - "branch": "fx-team", 23:04:04 INFO - "repo_path": "integration/fx-team", 23:04:04 INFO - "revision": "29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b", 23:04:04 INFO - "stage_platform": "linux64-pgo", 23:04:04 INFO - "builduid": "5b64ddbf85ce4002b39c22db648c0e08", 23:04:04 INFO - "slavebuilddir": "test" 23:04:04 INFO - } 23:04:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 23:04:04 INFO - Running post-action listener: _resource_record_post_action 23:04:04 INFO - ##### 23:04:04 INFO - ##### Running download-and-extract step. 23:04:04 INFO - ##### 23:04:04 INFO - Running pre-action listener: _resource_record_pre_action 23:04:04 INFO - Running main action method: download_and_extract 23:04:04 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:04:04 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')]} 23:04:04 INFO - https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:04:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/test_packages.json 23:04:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/test_packages.json 23:04:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:04:08 INFO - Downloaded 1448 bytes. 23:04:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:04:08 INFO - Using the following test package requirements: 23:04:08 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:08 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:04:08 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:04:08 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'jsshell-linux-x86_64.zip'], 23:04:08 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:04:08 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:08 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:04:08 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:04:08 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:04:08 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:08 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:04:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:04:08 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')]} 23:04:08 INFO - https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:12 INFO - Downloaded 23296063 bytes. 23:04:12 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'] 23:04:12 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 23:04:13 INFO - Return code: 0 23:04:13 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 23:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:13 INFO - https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:04:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:04:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:14 INFO - Downloaded 23296063 bytes. 23:04:14 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'] 23:04:14 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 23:04:16 INFO - Return code: 0 23:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:16 INFO - https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:17 INFO - Downloaded 10707070 bytes. 23:04:17 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'] 23:04:17 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 23:04:17 INFO - Return code: 0 23:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:17 INFO - https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSGyDYauTEKQ-57mRykseg/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 23:04:19 INFO - Downloaded 56530886 bytes. 23:04:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:04:19 INFO - mkdir: /builds/slave/test-pgo/properties 23:04:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:04:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:04:19 INFO - Contents: 23:04:19 INFO - build_url:https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:04:20 INFO - Running post-action listener: _resource_record_post_action 23:04:20 INFO - Running post-action listener: set_extra_try_arguments 23:04:20 INFO - ##### 23:04:20 INFO - ##### Running populate-webroot step. 23:04:20 INFO - ##### 23:04:20 INFO - Running pre-action listener: _resource_record_pre_action 23:04:20 INFO - Running main action method: populate_webroot 23:04:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:04:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:04:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:04:20 INFO - '--tppagecycles', 23:04:20 INFO - '7'], 23:04:20 INFO - 'tests': ['tsvgm']}}, 23:04:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:04:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:04:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:04:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:04:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:04:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:04:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'tests': ['damp', 'tps']}, 23:04:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['damp', 'tps']}, 23:04:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:04:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:04:20 INFO - 'other': {'tests': ['a11yr', 23:04:20 INFO - 'ts_paint', 23:04:20 INFO - 'tpaint', 23:04:20 INFO - 'sessionrestore', 23:04:20 INFO - 'sessionrestore_no_auto_restore']}, 23:04:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['a11yr', 23:04:20 INFO - 'ts_paint', 23:04:20 INFO - 'tpaint', 23:04:20 INFO - 'sessionrestore', 23:04:20 INFO - 'sessionrestore_no_auto_restore']}, 23:04:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['a11yr', 23:04:20 INFO - 'ts_paint', 23:04:20 INFO - 'tpaint', 23:04:20 INFO - 'sessionrestore', 23:04:20 INFO - 'sessionrestore_no_auto_restore']}, 23:04:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['a11yr', 23:04:20 INFO - 'ts_paint', 23:04:20 INFO - 'tpaint', 23:04:20 INFO - 'sessionrestore', 23:04:20 INFO - 'sessionrestore_no_auto_restore']}, 23:04:20 INFO - 'other_l64': {'tests': ['a11yr', 23:04:20 INFO - 'ts_paint', 23:04:20 INFO - 'tpaint', 23:04:20 INFO - 'sessionrestore', 23:04:20 INFO - 'sessionrestore_no_auto_restore']}, 23:04:20 INFO - 'other_nol64': {'tests': ['a11yr', 23:04:20 INFO - 'ts_paint', 23:04:20 INFO - 'tpaint', 23:04:20 INFO - 'sessionrestore', 23:04:20 INFO - 'sessionrestore_no_auto_restore']}, 23:04:20 INFO - 'svgr': {'tests': ['tsvgx', 23:04:20 INFO - 'tsvgr_opacity', 23:04:20 INFO - 'tart', 23:04:20 INFO - 'tscrollx', 23:04:20 INFO - 'cart']}, 23:04:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['tsvgx', 23:04:20 INFO - 'tsvgr_opacity', 23:04:20 INFO - 'tart', 23:04:20 INFO - 'tscrollx', 23:04:20 INFO - 'cart']}, 23:04:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'tests': ['tp5o']}, 23:04:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'talos_options': ['--e10s'], 23:04:20 INFO - 'tests': ['tp5o']}, 23:04:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'talos_options': ['--xperf_path', 23:04:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:04:20 INFO - 'tests': ['tp5n']}, 23:04:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:20 INFO - 'talos_options': ['--e10s', 23:04:20 INFO - '--xperf_path', 23:04:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:04:20 INFO - 'tests': ['tp5n']}}, 23:04:20 INFO - 'talos.zip': {'path': '', 23:04:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:04:20 INFO - Running post-action listener: _resource_record_post_action 23:04:20 INFO - ##### 23:04:20 INFO - ##### Running create-virtualenv step. 23:04:20 INFO - ##### 23:04:20 INFO - Running pre-action listener: _resource_record_pre_action 23:04:20 INFO - Running main action method: create_virtualenv 23:04:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:04:20 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 23:04:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:04:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:04:20 INFO - Using real prefix '/usr' 23:04:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:04:20 INFO - Installing distribute.............................................................................................................................................................................................done. 23:04:22 INFO - Installing pip.................done. 23:04:22 INFO - Return code: 0 23:04:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:04:22 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')]} 23:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:22 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')]} 23:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:22 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:22 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 23:04:22 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 23:04:22 INFO - Using env: {'DISPLAY': ':0', 23:04:22 INFO - 'HOME': '/home/cltbld', 23:04:22 INFO - 'LANG': 'en_US.UTF-8', 23:04:22 INFO - 'LANGUAGE': 'en_US:en', 23:04:22 INFO - 'LOGNAME': 'cltbld', 23:04:22 INFO - 'MAIL': '/var/mail/cltbld', 23:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:22 INFO - 'MOZ_NO_REMOTE': '1', 23:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:22 INFO - 'NO_EM_RESTART': '1', 23:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:22 INFO - 'SHELL': '/bin/bash', 23:04:22 INFO - 'SHLVL': '1', 23:04:22 INFO - 'TERM': 'linux', 23:04:22 INFO - 'TMOUT': '86400', 23:04:22 INFO - 'USER': 'cltbld', 23:04:22 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:22 INFO - '_': '/tools/buildbot/bin/python'} 23:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:22 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 23:04:22 INFO - Cleaning up... 23:04:22 INFO - Return code: 0 23:04:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:04:22 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')]} 23:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:22 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')]} 23:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:22 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:22 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 23:04:22 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 23:04:22 INFO - Using env: {'DISPLAY': ':0', 23:04:22 INFO - 'HOME': '/home/cltbld', 23:04:22 INFO - 'LANG': 'en_US.UTF-8', 23:04:22 INFO - 'LANGUAGE': 'en_US:en', 23:04:22 INFO - 'LOGNAME': 'cltbld', 23:04:22 INFO - 'MAIL': '/var/mail/cltbld', 23:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:22 INFO - 'MOZ_NO_REMOTE': '1', 23:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:22 INFO - 'NO_EM_RESTART': '1', 23:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:22 INFO - 'SHELL': '/bin/bash', 23:04:22 INFO - 'SHLVL': '1', 23:04:22 INFO - 'TERM': 'linux', 23:04:22 INFO - 'TMOUT': '86400', 23:04:22 INFO - 'USER': 'cltbld', 23:04:22 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:22 INFO - '_': '/tools/buildbot/bin/python'} 23:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:23 INFO - Downloading/unpacking psutil>=0.7.1 23:04:23 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 23:04:23 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 23:04:23 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 23:04:23 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 23:04:23 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 23:04:23 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 23:04:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:04:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:04:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:04:24 INFO - Installing collected packages: psutil 23:04:24 INFO - Running setup.py install for psutil 23:04:25 INFO - building 'psutil._psutil_linux' extension 23:04:25 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 23:04:25 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 23:04:25 INFO - building 'psutil._psutil_posix' extension 23:04:25 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 23:04:25 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 23:04:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:04:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:04:25 INFO - Successfully installed psutil 23:04:25 INFO - Cleaning up... 23:04:25 INFO - Return code: 0 23:04:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:04: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')]} 23:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04: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')]} 23:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:25 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:25 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 23:04:25 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 23:04:25 INFO - Using env: {'DISPLAY': ':0', 23:04:25 INFO - 'HOME': '/home/cltbld', 23:04:25 INFO - 'LANG': 'en_US.UTF-8', 23:04:25 INFO - 'LANGUAGE': 'en_US:en', 23:04:25 INFO - 'LOGNAME': 'cltbld', 23:04:25 INFO - 'MAIL': '/var/mail/cltbld', 23:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:25 INFO - 'MOZ_NO_REMOTE': '1', 23:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:25 INFO - 'NO_EM_RESTART': '1', 23:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:25 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:25 INFO - 'SHELL': '/bin/bash', 23:04:25 INFO - 'SHLVL': '1', 23:04:25 INFO - 'TERM': 'linux', 23:04:25 INFO - 'TMOUT': '86400', 23:04:25 INFO - 'USER': 'cltbld', 23:04:25 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:25 INFO - '_': '/tools/buildbot/bin/python'} 23:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:04:25 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 23:04:25 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 23:04:25 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 23:04:25 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 23:04:25 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 23:04:25 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 23:04:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:04:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:04:27 INFO - Installing collected packages: mozsystemmonitor 23:04:27 INFO - Running setup.py install for mozsystemmonitor 23:04:27 INFO - Successfully installed mozsystemmonitor 23:04:27 INFO - Cleaning up... 23:04:27 INFO - Return code: 0 23:04:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:27 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:27 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 23:04:27 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 23:04:27 INFO - Using env: {'DISPLAY': ':0', 23:04:27 INFO - 'HOME': '/home/cltbld', 23:04:27 INFO - 'LANG': 'en_US.UTF-8', 23:04:27 INFO - 'LANGUAGE': 'en_US:en', 23:04:27 INFO - 'LOGNAME': 'cltbld', 23:04:27 INFO - 'MAIL': '/var/mail/cltbld', 23:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:27 INFO - 'MOZ_NO_REMOTE': '1', 23:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:27 INFO - 'NO_EM_RESTART': '1', 23:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:27 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:27 INFO - 'SHELL': '/bin/bash', 23:04:27 INFO - 'SHLVL': '1', 23:04:27 INFO - 'TERM': 'linux', 23:04:27 INFO - 'TMOUT': '86400', 23:04:27 INFO - 'USER': 'cltbld', 23:04:27 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:27 INFO - '_': '/tools/buildbot/bin/python'} 23:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:27 INFO - Downloading/unpacking blobuploader==1.2.4 23:04:27 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 23:04:27 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 23:04:27 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 23:04:27 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 23:04:27 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 23:04:27 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 23:04:29 INFO - Downloading blobuploader-1.2.4.tar.gz 23:04:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:04:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:04:29 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 23:04:29 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 23:04:29 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 23:04:29 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 23:04:29 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 23:04:29 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 23:04:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:04:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:04:30 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 23:04:30 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 23:04:30 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 23:04:30 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 23:04:30 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 23:04:30 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 23:04:30 INFO - Downloading docopt-0.6.1.tar.gz 23:04:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:04:30 INFO - Installing collected packages: blobuploader, requests, docopt 23:04:30 INFO - Running setup.py install for blobuploader 23:04:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:04:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:04:30 INFO - Running setup.py install for requests 23:04:31 INFO - Running setup.py install for docopt 23:04:31 INFO - Successfully installed blobuploader requests docopt 23:04:31 INFO - Cleaning up... 23:04:31 INFO - Return code: 0 23:04:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:04: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')]} 23:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04: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')]} 23:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:31 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:31 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 23:04:31 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 23:04:31 INFO - Using env: {'DISPLAY': ':0', 23:04:31 INFO - 'HOME': '/home/cltbld', 23:04:31 INFO - 'LANG': 'en_US.UTF-8', 23:04:31 INFO - 'LANGUAGE': 'en_US:en', 23:04:31 INFO - 'LOGNAME': 'cltbld', 23:04:31 INFO - 'MAIL': '/var/mail/cltbld', 23:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:31 INFO - 'MOZ_NO_REMOTE': '1', 23:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:31 INFO - 'NO_EM_RESTART': '1', 23:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:31 INFO - 'SHELL': '/bin/bash', 23:04:31 INFO - 'SHLVL': '1', 23:04:31 INFO - 'TERM': 'linux', 23:04:31 INFO - 'TMOUT': '86400', 23:04:31 INFO - 'USER': 'cltbld', 23:04:31 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:31 INFO - '_': '/tools/buildbot/bin/python'} 23:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:04:31 INFO - Running setup.py (path:/tmp/pip-whClNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:04:31 INFO - Running setup.py (path:/tmp/pip-G7W2bM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:04:31 INFO - Running setup.py (path:/tmp/pip-EWrNWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:04:31 INFO - Running setup.py (path:/tmp/pip-y1DVjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:04:31 INFO - Running setup.py (path:/tmp/pip-zgM7ij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:04:31 INFO - Running setup.py (path:/tmp/pip-gJb3ja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:04:31 INFO - Running setup.py (path:/tmp/pip-noJP0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:04:31 INFO - Running setup.py (path:/tmp/pip-tEM0iN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:04:31 INFO - Running setup.py (path:/tmp/pip-A8OPit-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:04:32 INFO - Running setup.py (path:/tmp/pip-FHGQTO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:04:32 INFO - Running setup.py (path:/tmp/pip-vjmIZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:04:32 INFO - Running setup.py (path:/tmp/pip-0by0Sn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:04:32 INFO - Running setup.py (path:/tmp/pip-kzCeZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:04:32 INFO - Running setup.py (path:/tmp/pip-moQRcg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:04:32 INFO - Running setup.py (path:/tmp/pip-uPxnei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:04:32 INFO - Running setup.py (path:/tmp/pip-QWB6Wz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:04:32 INFO - Running setup.py (path:/tmp/pip-qfy8qq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:04:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:04:32 INFO - Running setup.py install for manifestparser 23:04:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:04:32 INFO - Running setup.py install for mozcrash 23:04:32 INFO - Running setup.py install for mozdebug 23:04:32 INFO - Running setup.py install for mozdevice 23:04:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:04:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:04:32 INFO - Running setup.py install for mozfile 23:04:33 INFO - Running setup.py install for mozhttpd 23:04:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Running setup.py install for mozinfo 23:04:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Running setup.py install for mozInstall 23:04:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Running setup.py install for mozleak 23:04:33 INFO - Running setup.py install for mozlog 23:04:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Running setup.py install for moznetwork 23:04:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Running setup.py install for mozprocess 23:04:33 INFO - Running setup.py install for mozprofile 23:04:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:04:33 INFO - Running setup.py install for mozrunner 23:04:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:04:34 INFO - Running setup.py install for mozscreenshot 23:04:34 INFO - Running setup.py install for moztest 23:04:34 INFO - Running setup.py install for mozversion 23:04:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:04:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:04:34 INFO - Cleaning up... 23:04:34 INFO - Return code: 0 23:04:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:04:34 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')]} 23:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:34 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')]} 23:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:34 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:34 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 23:04:34 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 23:04:34 INFO - Using env: {'DISPLAY': ':0', 23:04:34 INFO - 'HOME': '/home/cltbld', 23:04:34 INFO - 'LANG': 'en_US.UTF-8', 23:04:34 INFO - 'LANGUAGE': 'en_US:en', 23:04:34 INFO - 'LOGNAME': 'cltbld', 23:04:34 INFO - 'MAIL': '/var/mail/cltbld', 23:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:34 INFO - 'MOZ_NO_REMOTE': '1', 23:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:34 INFO - 'NO_EM_RESTART': '1', 23:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:34 INFO - 'SHELL': '/bin/bash', 23:04:34 INFO - 'SHLVL': '1', 23:04:34 INFO - 'TERM': 'linux', 23:04:34 INFO - 'TMOUT': '86400', 23:04:34 INFO - 'USER': 'cltbld', 23:04:34 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:34 INFO - '_': '/tools/buildbot/bin/python'} 23:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:04:34 INFO - Running setup.py (path:/tmp/pip-R1Try6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:04:34 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)) 23:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:04:34 INFO - Running setup.py (path:/tmp/pip-y8xeVc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:04:34 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)) 23:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:04:34 INFO - Running setup.py (path:/tmp/pip-LBIhNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:04:34 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)) 23:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:04:34 INFO - Running setup.py (path:/tmp/pip-a3GDQt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:04:34 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)) 23:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:04:34 INFO - Running setup.py (path:/tmp/pip-yy5THf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:04:34 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)) 23:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:04:34 INFO - Running setup.py (path:/tmp/pip-cQaOUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:04:35 INFO - Running setup.py (path:/tmp/pip-lqxtdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:04:35 INFO - Running setup.py (path:/tmp/pip-8OEx43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:04:35 INFO - Running setup.py (path:/tmp/pip-wWRHCV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:04:35 INFO - Running setup.py (path:/tmp/pip-A31erm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:04:35 INFO - Running setup.py (path:/tmp/pip-kSledJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:04:35 INFO - Running setup.py (path:/tmp/pip-7ICYeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:04:35 INFO - Running setup.py (path:/tmp/pip-H72OKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:04:35 INFO - Running setup.py (path:/tmp/pip-TlB8EF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:04:35 INFO - Running setup.py (path:/tmp/pip-D3jpkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:04:35 INFO - Running setup.py (path:/tmp/pip-qEIEKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:04:35 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)) 23:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:04:35 INFO - Running setup.py (path:/tmp/pip-k3Kh4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:04:35 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)) 23:04:35 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)) 23:04:35 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)) 23:04:35 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)) 23:04:35 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)) 23:04:35 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)) 23:04:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:37 INFO - Downloading blessings-1.6.tar.gz 23:04:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:04:37 INFO - Installing collected packages: blessings 23:04:37 INFO - Running setup.py install for blessings 23:04:37 INFO - Successfully installed blessings 23:04:37 INFO - Cleaning up... 23:04:37 INFO - Return code: 0 23:04:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:04:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:04:38 INFO - Reading from file tmpfile_stdout 23:04:38 INFO - Current package versions: 23:04:38 INFO - argparse == 1.2.1 23:04:38 INFO - blessings == 1.6 23:04:38 INFO - blobuploader == 1.2.4 23:04:38 INFO - docopt == 0.6.1 23:04:38 INFO - manifestparser == 1.1 23:04:38 INFO - mozInstall == 1.12 23:04:38 INFO - mozcrash == 0.16 23:04:38 INFO - mozdebug == 0.1 23:04:38 INFO - mozdevice == 0.48 23:04:38 INFO - mozfile == 1.2 23:04:38 INFO - mozhttpd == 0.7 23:04:38 INFO - mozinfo == 0.9 23:04:38 INFO - mozleak == 0.1 23:04:38 INFO - mozlog == 3.1 23:04:38 INFO - moznetwork == 0.27 23:04:38 INFO - mozprocess == 0.22 23:04:38 INFO - mozprofile == 0.28 23:04:38 INFO - mozrunner == 6.11 23:04:38 INFO - mozscreenshot == 0.1 23:04:38 INFO - mozsystemmonitor == 0.0 23:04:38 INFO - moztest == 0.7 23:04:38 INFO - mozversion == 1.4 23:04:38 INFO - psutil == 3.1.1 23:04:38 INFO - requests == 1.2.3 23:04:38 INFO - wsgiref == 0.1.2 23:04:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:38 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:38 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 23:04:38 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 23:04:38 INFO - Using env: {'DISPLAY': ':0', 23:04:38 INFO - 'HOME': '/home/cltbld', 23:04:38 INFO - 'LANG': 'en_US.UTF-8', 23:04:38 INFO - 'LANGUAGE': 'en_US:en', 23:04:38 INFO - 'LOGNAME': 'cltbld', 23:04:38 INFO - 'MAIL': '/var/mail/cltbld', 23:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:38 INFO - 'MOZ_NO_REMOTE': '1', 23:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:38 INFO - 'NO_EM_RESTART': '1', 23:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:38 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:38 INFO - 'SHELL': '/bin/bash', 23:04:38 INFO - 'SHLVL': '1', 23:04:38 INFO - 'TERM': 'linux', 23:04:38 INFO - 'TMOUT': '86400', 23:04:38 INFO - 'USER': 'cltbld', 23:04:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:38 INFO - '_': '/tools/buildbot/bin/python'} 23:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 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)) 23:04:38 INFO - Cleaning up... 23:04:38 INFO - Return code: 0 23:04:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:38 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:38 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 23:04:38 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 23:04:38 INFO - Using env: {'DISPLAY': ':0', 23:04:38 INFO - 'HOME': '/home/cltbld', 23:04:38 INFO - 'LANG': 'en_US.UTF-8', 23:04:38 INFO - 'LANGUAGE': 'en_US:en', 23:04:38 INFO - 'LOGNAME': 'cltbld', 23:04:38 INFO - 'MAIL': '/var/mail/cltbld', 23:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:38 INFO - 'MOZ_NO_REMOTE': '1', 23:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:38 INFO - 'NO_EM_RESTART': '1', 23:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:38 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:38 INFO - 'SHELL': '/bin/bash', 23:04:38 INFO - 'SHLVL': '1', 23:04:38 INFO - 'TERM': 'linux', 23:04:38 INFO - 'TMOUT': '86400', 23:04:38 INFO - 'USER': 'cltbld', 23:04:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:38 INFO - '_': '/tools/buildbot/bin/python'} 23:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:38 INFO - Downloading/unpacking jsonschema 23:04:38 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 23:04:38 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 23:04:38 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 23:04:38 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 23:04:38 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 23:04:38 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 23:04:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:04:40 INFO - Downloading/unpacking functools32 (from jsonschema) 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04:40 INFO - Downloading functools32-3.2.3-2.tar.gz 23:04:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:04:40 INFO - warning: no files found matching '*.txt' 23:04:40 INFO - no previously-included directories found matching 'build' 23:04:40 INFO - no previously-included directories found matching 'dist' 23:04:40 INFO - no previously-included directories found matching '.git*' 23:04:40 INFO - Installing collected packages: jsonschema, functools32 23:04:40 INFO - Running setup.py install for functools32 23:04:40 INFO - warning: no files found matching '*.txt' 23:04:40 INFO - no previously-included directories found matching 'build' 23:04:40 INFO - no previously-included directories found matching 'dist' 23:04:40 INFO - no previously-included directories found matching '.git*' 23:04:40 INFO - Successfully installed jsonschema functools32 23:04:40 INFO - Cleaning up... 23:04:40 INFO - Return code: 0 23:04:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:40 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 0x7f615dc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', '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 23:04:40 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 23:04:40 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 23:04:40 INFO - Using env: {'DISPLAY': ':0', 23:04:40 INFO - 'HOME': '/home/cltbld', 23:04:40 INFO - 'LANG': 'en_US.UTF-8', 23:04:40 INFO - 'LANGUAGE': 'en_US:en', 23:04:40 INFO - 'LOGNAME': 'cltbld', 23:04:40 INFO - 'MAIL': '/var/mail/cltbld', 23:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:40 INFO - 'MOZ_NO_REMOTE': '1', 23:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:40 INFO - 'NO_EM_RESTART': '1', 23:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:40 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:40 INFO - 'SHELL': '/bin/bash', 23:04:40 INFO - 'SHLVL': '1', 23:04:40 INFO - 'TERM': 'linux', 23:04:40 INFO - 'TMOUT': '86400', 23:04:40 INFO - 'USER': 'cltbld', 23:04:40 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:40 INFO - '_': '/tools/buildbot/bin/python'} 23:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:40 INFO - Downloading/unpacking flake8 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:04:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:04:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:04:43 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 23:04:43 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 23:04:43 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 23:04:43 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 23:04:43 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 23:04:43 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 23:04:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:04:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:04:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:04:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:04:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:04:43 INFO - no previously-included directories found matching 'docs/_build' 23:04:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:04:43 INFO - Running setup.py install for pep8 23:04:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:04:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:04:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:04:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:04:43 INFO - no previously-included directories found matching 'docs/_build' 23:04:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:04:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:04:43 INFO - Cleaning up... 23:04:43 INFO - Return code: 0 23:04:43 INFO - Running post-action listener: _resource_record_post_action 23:04:43 INFO - Running post-action listener: _start_resource_monitoring 23:04:43 INFO - Starting resource monitoring. 23:04:43 INFO - ##### 23:04:43 INFO - ##### Running install step. 23:04:43 INFO - ##### 23:04:43 INFO - Running pre-action listener: _resource_record_pre_action 23:04:43 INFO - Running main action method: install 23:04:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:04:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:04:43 INFO - Reading from file tmpfile_stdout 23:04:43 INFO - Detecting whether we're running mozinstall >=1.0... 23:04:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:04:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:04:43 INFO - Reading from file tmpfile_stdout 23:04:43 INFO - Output received: 23:04:43 INFO - Usage: mozinstall [options] installer 23:04:43 INFO - Options: 23:04:43 INFO - -h, --help show this help message and exit 23:04:43 INFO - -d DEST, --destination=DEST 23:04:43 INFO - Directory to install application into. [default: 23:04:43 INFO - "/builds/slave/test-pgo"] 23:04:43 INFO - --app=APP Application being installed. [default: firefox] 23:04:43 INFO - mkdir: /builds/slave/test-pgo/build/application 23:04:43 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'] 23:04:43 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 23:05:00 INFO - Reading from file tmpfile_stdout 23:05:00 INFO - Output received: 23:05:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:05:00 INFO - Running post-action listener: _resource_record_post_action 23:05:00 INFO - ##### 23:05:00 INFO - ##### Running run-tests step. 23:05:00 INFO - ##### 23:05:00 INFO - Running pre-action listener: _resource_record_pre_action 23:05:00 INFO - Running main action method: run_tests 23:05:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:05:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:05:00 INFO - Python 2.7.3 23:05:00 INFO - Return code: 0 23:05:00 INFO - grabbing minidump binary from tooltool 23:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:00 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 0xdf28c0>, '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 0xdf37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:05:00 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 23:05:00 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 23:05:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:05:00 INFO - Return code: 0 23:05:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:05:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:05:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:05:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:05:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:05:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:05:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:05:01 INFO - Return code: 0 23:05:01 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/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 23:05:01 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/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 23:05:01 INFO - Using env: {'DISPLAY': ':0', 23:05:01 INFO - 'HOME': '/home/cltbld', 23:05:01 INFO - 'LANG': 'en_US.UTF-8', 23:05:01 INFO - 'LANGUAGE': 'en_US:en', 23:05:01 INFO - 'LOGNAME': 'cltbld', 23:05:01 INFO - 'MAIL': '/var/mail/cltbld', 23:05:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:05:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:01 INFO - 'MOZ_NO_REMOTE': '1', 23:05:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:01 INFO - 'NO_EM_RESTART': '1', 23:05:01 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:01 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:01 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:05:01 INFO - 'SHELL': '/bin/bash', 23:05:01 INFO - 'SHLVL': '1', 23:05:01 INFO - 'TERM': 'linux', 23:05:01 INFO - 'TMOUT': '86400', 23:05:01 INFO - 'USER': 'cltbld', 23:05:01 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300', 23:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:01 INFO - '_': '/tools/buildbot/bin/python'} 23:05:01 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/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 23:05:01 INFO - mozversion application_buildid: 20160213203426 23:05:01 INFO - mozversion application_changeset: 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b 23:05:01 INFO - mozversion application_display_name: Nightly 23:05:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:05:01 INFO - mozversion application_name: Firefox 23:05:01 INFO - mozversion application_remotingname: firefox 23:05:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:05:01 INFO - mozversion application_vendor: Mozilla 23:05:01 INFO - mozversion application_version: 47.0a1 23:05:01 INFO - mozversion platform_buildid: 20160213203426 23:05:01 INFO - mozversion platform_changeset: 29246bfbc091ddfaaa6d53f0b1dfcf7da19a615b 23:05:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:05:01 INFO - mozversion platform_version: 47.0a1 23:05:01 INFO - using testdate: 1455433501 23:05:01 INFO - actual date: 1455433501 23:05:01 INFO - starting webserver on 'localhost:60257' 23:05:01 INFO - SUITE-START | Running 2 tests 23:05:01 INFO - TEST-START | dromaeo_css 23:05:01 INFO - operating with platform_type : linux_ 23:05:01 INFO - Initialising browser for dromaeo_css test... 23:05:01 INFO - TEST-INFO | started process 12778 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNCIPlY/profile http://localhost:60257/getInfo.html) 23:05:06 INFO - PROCESS | 12778 | __metrics Screen width/height:1600/1200 23:05:06 INFO - PROCESS | 12778 | colorDepth:24 23:05:06 INFO - PROCESS | 12778 | Browser inner width/height: 1024/697 23:05:06 INFO - PROCESS | 12778 | __metrics 23:05:07 INFO - PROCESS | 12778 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:05:08 INFO - TEST-INFO | 12778: exit 0 23:05:08 INFO - Browser initialized. 23:05:08 INFO - Running cycle 1/1 for dromaeo_css test... 23:05:08 INFO - TEST-INFO | started process 12876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNCIPlY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:20 INFO - PROCESS | 12876 | RSS: Main: 149774336 23:05:20 INFO - PROCESS | 12876 | 23:06:11 INFO - PROCESS | 12876 | 1455433571621 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] 23:08:19 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:60257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60257/tests/dromaeo/cssquery-ext.html) 23:08:20 INFO - PROCESS | 12876 | RSS: Main: 248770560 23:08:20 INFO - PROCESS | 12876 | 23:11:23 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:60257/tests/dromaeo/cssquery-ext.html (next: http://localhost:60257/tests/dromaeo/cssquery-jquery.html) 23:11:23 INFO - PROCESS | 12876 | RSS: Main: 234409984 23:11:23 INFO - PROCESS | 12876 | 23:14:25 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:60257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60257/tests/dromaeo/cssquery-mootools.html) 23:14:26 INFO - PROCESS | 12876 | RSS: Main: 229842944 23:14:26 INFO - PROCESS | 12876 | 23:17:28 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:60257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60257/tests/dromaeo/cssquery-prototype.html) 23:17:28 INFO - PROCESS | 12876 | RSS: Main: 214892544 23:17:28 INFO - PROCESS | 12876 | 23:20:31 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:60257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60257/tests/dromaeo/cssquery-yui.html) 23:20:31 INFO - PROCESS | 12876 | RSS: Main: 215986176 23:20:31 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:60257/tests/dromaeo/cssquery-yui.html (next: http://localhost:60257/tests/dromaeo/cssquery-dojo.html) 23:23:34 INFO - PROCESS | 12876 | RSS: Main: 271024128 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | __start_tp_report 23:23:34 INFO - PROCESS | 12876 | _x_x_mozilla_page_load 23:23:34 INFO - PROCESS | 12876 | _x_x_mozilla_page_load_details 23:23:34 INFO - PROCESS | 12876 | |i|pagename|runs| 23:23:34 INFO - PROCESS | 12876 | |0;dojo.html;3067.263856674399;3092.922676933077;3101.457244982129;3131.843407829608;3159.4313023655745;4948.7278199699;4964.280179373988;5014.623903207261;5030.496950304972;5061.089003979282;5019.64862459628;5113.51421614947;5125.000624878141;5220.112580861253;5223.033738758332;4605.539446055393;4623.075384923012;4623.468301145361;4655.953440465602;4694.694844835075;4688.789004494789;4716.669833111683;4723.574878260956;4741.312509686093;4743.881402964937;4614.238650622643;4615.053913947632;4695.812167513295;4719.362886010379;4727;4596.448426188878;4602.148602508513;4604.516525764813;4619.86140415788;4640.187967105777;4589.403377560929;4592.816287348502;4594.241950078266;4603.930941035887;4628.421447319085;4806.279058141306;4950.801967921278;4980.726060066695;5066.69599824008;5094;5442.374126975409;5481.890362192734;5489.451054894518;5492.81904390558;5495.230667706524;5494.587905907073;5509.228707980886;5516.475934786189;5527.834164975057;5533.00405926933;5117.667351622133;5137.717425541594;5152.768125434364;5172.637915345889;5211.270422140866;5668.291463567054;5670.943290567124;5671.574631902624;5673.886522269531;5685.60200785941;5216.921746173811;5287.841364759063;5437.8368648940595;5454.754536045887;5463.043967305705;5414.6480478769545;5433.347998240237;5462.317210348707;5463.207834864002;5519.889602207933;5455.8363249102595;5505.421930697299;5511.118221084607;5514.145307477347;5516.089845175501;5373.731313434313;5410.972945135328;5467.863303417446;5513.09034009384;5551.472610102034;4258.446401967724;4266.552012038691;4268.893277668021;4286.742795432284;4307.504636966726;3816.9427458588143;3833.9616603833606;3845.057960799622;3868.4390763339156;3882.437046628223;5014.874628134253;5079.1365467870555;5079.6698214615935;5140.691558506502;5173.405058418255;5449.782008719686;5466.988607107618;5488.807891723771;5490.835274941758;5500.972495137498;5100.642954993189;5126.769295381717;5132.204508301219;5134.024535338273;5167.948320516822;4593.150267200579;4709.458412282563;4741.40732408442;4744.596709279681;4745.857624271277;5620.241267428926;5655.321361436654;5657.195015477429;5663.801766938137;5729.28383952006;5390.487903649304;5470.480304371078;5471.534919531884;5478;5480.506754392124;5684.289463817023;5686.914696279477;5741.081426971665;5760.0783874579865;5799.362070172193;5283.049051170826;5336.973315133399;5341.813036543703;5344.331958505187;5377.08589539787;5447.128459446628;5453.727313634223;5454.699991500505;5518.917216241679;5548.0845660465575;5299.735013249399;5300.045991721528;5302.840914772563;5315.548178404724;5334.1732031535175;5258.921116183184;5293.364796224324;5296.947030529645;5306.761195746278;5343.091674415281;5209.244659524424;5232.947670523246;5233.895322093461;5241.213817927342;5331.840044798662;5371.597130215171;5372.221027951004;5382.30030096085;5388.811391601275;5428.402875683592;5253.054450199001;5257.369115706139;5258.447862974333;5271.973640131775;5279.709615971158 23:23:34 INFO - PROCESS | 12876 | |1;ext.html;510.67572091721746;529.7827890564869;576.4091805898954;583.3699604427219;584.4535359438925;28924.566131508018;36428;36510;36543.45184822226;36557.99999999996;40484;41060.58939410605;41080.17839643206;41100.58899411013;41141.79429102858;7494.475386722932;7636.312731854132;8513.148685131484;8763;8766.60550275236;10371.688849334532;10508.842367364496;10544;10549.47252637365;10649.09482693972;10057.094861462467;10132.493375331203;10143.239257055713;10144.49277536124;10226.795464090714;10312.535935882866;10327.690169294932;10351.896481035168;10362.222833287458;10386.117180039706;10309.896901030968;10480.68557943263;10505.474726263656;10507.527161277761;10582.470876456146;40708.79645601783;41197.176056479;41209.381859272136;41212.38181427281;41222.58777412218;3277.5083737439336;3432.5880894292595;3784.9810750946344;3910.608939106095;4147.8963025924295;30426.54360184599;30853.228669283224;31052.689473105205;31242.84378578115;31618.525722114187;3513.736469764752;3519.3137338219058;3543;3652.4156135018534;3738.831752571141;271226;273191;273412.999999998;274113;276783;61339.38660613426;61781.38218617846;61825.690871545354;62002.379976200566;62016.379836201966;58217.70891145602;66014;73528.63235683787;74935.62532187304;75081.6245918767;13021.609351719464;13035.543755968496;13059.934700326437;13108.672283192996;13386;10404.427756473468;10627.734306642396;10638.308509946983;10644.574217031386;10651.201159913038;20607.381778546667;20991.795861434635;21007.15971361159;21070;21076.89461552713;7880.842383152305;8003.878487389922;8152.347812175011;8215.301699355503;8238.464499807493;954.3844220477891;1010.5604062232952;1021.7854250607307;1028.5371582787775;1064.5635289531256;28278.15165545037;29008.709912901024;29172.416551668848;29254.707452925624;29362.412751744847;1010.4644538394663;1070.3791800755544;1136.3238872870793;1170.8770579089244;1208.0215025829107;15157.696846063238;16506.669866602842;16713.83286167147;16792.244349004322;16867.084495356845;383095;390237;392205;392930;393592;55861.72069139628;56415;56568;56580;56642;1333.7465881482487;1337.1776357540043;1341.7651910915552;1351.8918486521054;1352.8241328627216;29915.55126673145;30522.84738576293;30701.692983069883;30845.845770771004;31191.84404077965;44842.327365090205;47689.52310476851;48147.75926120347;48197.27704084512;48210;379928;384859;388707;388804;389164;32225.677743223205;32636.510452343708;32668.856590019237;32710.34579308353;32730.672693273715;43463.348049778644;43646.12707745891;43899.78050109729;43956;44787;37417;37817;38114;38828;38947.221055578164;37389.626103739705;37442.251154976206;37928.62071379251;38241.617583823805;38438;31521;35983.460248096824;36070.63929360673;36278;37015.25969480541;29118.854405727834;31875.52186717155;32164.839175803972;32281.838590806896;32389;24662.136825211033;27170.592441113004;27373.589396158673;27605.861970690017;27624 23:23:34 INFO - PROCESS | 12876 | |2;jquery.html;369.19515456305254;369.45136472338584;375.38811736868917;379.55591957409825;382.9597892221315;13726.107802992798;15225.467108651199;15981.280842362092;16696.74954875678;17262.568435789097;16289.104099274535;16600.58498537537;16753.329866805343;16838.158092095407;16852.74720879188;3817.9809100954594;4810.639202059842;5047.697138171721;5048.697078175322;5050.570701490377;5280.128778751501;5520.585956053292;5531.115021596545;5534.695591742453;5539.723013849311;5295.232191332255;5412.40334101441;5480.671159730409;5488.53347465466;5500.257465242201;5452.863678408032;5475.808346707866;5492.972535137339;5494.697791621459;5511.862203444906;5349.358077030781;5353.491418315254;5358.65168764033;5358.866028349284;5360.705161216131;19480.610387792163;19929.60140797176;20133.194672213092;20183.39449816508;20190;2044.8466365022682;2054.938351849447;2117.894105294729;2133.4133113393787;2666.2934322404576;9392.953035234848;9475.810483790285;9780.608775648965;9821.214302855755;12318.692032699255;1778.262021261175;1820.226403778402;1875.756151700284;1885.453218566614;1892.6120145370166;58335.70832145897;58914.705426473025;58951.41048589502;60575.69712151411;61108.694456527875;9812.705618831447;10259.333143345659;10273.897261027443;10278.486075696186;10329.74175645615;13484.12353197039;13551.66120846967;13622;13645.38595763193;13648.385822638005;6925.3074692530345;6946.6179360135675;6981.2669669684965;7014.789556313319;7080.575165490087;6166.506679465632;6224.1597384352535;6244.718987645567;6256.217972753406;6422.839429014312;4010.538788039413;4204.873853784391;4206.26390381682;4325.653947684178;4365.3670217818235;1742.6950283700303;1806.4490330449075;1838.3198216659655;1847.7967423583664;1919.3474218765407;931.5388882503204;947.1617618407621;975.3026585990908;993.3940296419179;1006.3911333643041;13307.600771976857;15184.468543601142;15876;16497.422590209284;16599.41902033423;894.9149830766066;956.2302346611045;958.6069711418285;975.7559112132088;1015.7917626886618;9432.434053956784;9585.089416505421;9616.90383096174;9618.663346782829;9767.462789546502;335554;338924;339043;356176;446982;44854.77572612116;44957.775211123735;46876.531234687216;70464.64767676129;74686;1104.8232282834708;1151.9308841469372;1157.7684463107412;1163.528770847808;1163.5578480177649;14706.117632942058;14923.701525969636;15025.924870375578;15132.243387830784;15287.15920624332;29959.400811984073;30416.695833041387;30571.388572227985;30780.53829192519;30887.536686950163;39584.802075989435;42013.789931051375;43496.13007739764;43636.56363436452;43778.124437510436;7484.550926944401;7555.508891922007;7575.318221360104;7625.1231108421025;7641.35048520882;9816.558254878404;11693.239939403911;11791.469383877575;11866.940665296619;12046.879531204575;9967.50162491887;10226.744331391776;10435.217358697977;10512.106470950055;10555.525001374803;9807.509624518603;9849.704508864745;9976.351537150353;10030.29787914839;10091.949540252252;9787.706368808947;10195.439250841275;10394.324368915995;10415.635452759117;10551.208659350426;7249;7396.556587666527;7399.557086368107;7465.925340746523;7726.18875018115;7847.646855891385;10058.748531286776;10130.240231982778;10177.134943529883;10227.181825454094 23:23:34 INFO - PROCESS | 12876 | |3;mootools.html;1354.803553484744;1487.7693957436597;1487.799147115139;1660.5433505785916;1807.1145138881943;6976.337247961442;7684.423668224885;7848.332891704198;7857.057153141617;7860.489068210562;7850.332721718646;8051.516908985465;8058.4359094863385;8059.758207253792;8074.232947869958;2028.1988614497266;2230.364346161344;2235.4299653588314;2316.05041932808;2330.976690233101;2255.5037891663806;2259.288324177887;2263.106073101124;2264.671622614728;2265.1279257485903;2246;2351.318117745852;2356.1164563288767;2356.1988923765916;2356.3637817789186;2293.896774645145;2324.0936034946385;2363.0429675981254;2364.6925899633025;2367.124164059292;2327.8719670418122;2358.1864256831363;2358.5872472317446;2361.315218586608;2367.3253122860074;7926.167752385974;7973.760787176394;7976.840463190703;7979;7987.480813747146;4917.459079501252;5029.773660185264;5053.545180933696;5061.746912654353;5063.620228482879;3089.598352214198;3089.9691003089906;3102.534619807047;3198.1524895902603;3243.8864639737494;1087.320424734541;1095.6155511850152;1103.2112039891435;1103.5034234594464;1122.3939072900623;11348.602798901999;11367.715807104805;11446.771064578745;11485.655430337103;11496.252743571724;4503.572160644799;4528;4555.043440877386;4556.589906908394;4586.678932474695;9827.656032038843;9828.164606008426;9830.21358291335;9832.901670983341;9869.11177993984;5033;5044.117279476077;5083.669561478492;5083.974580127076;5085.2372144177925;4592.908141837144;4600.7929643166135;4606.838760643362;4613.400257966443;4617.5382461754225;3504.369213541587;3681.7606855554304;3683.1160521474653;3714.0900479382185;3745.962540374616;1216.6167657187957;1227.1042139238227;1228.4349199368392;1229.6495498782983;1245.3524167432884;1331.7269959658247;1335.2255691698792;1359.4018631801976;1363.6250031241289;1381.7927310903244;7215.71137154508;7539.0576177977755;7689.154193038761;7695;7709.229077092358;1101.5373543111912;1114.6878873915316;1117.6367680503706;1129.4183495499824;1138.732397886496;5715.085586306171;5779.104238842986;5788.681622510802;5791.507721843691;5803.245578074908;9274;9317.254619630414;9537.332386732862;9638.469884156439;9663.661771837951;9765.951170244103;9778.706638800848;9779.266555008402;9787.706368808947;9798.412095274307;7217.711291548279;7305.269473052758;7320.597367144752;7375.778726638209;7515.286047825448;7352.926470735224;7442.404607631484;7443.925560744323;7448.590327532038;7466.589337586485;8223.671053157806;8227.79430514218;8376.87434688468;8382.413231073766;8520.19058189471;8221.79445513867;8456.2812160967;8541;8603.139686031596;8637.352198585006;6902.758403455855;7026.051483049723;7032.683529241299;7042.119735033121;7056.50604457683;6752.527323087336;7296.7810965671115;7494.700211991677;7502.549847009197;7529;6822.181338239443;6863.073485079451;6907.412869905913;7015.298470152944;7042.295770422917;6861.588304701734;6869.887143966036;6919.169699636076;6945.826354340979;6952.826179345557;6810.216825064983;6861.519693621399;6862.279460656559;6866.244713081457;6869.0383346330555;6195.535334849995;6271.717772700331;6274.937250627435;6296.181496405438;6296.937030629635;6518.641474718746;6527.11883895668;6549.7380104797185;6561.507886908596;6572.539922205399 23:23:34 INFO - PROCESS | 12876 | |4;prototype.html;333.8380885270643;339.4043453738688;344.0401280427607;350.8824543777834;356.96608822161903;5749.108888122338;5900.911486327708;5926.081457374108;5935.050391937291;5959.851003724909;5753.395893431192;5812.767489300423;5822.126680997852;5833.620814647055;5834.358220595731;4595.425571803533;4597.540245975392;4598.908021839561;4603.148417542749;4614.353990441341;4394.4067550880545;4525.977370113162;4556.3621093047;4557.498675145748;4597.586217240448;4495.325701144838;4587.449506059261;4593.379893714339;4595.103954728829;4614.031053478773;4585;4588.128255631436;4589.426321709786;4593.265077587604;4605.424321959755;4071.307877660805;4071.3282308419075;4073.6537394321517;4083.3670781028986;4083.836646534135;5575.609707320489;5618.662880227159;5646.745896434671;5659.660420374749;5664.150377443375;5334.946650533484;5347.786088556492;5348.304720386363;5352.090144675414;5358.303420555342;6024.518038556905;6275.843103922392;6276.905846412307;6280.560360774748;6283.057541368786;4388.341748737683;4470.351798989161;4531.365608814768;4536.8865778355475;4540.77296135192;6545.312742162052;6572.112764776742;6574.079628851964;6580.967095164541;6584.242812076624;4633.536646335339;4641.814327426932;4645.233536466513;4647.651426143053;4647.837325693585;4377.934330985037;4488.079943611552;4508.752018638941;4693.272542755878;4702.905941881211;5243.161094224905;5246.186841039645;5246.947530524722;5249.868753281122;5258.947410525922;6314.052892066226;6366;6366.331535188831;6379.936200638027;6409.294977552466;1562.53124062783;1591.4270862489495;1593.139704559525;1596.8722502199796;1600.8799340049543;1045.4772613693153;1056.5509658395151;1058.5289546152042;1062.4103622489438;1091.912646988239;5954.851128721816;6001.459868611846;6006.099085137177;6013.398660134039;6014.278286605635;6497;6499.155109835786;6503.447206987459;6504.577202481823;6507.642079685568;5980.970095149583;5984.760609575568;5987.6108052976415;5993.130996005555;5993.430624090704;3428.468587368962;3511.455724362728;3513.1217195701074;3536.8938931832085;3544.468329750558;6876.381125698711;6880.449564034965;6880.931190688029;6896.206936202401;6903.378695917391;6736.124303840469;6743.291954344723;6743.460523158135;6755.2906944771075;6762.323767623198;6661.866762664719;6884.105066341343;6885.1049363582415;6901.309869013159;6909.2399836019;6280.7487700491465;6412.519061070531;6552.180977377828;6569.4744420447205;6576.967115164393;6502.60984340941;6518.315576864361;6521.380468855451;6526.67366631657;6538.934610653832;6816.522843400914;6841.350071743176;6863.10779598669;6864.48516361265;6876.621785801629;4341.630961368192;4393.692441529062;4425.645948324191;4435.645148388056;4444;6471.611703297817;6483.805485835433;6511.641859697762;6522.608643481406;6525.836854078686;6349.936500634934;6357.141785859035;6367.649779261999;6373.904391434225;6379.393957574023;6203.906941395792;6359.586626869239;6364.204474440695;6364.968175159094;6366.64983425916;6262.749490020348;6265.373462653881;6266;6268.373162683695;6274.874502509833;6355.237371515448;6355.396237357444;6393.968030159819;6410.551261411843;6419.325970773189;6068.757249709962;6222.097795819672;6265.530085243534;6273.96863015682;6278.717457714322 23:23:34 INFO - PROCESS | 12876 | |5;yui.html;716.3946465236874;756.1644382956832;757.3524636435848;799.8960135182425;813.5240884082812;13448.731025379499;13718.176909385444;13740;13743.725125497484;13751.518696845613;12916.677083072927;12964.611061668165;12966.416511256992;12976.05359196121;12991.805122923164;670.4636290967206;677.2381071294793;798.5967086621278;806.7378102116807;817.6606708216083;815.747118393297;817.2113910076774;823.1398188892591;823.6705317872838;824.11819353292;861.7027125641675;862.9266512346458;864.3646919514152;865.35098675993;866.1598249697784;704.2992222738383;710.5097482736921;711.9822004449878;713.1834050012758;859.5702148925537;610.4536439886322;623.5884316351231;623.9719212635397;625.0249610607467;626.6396821827467;13385.73228535424;13414.329283535882;13438.932805336008;13449.529266475627;13463.798043029363;12503.687407814787;12815.487380504768;12857.935710321388;12893.290869002201;13271;10400.167986561057;10596.682099537025;10707.089897358734;11240.269382490113;11401.828972565418;3614.150674591469;3655.95805195518;3669.21111960927;3716.1824398632257;3833.9424908626393;45748.54251457476;46676.066478670575;50449;50736.49263507391;50874.236886446735;10183.134433573081;10231.94884025575;10365.326253793479;10415.479226038668;10818.24272300947;18442.07789610541;18750.718739218923;18754.718679219823;18785.624287514172;18799;7632.961835190788;7799.610019499116;7841.490303130278;7853.607319633996;7923.722669706648;4299.527052024275;4324.17840610283;4340.739555626673;4368.148211098869;4423.623991960655;3239.6760323967414;3247;3262.5758651375168;3278.164068162603;3282.983585082059;598.0670154558815;607.0499668019623;609.5306613907355;625.4621025917708;627.6736097229415;499.2261993909426;519.9480051994846;637.2926052082186;665.4643012374988;688.9276625954303;8503.574821258911;8634.395592308603;8734.781630459162;8739.082396348293;9714.174295184846;567.957403194762;634.9301576826546;646.6734299178885;669.4577392312243;725.0465637686531;3830.272248272819;3882.417637354363;4012.578679238696;4027.453576281241;4156.937645935313;51274.23088653673;52449.737751311;52659.47340526546;52910;53341.46658533443;47781;48633.756831215615;49375.753121234164;49521.25718114231;49738.50261497411;44099;44346;44487;44621.77689111534;44667.32999005017;8040.67837286502;8049.678012879419;8206.507609543207;8325.500469971821;8414.368922330726;33558.66441335653;33692.83153584216;33768;34604.65395346115;35140.12149696278;42826.14347713091;42854.142917142104;43207.567924320356;43985.78007109944;44153;10735.409552474688;10905.618303359344;10937.83593246118;10974.396408197306;11634.6509604712;12115.75768484643;12129.818052729039;12481.251124932533;12566.434510446868;12619.558315458915;10969.396683182502;11656.592019279284;11889.524419023142;11955.880441195824;12069.215500992408;11360.53848555888;11672.182947193614;11710.355930423568;11734.647960561197;12138.211016283913;11498.195126341076;11867.525298988288;11899.405029748652;11935.283882967049;12265.202761820454;9533.380330278509;9938.602455901972;10092.596296148073;10191.133753630727;10196.847047294445;8728.258098061737;8865.601047952987;9215.953920230357;10269.281150319406;10317.432541210006 23:23:34 INFO - PROCESS | 12876 | __end_tp_report 23:23:34 INFO - PROCESS | 12876 | __start_cc_report 23:23:34 INFO - PROCESS | 12876 | _x_x_mozilla_cycle_collect,771 23:23:34 INFO - PROCESS | 12876 | __end_cc_report 23:23:34 INFO - PROCESS | 12876 | __startTimestamp1455434614903__endTimestamp 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | ------- Summary: start ------- 23:23:34 INFO - PROCESS | 12876 | Number of tests: 6 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | [#0] dojo.html Cycles:165 Average:5086.22 Median:5258.45 stddev:552.52 (10.5%) stddev-sans-first:531.03 23:23:34 INFO - PROCESS | 12876 | Values: 3067.3 3092.9 3101.5 3131.8 3159.4 4948.7 4964.3 5014.6 5030.5 5061.1 5019.6 5113.5 5125.0 5220.1 5223.0 4605.5 4623.1 4623.5 4656.0 4694.7 4688.8 4716.7 4723.6 4741.3 4743.9 4614.2 4615.1 4695.8 4719.4 4727.0 4596.4 4602.1 4604.5 4619.9 4640.2 4589.4 4592.8 4594.2 4603.9 4628.4 4806.3 4950.8 4980.7 5066.7 5094.0 5442.4 5481.9 5489.5 5492.8 5495.2 5494.6 5509.2 5516.5 5527.8 5533.0 5117.7 5137.7 5152.8 5172.6 5211.3 5668.3 5670.9 5671.6 5673.9 5685.6 5216.9 5287.8 5437.8 5454.8 5463.0 5414.6 5433.3 5462.3 5463.2 5519.9 5455.8 5505.4 5511.1 5514.1 5516.1 5373.7 5411.0 5467.9 5513.1 5551.5 4258.4 4266.6 4268.9 4286.7 4307.5 3816.9 3834.0 3845.1 3868.4 3882.4 5014.9 5079.1 5079.7 5140.7 5173.4 5449.8 5467.0 5488.8 5490.8 5501.0 5100.6 5126.8 5132.2 5134.0 5167.9 4593.2 4709.5 4741.4 4744.6 4745.9 5620.2 5655.3 5657.2 5663.8 5729.3 5390.5 5470.5 5471.5 5478.0 5480.5 5684.3 5686.9 5741.1 5760.1 5799.4 5283.0 5337.0 5341.8 5344.3 5377.1 5447.1 5453.7 5454.7 5518.9 5548.1 5299.7 5300.0 5302.8 5315.5 5334.2 5258.9 5293.4 5296.9 5306.8 5343.1 5209.2 5232.9 5233.9 5241.2 5331.8 5371.6 5372.2 5382.3 5388.8 5428.4 5253.1 5257.4 5258.4 5272.0 5279.7 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | [#1] ext.html Cycles:180 Average:51947.67 Median:18004.09 stddev:93264.55 (518.0%) stddev-sans-first:93446.22 23:23:34 INFO - PROCESS | 12876 | Values: 510.7 529.8 576.4 583.4 584.5 28924.6 36428.0 36510.0 36543.5 36558.0 40484.0 41060.6 41080.2 41100.6 41141.8 7494.5 7636.3 8513.1 8763.0 8766.6 10371.7 10508.8 10544.0 10549.5 10649.1 10057.1 10132.5 10143.2 10144.5 10226.8 10312.5 10327.7 10351.9 10362.2 10386.1 10309.9 10480.7 10505.5 10507.5 10582.5 40708.8 41197.2 41209.4 41212.4 41222.6 3277.5 3432.6 3785.0 3910.6 4147.9 30426.5 30853.2 31052.7 31242.8 31618.5 3513.7 3519.3 3543.0 3652.4 3738.8 271226.0 273191.0 273413.0 274113.0 276783.0 61339.4 61781.4 61825.7 62002.4 62016.4 58217.7 66014.0 73528.6 74935.6 75081.6 13021.6 13035.5 13059.9 13108.7 13386.0 10404.4 10627.7 10638.3 10644.6 10651.2 20607.4 20991.8 21007.2 21070.0 21076.9 7880.8 8003.9 8152.3 8215.3 8238.5 954.4 1010.6 1021.8 1028.5 1064.6 28278.2 29008.7 29172.4 29254.7 29362.4 1010.5 1070.4 1136.3 1170.9 1208.0 15157.7 16506.7 16713.8 16792.2 16867.1 383095.0 390237.0 392205.0 392930.0 393592.0 55861.7 56415.0 56568.0 56580.0 56642.0 1333.7 1337.2 1341.8 1351.9 1352.8 29915.6 30522.8 30701.7 30845.8 31191.8 44842.3 47689.5 48147.8 48197.3 48210.0 379928.0 384859.0 388707.0 388804.0 389164.0 32225.7 32636.5 32668.9 32710.3 32730.7 43463.3 43646.1 43899.8 43956.0 44787.0 37417.0 37817.0 38114.0 38828.0 38947.2 37389.6 37442.3 37928.6 38241.6 38438.0 31521.0 35983.5 36070.6 36278.0 37015.3 29118.9 31875.5 32164.8 32281.8 32389.0 24662.1 27170.6 27373.6 27605.9 27624.0 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | [#2] jquery.html Cycles:180 Average:22189.68 Median:21797.67 stddev:59917.82 (274.9%) stddev-sans-first:60063.51 23:23:34 INFO - PROCESS | 12876 | Values: 369.2 369.5 375.4 379.6 383.0 13726.1 15225.5 15981.3 16696.7 17262.6 16289.1 16600.6 16753.3 16838.2 16852.7 3818.0 4810.6 5047.7 5048.7 5050.6 5280.1 5520.6 5531.1 5534.7 5539.7 5295.2 5412.4 5480.7 5488.5 5500.3 5452.9 5475.8 5493.0 5494.7 5511.9 5349.4 5353.5 5358.7 5358.9 5360.7 19480.6 19929.6 20133.2 20183.4 20190.0 2044.8 2054.9 2117.9 2133.4 2666.3 9393.0 9475.8 9780.6 9821.2 12318.7 1778.3 1820.2 1875.8 1885.5 1892.6 58335.7 58914.7 58951.4 60575.7 61108.7 9812.7 10259.3 10273.9 10278.5 10329.7 13484.1 13551.7 13622.0 13645.4 13648.4 6925.3 6946.6 6981.3 7014.8 7080.6 6166.5 6224.2 6244.7 6256.2 6422.8 4010.5 4204.9 4206.3 4325.7 4365.4 1742.7 1806.4 1838.3 1847.8 1919.3 931.5 947.2 975.3 993.4 1006.4 13307.6 15184.5 15876.0 16497.4 16599.4 894.9 956.2 958.6 975.8 1015.8 9432.4 9585.1 9616.9 9618.7 9767.5 335554.0 338924.0 339043.0 356176.0 446982.0 44854.8 44957.8 46876.5 70464.6 74686.0 1104.8 1151.9 1157.8 1163.5 1163.6 14706.1 14923.7 15025.9 15132.2 15287.2 29959.4 30416.7 30571.4 30780.5 30887.5 39584.8 42013.8 43496.1 43636.6 43778.1 7484.6 7555.5 7575.3 7625.1 7641.4 9816.6 11693.2 11791.5 11866.9 12046.9 9967.5 10226.7 10435.2 10512.1 10555.5 9807.5 9849.7 9976.4 10030.3 10091.9 9787.7 10195.4 10394.3 10415.6 10551.2 7249.0 7396.6 7399.6 7465.9 7726.2 7847.6 10058.7 10130.2 10177.1 10227.2 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | [#3] mootools.html Cycles:180 Average:5580.64 Median:6233.63 stddev:2888.33 (46.3%) stddev-sans-first:2878.96 23:23:34 INFO - PROCESS | 12876 | Values: 1354.8 1487.8 1487.8 1660.5 1807.1 6976.3 7684.4 7848.3 7857.1 7860.5 7850.3 8051.5 8058.4 8059.8 8074.2 2028.2 2230.4 2235.4 2316.1 2331.0 2255.5 2259.3 2263.1 2264.7 2265.1 2246.0 2351.3 2356.1 2356.2 2356.4 2293.9 2324.1 2363.0 2364.7 2367.1 2327.9 2358.2 2358.6 2361.3 2367.3 7926.2 7973.8 7976.8 7979.0 7987.5 4917.5 5029.8 5053.5 5061.7 5063.6 3089.6 3090.0 3102.5 3198.2 3243.9 1087.3 1095.6 1103.2 1103.5 1122.4 11348.6 11367.7 11446.8 11485.7 11496.3 4503.6 4528.0 4555.0 4556.6 4586.7 9827.7 9828.2 9830.2 9832.9 9869.1 5033.0 5044.1 5083.7 5084.0 5085.2 4592.9 4600.8 4606.8 4613.4 4617.5 3504.4 3681.8 3683.1 3714.1 3746.0 1216.6 1227.1 1228.4 1229.6 1245.4 1331.7 1335.2 1359.4 1363.6 1381.8 7215.7 7539.1 7689.2 7695.0 7709.2 1101.5 1114.7 1117.6 1129.4 1138.7 5715.1 5779.1 5788.7 5791.5 5803.2 9274.0 9317.3 9537.3 9638.5 9663.7 9766.0 9778.7 9779.3 9787.7 9798.4 7217.7 7305.3 7320.6 7375.8 7515.3 7352.9 7442.4 7443.9 7448.6 7466.6 8223.7 8227.8 8376.9 8382.4 8520.2 8221.8 8456.3 8541.0 8603.1 8637.4 6902.8 7026.1 7032.7 7042.1 7056.5 6752.5 7296.8 7494.7 7502.5 7529.0 6822.2 6863.1 6907.4 7015.3 7042.3 6861.6 6869.9 6919.2 6945.8 6952.8 6810.2 6861.5 6862.3 6866.2 6869.0 6195.5 6271.7 6274.9 6296.2 6296.9 6518.6 6527.1 6549.7 6561.5 6572.5 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | [#4] prototype.html Cycles:180 Average:5305.03 Median:5970.41 stddev:1596.84 (26.7%) stddev-sans-first:1557.12 23:23:34 INFO - PROCESS | 12876 | Values: 333.8 339.4 344.0 350.9 357.0 5749.1 5900.9 5926.1 5935.1 5959.9 5753.4 5812.8 5822.1 5833.6 5834.4 4595.4 4597.5 4598.9 4603.1 4614.4 4394.4 4526.0 4556.4 4557.5 4597.6 4495.3 4587.4 4593.4 4595.1 4614.0 4585.0 4588.1 4589.4 4593.3 4605.4 4071.3 4071.3 4073.7 4083.4 4083.8 5575.6 5618.7 5646.7 5659.7 5664.2 5334.9 5347.8 5348.3 5352.1 5358.3 6024.5 6275.8 6276.9 6280.6 6283.1 4388.3 4470.4 4531.4 4536.9 4540.8 6545.3 6572.1 6574.1 6581.0 6584.2 4633.5 4641.8 4645.2 4647.7 4647.8 4377.9 4488.1 4508.8 4693.3 4702.9 5243.2 5246.2 5246.9 5249.9 5258.9 6314.1 6366.0 6366.3 6379.9 6409.3 1562.5 1591.4 1593.1 1596.9 1600.9 1045.5 1056.6 1058.5 1062.4 1091.9 5954.9 6001.5 6006.1 6013.4 6014.3 6497.0 6499.2 6503.4 6504.6 6507.6 5981.0 5984.8 5987.6 5993.1 5993.4 3428.5 3511.5 3513.1 3536.9 3544.5 6876.4 6880.4 6880.9 6896.2 6903.4 6736.1 6743.3 6743.5 6755.3 6762.3 6661.9 6884.1 6885.1 6901.3 6909.2 6280.7 6412.5 6552.2 6569.5 6577.0 6502.6 6518.3 6521.4 6526.7 6538.9 6816.5 6841.4 6863.1 6864.5 6876.6 4341.6 4393.7 4425.6 4435.6 4444.0 6471.6 6483.8 6511.6 6522.6 6525.8 6349.9 6357.1 6367.6 6373.9 6379.4 6203.9 6359.6 6364.2 6365.0 6366.6 6262.7 6265.4 6266.0 6268.4 6274.9 6355.2 6355.4 6394.0 6410.6 6419.3 6068.8 6222.1 6265.5 6274.0 6278.7 23:23:34 INFO - PROCESS | 12876 | 23:23:34 INFO - PROCESS | 12876 | [#5] yui.html Cycles:180 Average:13616.15 Median:4354.44 stddev:15263.44 (350.5%) stddev-sans-first:15275.52 23:23:34 INFO - PROCESS | 12876 | Values: 716.4 756.2 757.4 799.9 813.5 13448.7 13718.2 13740.0 13743.7 13751.5 12916.7 12964.6 12966.4 12976.1 12991.8 670.5 677.2 798.6 806.7 817.7 815.7 817.2 823.1 823.7 824.1 861.7 862.9 864.4 865.4 866.2 704.3 710.5 712.0 713.2 859.6 610.5 623.6 624.0 625.0 626.6 13385.7 13414.3 13438.9 13449.5 13463.8 12503.7 12815.5 12857.9 12893.3 13271.0 10400.2 10596.7 10707.1 11240.3 11401.8 3614.2 3656.0 3669.2 3716.2 3833.9 45748.5 46676.1 50449.0 50736.5 50874.2 10183.1 10231.9 10365.3 10415.5 10818.2 18442.1 18750.7 18754.7 18785.6 18799.0 7633.0 7799.6 7841.5 7853.6 7923.7 4299.5 4324.2 4340.7 4368.1 4423.6 3239.7 3247.0 3262.6 3278.2 3283.0 598.1 607.0 609.5 625.5 627.7 499.2 519.9 637.3 665.5 688.9 8503.6 8634.4 8734.8 8739.1 9714.2 568.0 634.9 646.7 669.5 725.0 3830.3 3882.4 4012.6 4027.5 4156.9 51274.2 52449.7 52659.5 52910.0 53341.5 47781.0 48633.8 49375.8 49521.3 49738.5 44099.0 44346.0 44487.0 44621.8 44667.3 8040.7 8049.7 8206.5 8325.5 8414.4 33558.7 33692.8 33768.0 34604.7 35140.1 42826.1 42854.1 43207.6 43985.8 44153.0 10735.4 10905.6 10937.8 10974.4 11634.7 12115.8 12129.8 12481.3 12566.4 12619.6 10969.4 11656.6 11889.5 11955.9 12069.2 11360.5 11672.2 11710.4 11734.6 12138.2 11498.2 11867.5 11899.4 11935.3 12265.2 9533.4 9938.6 10092.6 10191.1 10196.8 8728.3 8865.6 9216.0 10269.3 10317.4 23:23:34 INFO - PROCESS | 12876 | -------- Summary: end -------- 23:23:34 INFO - PROCESS | 12876 | 23:23:35 INFO - TEST-INFO | 12876: exit 0 23:23:35 INFO - TEST-OK | dromaeo_css | took 1114046ms 23:23:35 INFO - TEST-START | kraken 23:23:35 INFO - operating with platform_type : linux_ 23:23:35 INFO - Initialising browser for kraken test... 23:23:35 INFO - TEST-INFO | started process 13070 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9TFFZw/profile http://localhost:60257/getInfo.html) 23:23:40 INFO - PROCESS | 13070 | __metrics Screen width/height:1600/1200 23:23:40 INFO - PROCESS | 13070 | colorDepth:24 23:23:40 INFO - PROCESS | 13070 | Browser inner width/height: 1024/697 23:23:40 INFO - PROCESS | 13070 | __metrics 23:23:41 INFO - PROCESS | 13070 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:23:41 INFO - TEST-INFO | 13070: exit 0 23:23:41 INFO - Browser initialized. 23:23:41 INFO - Running cycle 1/1 for kraken test... 23:23:41 INFO - TEST-INFO | started process 13155 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9TFFZw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:53 INFO - PROCESS | 13155 | RSS: Main: 150134784 23:23:53 INFO - PROCESS | 13155 | 23:23:56 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60257/tests/kraken/driver.html?testName=audio-beat-detection) 23:23:56 INFO - PROCESS | 13155 | RSS: Main: 194633728 23:23:56 INFO - PROCESS | 13155 | 23:23:59 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60257/tests/kraken/driver.html?testName=audio-dft) 23:24:00 INFO - PROCESS | 13155 | RSS: Main: 185257984 23:24:00 INFO - PROCESS | 13155 | 23:24:03 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60257/tests/kraken/driver.html?testName=audio-fft) 23:24:03 INFO - PROCESS | 13155 | RSS: Main: 165904384 23:24:03 INFO - PROCESS | 13155 | 23:24:05 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60257/tests/kraken/driver.html?testName=audio-oscillator) 23:24:06 INFO - PROCESS | 13155 | RSS: Main: 167071744 23:24:06 INFO - PROCESS | 13155 | 23:24:08 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:24:08 INFO - PROCESS | 13155 | RSS: Main: 170582016 23:24:08 INFO - PROCESS | 13155 | 23:24:11 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60257/tests/kraken/driver.html?testName=imaging-darkroom) 23:24:12 INFO - PROCESS | 13155 | RSS: Main: 168841216 23:24:12 INFO - PROCESS | 13155 | 23:24:15 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60257/tests/kraken/driver.html?testName=imaging-desaturate) 23:24:16 INFO - PROCESS | 13155 | RSS: Main: 171618304 23:24:16 INFO - PROCESS | 13155 | 23:24:19 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60257/tests/kraken/driver.html?testName=json-parse-financial) 23:24:19 INFO - PROCESS | 13155 | RSS: Main: 170897408 23:24:19 INFO - PROCESS | 13155 | 23:24:21 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:24:22 INFO - PROCESS | 13155 | RSS: Main: 185421824 23:24:22 INFO - PROCESS | 13155 | 23:24:23 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:24:24 INFO - PROCESS | 13155 | RSS: Main: 179793920 23:24:24 INFO - PROCESS | 13155 | 23:24:26 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:24:27 INFO - PROCESS | 13155 | RSS: Main: 194207744 23:24:27 INFO - PROCESS | 13155 | 23:24:29 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:24:30 INFO - PROCESS | 13155 | RSS: Main: 200142848 23:24:30 INFO - PROCESS | 13155 | 23:24:32 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:24:33 INFO - PROCESS | 13155 | RSS: Main: 201195520 23:24:33 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | Cycle 1(1): loaded http://localhost:60257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60257/tests/kraken/driver.html?testName=ai-astar) 23:24:35 INFO - PROCESS | 13155 | RSS: Main: 261242880 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | __start_tp_report 23:24:35 INFO - PROCESS | 13155 | _x_x_mozilla_page_load 23:24:35 INFO - PROCESS | 13155 | _x_x_mozilla_page_load_details 23:24:35 INFO - PROCESS | 13155 | |i|pagename|runs| 23:24:35 INFO - PROCESS | 13155 | |0;ai-astar;110;111;107;112;111;111;100;109;109;110 23:24:35 INFO - PROCESS | 13155 | |1;audio-beat-detection;151;124;148;169;129;154;151;130;166;132 23:24:35 INFO - PROCESS | 13155 | |2;audio-dft;163;161;161;161;161;175;160;161;163;161 23:24:35 INFO - PROCESS | 13155 | |3;audio-fft;77;73;96;96;73;73;74;120;99;73 23:24:35 INFO - PROCESS | 13155 | |4;audio-oscillator;96;96;138;95;96;96;142;96;96;145 23:24:35 INFO - PROCESS | 13155 | |5;imaging-gaussian-blur;119;114;115;115;115;115;114;115;115;114 23:24:35 INFO - PROCESS | 13155 | |6;imaging-darkroom;146;145;145;144;145;145;145;145;145;145 23:24:35 INFO - PROCESS | 13155 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 23:24:35 INFO - PROCESS | 13155 | |8;json-parse-financial;58;58;59;56;57;56;59;66;55;56 23:24:35 INFO - PROCESS | 13155 | |9;json-stringify-tinderbox;68;69;68;67;68;67;67;67;67;67 23:24:35 INFO - PROCESS | 13155 | |10;stanford-crypto-aes;81;82;83;82;83;90;82;81;81;83 23:24:35 INFO - PROCESS | 13155 | |11;stanford-crypto-ccm;129;121;114;122;122;114;126;118;115;112 23:24:35 INFO - PROCESS | 13155 | |12;stanford-crypto-pbkdf2;155;146;164;154;154;147;155;153;148;159 23:24:35 INFO - PROCESS | 13155 | |13;stanford-crypto-sha256-iterative;70;69;70;71;69;69;69;69;68;68 23:24:35 INFO - PROCESS | 13155 | __end_tp_report 23:24:35 INFO - PROCESS | 13155 | __start_cc_report 23:24:35 INFO - PROCESS | 13155 | _x_x_mozilla_cycle_collect,940 23:24:35 INFO - PROCESS | 13155 | __end_cc_report 23:24:35 INFO - PROCESS | 13155 | __startTimestamp1455434675253__endTimestamp 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | ------- Summary: start ------- 23:24:35 INFO - PROCESS | 13155 | Number of tests: 14 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.46 (3.1%) stddev-sans-first:3.66 23:24:35 INFO - PROCESS | 13155 | Values: 110.0 111.0 107.0 112.0 111.0 111.0 100.0 109.0 109.0 110.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.00 stddev:15.88 (10.5%) stddev-sans-first:16.71 23:24:35 INFO - PROCESS | 13155 | Values: 151.0 124.0 148.0 169.0 129.0 154.0 151.0 130.0 166.0 132.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#2] audio-dft Cycles:10 Average:162.70 Median:161.00 stddev:4.42 (2.7%) stddev-sans-first:4.69 23:24:35 INFO - PROCESS | 13155 | Values: 163.0 161.0 161.0 161.0 161.0 175.0 160.0 161.0 163.0 161.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.50 stddev:16.41 (21.7%) stddev-sans-first:17.12 23:24:35 INFO - PROCESS | 13155 | Values: 77.0 73.0 96.0 96.0 73.0 73.0 74.0 120.0 99.0 73.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:22.19 (23.1%) stddev-sans-first:22.99 23:24:35 INFO - PROCESS | 13155 | Values: 96.0 96.0 138.0 95.0 96.0 96.0 142.0 96.0 96.0 145.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:0.50 23:24:35 INFO - PROCESS | 13155 | Values: 119.0 114.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 114.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 23:24:35 INFO - PROCESS | 13155 | Values: 146.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:24:35 INFO - PROCESS | 13155 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:3.13 (5.4%) stddev-sans-first:3.32 23:24:35 INFO - PROCESS | 13155 | Values: 58.0 58.0 59.0 56.0 57.0 56.0 59.0 66.0 55.0 56.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 23:24:35 INFO - PROCESS | 13155 | Values: 68.0 69.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.66 (3.2%) stddev-sans-first:2.74 23:24:35 INFO - PROCESS | 13155 | Values: 81.0 82.0 83.0 82.0 83.0 90.0 82.0 81.0 81.0 83.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:121.50 stddev:5.64 (4.6%) stddev-sans-first:4.76 23:24:35 INFO - PROCESS | 13155 | Values: 129.0 121.0 114.0 122.0 122.0 114.0 126.0 118.0 115.0 112.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.50 stddev:5.52 (3.6%) stddev-sans-first:5.83 23:24:35 INFO - PROCESS | 13155 | Values: 155.0 146.0 164.0 154.0 154.0 147.0 155.0 153.0 148.0 159.0 23:24:35 INFO - PROCESS | 13155 | 23:24:35 INFO - PROCESS | 13155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 23:24:35 INFO - PROCESS | 13155 | Values: 70.0 69.0 70.0 71.0 69.0 69.0 69.0 69.0 68.0 68.0 23:24:35 INFO - PROCESS | 13155 | -------- Summary: end -------- 23:24:35 INFO - PROCESS | 13155 | 23:24:36 INFO - TEST-INFO | 13155: exit 0 23:24:36 INFO - TEST-OK | kraken | took 60537ms 23:24:36 INFO - SUITE-END | took 1174s 23:24:36 INFO - Completed test suite (00:19:34) 23:24:36 INFO - Working with test: dromaeo_css 23:24:36 INFO - Generating results file: dromaeo_css 23:24:36 INFO - Working with test: kraken 23:24:36 INFO - Generating results file: kraken 23:24:36 INFO - javascript benchmark 23:24:36 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:24:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:24:36 INFO - process_Request line: dromaeo_css 6914.58 graph.html#tests=[[72,64,35]] 23:24:36 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:24:36 INFO - process_Request line: kraken 1518.40 graph.html#tests=[[232,64,35]] 23:24:36 INFO - RETURN: dromaeo_css: 6914.58 23:24:36 INFO - RETURN: kraken: 1518.40 23:24:36 INFO - javascript benchmark 23:24:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3067.263856674399, 3092.922676933077, 3101.457244982129, 3131.843407829608, 3159.4313023655745, 4948.7278199699, 4964.280179373988, 5014.623903207261, 5030.496950304972, 5061.089003979282, 5019.64862459628, 5113.51421614947, 5125.000624878141, 5220.112580861253, 5223.033738758332, 4605.539446055393, 4623.075384923012, 4623.468301145361, 4655.953440465602, 4694.694844835075, 4688.789004494789, 4716.669833111683, 4723.574878260956, 4741.312509686093, 4743.881402964937, 4614.238650622643, 4615.053913947632, 4695.812167513295, 4719.362886010379, 4727.0, 4596.448426188878, 4602.148602508513, 4604.516525764813, 4619.86140415788, 4640.187967105777, 4589.403377560929, 4592.816287348502, 4594.241950078266, 4603.930941035887, 4628.421447319085, 4806.279058141306, 4950.801967921278, 4980.726060066695, 5066.69599824008, 5094.0, 5442.374126975409, 5481.890362192734, 5489.451054894518, 5492.81904390558, 5495.230667706524, 5494.587905907073, 5509.228707980886, 5516.475934786189, 5527.834164975057, 5533.00405926933, 5117.667351622133, 5137.717425541594, 5152.768125434364, 5172.637915345889, 5211.270422140866, 5668.291463567054, 5670.943290567124, 5671.574631902624, 5673.886522269531, 5685.60200785941, 5216.921746173811, 5287.841364759063, 5437.8368648940595, 5454.754536045887, 5463.043967305705, 5414.6480478769545, 5433.347998240237, 5462.317210348707, 5463.207834864002, 5519.889602207933, 5455.8363249102595, 5505.421930697299, 5511.118221084607, 5514.145307477347, 5516.089845175501, 5373.731313434313, 5410.972945135328, 5467.863303417446, 5513.09034009384, 5551.472610102034, 4258.446401967724, 4266.552012038691, 4268.893277668021, 4286.742795432284, 4307.504636966726, 3816.9427458588143, 3833.9616603833606, 3845.057960799622, 3868.4390763339156, 3882.437046628223, 5014.874628134253, 5079.1365467870555, 5079.6698214615935, 5140.691558506502, 5173.405058418255, 5449.782008719686, 5466.988607107618, 5488.807891723771, 5490.835274941758, 5500.972495137498, 5100.642954993189, 5126.769295381717, 5132.204508301219, 5134.024535338273, 5167.948320516822, 4593.150267200579, 4709.458412282563, 4741.40732408442, 4744.596709279681, 4745.857624271277, 5620.241267428926, 5655.321361436654, 5657.195015477429, 5663.801766938137, 5729.28383952006, 5390.487903649304, 5470.480304371078, 5471.534919531884, 5478.0, 5480.506754392124, 5684.289463817023, 5686.914696279477, 5741.081426971665, 5760.0783874579865, 5799.362070172193, 5283.049051170826, 5336.973315133399, 5341.813036543703, 5344.331958505187, 5377.08589539787, 5447.128459446628, 5453.727313634223, 5454.699991500505, 5518.917216241679, 5548.0845660465575, 5299.735013249399, 5300.045991721528, 5302.840914772563, 5315.548178404724, 5334.1732031535175, 5258.921116183184, 5293.364796224324, 5296.947030529645, 5306.761195746278, 5343.091674415281, 5209.244659524424, 5232.947670523246, 5233.895322093461, 5241.213817927342, 5331.840044798662, 5371.597130215171, 5372.221027951004, 5382.30030096085, 5388.811391601275, 5428.402875683592, 5253.054450199001, 5257.369115706139, 5258.447862974333, 5271.973640131775, 5279.709615971158], "unit": "score", "name": "dojo.html", "value": 5051.516557136559}, {"lowerIsBetter": false, "replicates": [510.67572091721746, 529.7827890564869, 576.4091805898954, 583.3699604427219, 584.4535359438925, 28924.566131508018, 36428.0, 36510.0, 36543.45184822226, 36557.99999999996, 40484.0, 41060.58939410605, 41080.17839643206, 41100.58899411013, 41141.79429102858, 7494.475386722932, 7636.312731854132, 8513.148685131484, 8763.0, 8766.60550275236, 10371.688849334532, 10508.842367364496, 10544.0, 10549.47252637365, 10649.09482693972, 10057.094861462467, 10132.493375331203, 10143.239257055713, 10144.49277536124, 10226.795464090714, 10312.535935882866, 10327.690169294932, 10351.896481035168, 10362.222833287458, 10386.117180039706, 10309.896901030968, 10480.68557943263, 10505.474726263656, 10507.527161277761, 10582.470876456146, 40708.79645601783, 41197.176056479, 41209.381859272136, 41212.38181427281, 41222.58777412218, 3277.5083737439336, 3432.5880894292595, 3784.9810750946344, 3910.608939106095, 4147.8963025924295, 30426.54360184599, 30853.228669283224, 31052.689473105205, 31242.84378578115, 31618.525722114187, 3513.736469764752, 3519.3137338219058, 3543.0, 3652.4156135018534, 3738.831752571141, 271226.0, 273191.0, 273412.999999998, 274113.0, 276783.0, 61339.38660613426, 61781.38218617846, 61825.690871545354, 62002.379976200566, 62016.379836201966, 58217.70891145602, 66014.0, 73528.63235683787, 74935.62532187304, 75081.6245918767, 13021.609351719464, 13035.543755968496, 13059.934700326437, 13108.672283192996, 13386.0, 10404.427756473468, 10627.734306642396, 10638.308509946983, 10644.574217031386, 10651.201159913038, 20607.381778546667, 20991.795861434635, 21007.15971361159, 21070.0, 21076.89461552713, 7880.842383152305, 8003.878487389922, 8152.347812175011, 8215.301699355503, 8238.464499807493, 954.3844220477891, 1010.5604062232952, 1021.7854250607307, 1028.5371582787775, 1064.5635289531256, 28278.15165545037, 29008.709912901024, 29172.416551668848, 29254.707452925624, 29362.412751744847, 1010.4644538394663, 1070.3791800755544, 1136.3238872870793, 1170.8770579089244, 1208.0215025829107, 15157.696846063238, 16506.669866602842, 16713.83286167147, 16792.244349004322, 16867.084495356845, 383095.0, 390237.0, 392205.0, 392930.0, 393592.0, 55861.72069139628, 56415.0, 56568.0, 56580.0, 56642.0, 1333.7465881482487, 1337.1776357540043, 1341.7651910915552, 1351.8918486521054, 1352.8241328627216, 29915.55126673145, 30522.84738576293, 30701.692983069883, 30845.845770771004, 31191.84404077965, 44842.327365090205, 47689.52310476851, 48147.75926120347, 48197.27704084512, 48210.0, 379928.0, 384859.0, 388707.0, 388804.0, 389164.0, 32225.677743223205, 32636.510452343708, 32668.856590019237, 32710.34579308353, 32730.672693273715, 43463.348049778644, 43646.12707745891, 43899.78050109729, 43956.0, 44787.0, 37417.0, 37817.0, 38114.0, 38828.0, 38947.221055578164, 37389.626103739705, 37442.251154976206, 37928.62071379251, 38241.617583823805, 38438.0, 31521.0, 35983.460248096824, 36070.63929360673, 36278.0, 37015.25969480541, 29118.854405727834, 31875.52186717155, 32164.839175803972, 32281.838590806896, 32389.0, 24662.136825211033, 27170.592441113004, 27373.589396158673, 27605.861970690017, 27624.0], "unit": "score", "name": "ext.html", "value": 19331.30646691455}, {"lowerIsBetter": false, "replicates": [369.19515456305254, 369.45136472338584, 375.38811736868917, 379.55591957409825, 382.9597892221315, 13726.107802992798, 15225.467108651199, 15981.280842362092, 16696.74954875678, 17262.568435789097, 16289.104099274535, 16600.58498537537, 16753.329866805343, 16838.158092095407, 16852.74720879188, 3817.9809100954594, 4810.639202059842, 5047.697138171721, 5048.697078175322, 5050.570701490377, 5280.128778751501, 5520.585956053292, 5531.115021596545, 5534.695591742453, 5539.723013849311, 5295.232191332255, 5412.40334101441, 5480.671159730409, 5488.53347465466, 5500.257465242201, 5452.863678408032, 5475.808346707866, 5492.972535137339, 5494.697791621459, 5511.862203444906, 5349.358077030781, 5353.491418315254, 5358.65168764033, 5358.866028349284, 5360.705161216131, 19480.610387792163, 19929.60140797176, 20133.194672213092, 20183.39449816508, 20190.0, 2044.8466365022682, 2054.938351849447, 2117.894105294729, 2133.4133113393787, 2666.2934322404576, 9392.953035234848, 9475.810483790285, 9780.608775648965, 9821.214302855755, 12318.692032699255, 1778.262021261175, 1820.226403778402, 1875.756151700284, 1885.453218566614, 1892.6120145370166, 58335.70832145897, 58914.705426473025, 58951.41048589502, 60575.69712151411, 61108.694456527875, 9812.705618831447, 10259.333143345659, 10273.897261027443, 10278.486075696186, 10329.74175645615, 13484.12353197039, 13551.66120846967, 13622.0, 13645.38595763193, 13648.385822638005, 6925.3074692530345, 6946.6179360135675, 6981.2669669684965, 7014.789556313319, 7080.575165490087, 6166.506679465632, 6224.1597384352535, 6244.718987645567, 6256.217972753406, 6422.839429014312, 4010.538788039413, 4204.873853784391, 4206.26390381682, 4325.653947684178, 4365.3670217818235, 1742.6950283700303, 1806.4490330449075, 1838.3198216659655, 1847.7967423583664, 1919.3474218765407, 931.5388882503204, 947.1617618407621, 975.3026585990908, 993.3940296419179, 1006.3911333643041, 13307.600771976857, 15184.468543601142, 15876.0, 16497.422590209284, 16599.41902033423, 894.9149830766066, 956.2302346611045, 958.6069711418285, 975.7559112132088, 1015.7917626886618, 9432.434053956784, 9585.089416505421, 9616.90383096174, 9618.663346782829, 9767.462789546502, 335554.0, 338924.0, 339043.0, 356176.0, 446982.0, 44854.77572612116, 44957.775211123735, 46876.531234687216, 70464.64767676129, 74686.0, 1104.8232282834708, 1151.9308841469372, 1157.7684463107412, 1163.528770847808, 1163.5578480177649, 14706.117632942058, 14923.701525969636, 15025.924870375578, 15132.243387830784, 15287.15920624332, 29959.400811984073, 30416.695833041387, 30571.388572227985, 30780.53829192519, 30887.536686950163, 39584.802075989435, 42013.789931051375, 43496.13007739764, 43636.56363436452, 43778.124437510436, 7484.550926944401, 7555.508891922007, 7575.318221360104, 7625.1231108421025, 7641.35048520882, 9816.558254878404, 11693.239939403911, 11791.469383877575, 11866.940665296619, 12046.879531204575, 9967.50162491887, 10226.744331391776, 10435.217358697977, 10512.106470950055, 10555.525001374803, 9807.509624518603, 9849.704508864745, 9976.351537150353, 10030.29787914839, 10091.949540252252, 9787.706368808947, 10195.439250841275, 10394.324368915995, 10415.635452759117, 10551.208659350426, 7249.0, 7396.556587666527, 7399.557086368107, 7465.925340746523, 7726.18875018115, 7847.646855891385, 10058.748531286776, 10130.240231982778, 10177.134943529883, 10227.181825454094], "unit": "score", "name": "jquery.html", "value": 8047.188402120427}, {"lowerIsBetter": false, "replicates": [1354.803553484744, 1487.7693957436597, 1487.799147115139, 1660.5433505785916, 1807.1145138881943, 6976.337247961442, 7684.423668224885, 7848.332891704198, 7857.057153141617, 7860.489068210562, 7850.332721718646, 8051.516908985465, 8058.4359094863385, 8059.758207253792, 8074.232947869958, 2028.1988614497266, 2230.364346161344, 2235.4299653588314, 2316.05041932808, 2330.976690233101, 2255.5037891663806, 2259.288324177887, 2263.106073101124, 2264.671622614728, 2265.1279257485903, 2246.0, 2351.318117745852, 2356.1164563288767, 2356.1988923765916, 2356.3637817789186, 2293.896774645145, 2324.0936034946385, 2363.0429675981254, 2364.6925899633025, 2367.124164059292, 2327.8719670418122, 2358.1864256831363, 2358.5872472317446, 2361.315218586608, 2367.3253122860074, 7926.167752385974, 7973.760787176394, 7976.840463190703, 7979.0, 7987.480813747146, 4917.459079501252, 5029.773660185264, 5053.545180933696, 5061.746912654353, 5063.620228482879, 3089.598352214198, 3089.9691003089906, 3102.534619807047, 3198.1524895902603, 3243.8864639737494, 1087.320424734541, 1095.6155511850152, 1103.2112039891435, 1103.5034234594464, 1122.3939072900623, 11348.602798901999, 11367.715807104805, 11446.771064578745, 11485.655430337103, 11496.252743571724, 4503.572160644799, 4528.0, 4555.043440877386, 4556.589906908394, 4586.678932474695, 9827.656032038843, 9828.164606008426, 9830.21358291335, 9832.901670983341, 9869.11177993984, 5033.0, 5044.117279476077, 5083.669561478492, 5083.974580127076, 5085.2372144177925, 4592.908141837144, 4600.7929643166135, 4606.838760643362, 4613.400257966443, 4617.5382461754225, 3504.369213541587, 3681.7606855554304, 3683.1160521474653, 3714.0900479382185, 3745.962540374616, 1216.6167657187957, 1227.1042139238227, 1228.4349199368392, 1229.6495498782983, 1245.3524167432884, 1331.7269959658247, 1335.2255691698792, 1359.4018631801976, 1363.6250031241289, 1381.7927310903244, 7215.71137154508, 7539.0576177977755, 7689.154193038761, 7695.0, 7709.229077092358, 1101.5373543111912, 1114.6878873915316, 1117.6367680503706, 1129.4183495499824, 1138.732397886496, 5715.085586306171, 5779.104238842986, 5788.681622510802, 5791.507721843691, 5803.245578074908, 9274.0, 9317.254619630414, 9537.332386732862, 9638.469884156439, 9663.661771837951, 9765.951170244103, 9778.706638800848, 9779.266555008402, 9787.706368808947, 9798.412095274307, 7217.711291548279, 7305.269473052758, 7320.597367144752, 7375.778726638209, 7515.286047825448, 7352.926470735224, 7442.404607631484, 7443.925560744323, 7448.590327532038, 7466.589337586485, 8223.671053157806, 8227.79430514218, 8376.87434688468, 8382.413231073766, 8520.19058189471, 8221.79445513867, 8456.2812160967, 8541.0, 8603.139686031596, 8637.352198585006, 6902.758403455855, 7026.051483049723, 7032.683529241299, 7042.119735033121, 7056.50604457683, 6752.527323087336, 7296.7810965671115, 7494.700211991677, 7502.549847009197, 7529.0, 6822.181338239443, 6863.073485079451, 6907.412869905913, 7015.298470152944, 7042.295770422917, 6861.588304701734, 6869.887143966036, 6919.169699636076, 6945.826354340979, 6952.826179345557, 6810.216825064983, 6861.519693621399, 6862.279460656559, 6866.244713081457, 6869.0383346330555, 6195.535334849995, 6271.717772700331, 6274.937250627435, 6296.181496405438, 6296.937030629635, 6518.641474718746, 6527.11883895668, 6549.7380104797185, 6561.507886908596, 6572.539922205399], "unit": "score", "name": "mootools.html", "value": 4606.855369072162}, {"lowerIsBetter": false, "replicates": [333.8380885270643, 339.4043453738688, 344.0401280427607, 350.8824543777834, 356.96608822161903, 5749.108888122338, 5900.911486327708, 5926.081457374108, 5935.050391937291, 5959.851003724909, 5753.395893431192, 5812.767489300423, 5822.126680997852, 5833.620814647055, 5834.358220595731, 4595.425571803533, 4597.540245975392, 4598.908021839561, 4603.148417542749, 4614.353990441341, 4394.4067550880545, 4525.977370113162, 4556.3621093047, 4557.498675145748, 4597.586217240448, 4495.325701144838, 4587.449506059261, 4593.379893714339, 4595.103954728829, 4614.031053478773, 4585.0, 4588.128255631436, 4589.426321709786, 4593.265077587604, 4605.424321959755, 4071.307877660805, 4071.3282308419075, 4073.6537394321517, 4083.3670781028986, 4083.836646534135, 5575.609707320489, 5618.662880227159, 5646.745896434671, 5659.660420374749, 5664.150377443375, 5334.946650533484, 5347.786088556492, 5348.304720386363, 5352.090144675414, 5358.303420555342, 6024.518038556905, 6275.843103922392, 6276.905846412307, 6280.560360774748, 6283.057541368786, 4388.341748737683, 4470.351798989161, 4531.365608814768, 4536.8865778355475, 4540.77296135192, 6545.312742162052, 6572.112764776742, 6574.079628851964, 6580.967095164541, 6584.242812076624, 4633.536646335339, 4641.814327426932, 4645.233536466513, 4647.651426143053, 4647.837325693585, 4377.934330985037, 4488.079943611552, 4508.752018638941, 4693.272542755878, 4702.905941881211, 5243.161094224905, 5246.186841039645, 5246.947530524722, 5249.868753281122, 5258.947410525922, 6314.052892066226, 6366.0, 6366.331535188831, 6379.936200638027, 6409.294977552466, 1562.53124062783, 1591.4270862489495, 1593.139704559525, 1596.8722502199796, 1600.8799340049543, 1045.4772613693153, 1056.5509658395151, 1058.5289546152042, 1062.4103622489438, 1091.912646988239, 5954.851128721816, 6001.459868611846, 6006.099085137177, 6013.398660134039, 6014.278286605635, 6497.0, 6499.155109835786, 6503.447206987459, 6504.577202481823, 6507.642079685568, 5980.970095149583, 5984.760609575568, 5987.6108052976415, 5993.130996005555, 5993.430624090704, 3428.468587368962, 3511.455724362728, 3513.1217195701074, 3536.8938931832085, 3544.468329750558, 6876.381125698711, 6880.449564034965, 6880.931190688029, 6896.206936202401, 6903.378695917391, 6736.124303840469, 6743.291954344723, 6743.460523158135, 6755.2906944771075, 6762.323767623198, 6661.866762664719, 6884.105066341343, 6885.1049363582415, 6901.309869013159, 6909.2399836019, 6280.7487700491465, 6412.519061070531, 6552.180977377828, 6569.4744420447205, 6576.967115164393, 6502.60984340941, 6518.315576864361, 6521.380468855451, 6526.67366631657, 6538.934610653832, 6816.522843400914, 6841.350071743176, 6863.10779598669, 6864.48516361265, 6876.621785801629, 4341.630961368192, 4393.692441529062, 4425.645948324191, 4435.645148388056, 4444.0, 6471.611703297817, 6483.805485835433, 6511.641859697762, 6522.608643481406, 6525.836854078686, 6349.936500634934, 6357.141785859035, 6367.649779261999, 6373.904391434225, 6379.393957574023, 6203.906941395792, 6359.586626869239, 6364.204474440695, 6364.968175159094, 6366.64983425916, 6262.749490020348, 6265.373462653881, 6266.0, 6268.373162683695, 6274.874502509833, 6355.237371515448, 6355.396237357444, 6393.968030159819, 6410.551261411843, 6419.325970773189, 6068.757249709962, 6222.097795819672, 6265.530085243534, 6273.96863015682, 6278.717457714322], "unit": "score", "name": "prototype.html", "value": 4787.122305805435}, {"lowerIsBetter": false, "replicates": [716.3946465236874, 756.1644382956832, 757.3524636435848, 799.8960135182425, 813.5240884082812, 13448.731025379499, 13718.176909385444, 13740.0, 13743.725125497484, 13751.518696845613, 12916.677083072927, 12964.611061668165, 12966.416511256992, 12976.05359196121, 12991.805122923164, 670.4636290967206, 677.2381071294793, 798.5967086621278, 806.7378102116807, 817.6606708216083, 815.747118393297, 817.2113910076774, 823.1398188892591, 823.6705317872838, 824.11819353292, 861.7027125641675, 862.9266512346458, 864.3646919514152, 865.35098675993, 866.1598249697784, 704.2992222738383, 710.5097482736921, 711.9822004449878, 713.1834050012758, 859.5702148925537, 610.4536439886322, 623.5884316351231, 623.9719212635397, 625.0249610607467, 626.6396821827467, 13385.73228535424, 13414.329283535882, 13438.932805336008, 13449.529266475627, 13463.798043029363, 12503.687407814787, 12815.487380504768, 12857.935710321388, 12893.290869002201, 13271.0, 10400.167986561057, 10596.682099537025, 10707.089897358734, 11240.269382490113, 11401.828972565418, 3614.150674591469, 3655.95805195518, 3669.21111960927, 3716.1824398632257, 3833.9424908626393, 45748.54251457476, 46676.066478670575, 50449.0, 50736.49263507391, 50874.236886446735, 10183.134433573081, 10231.94884025575, 10365.326253793479, 10415.479226038668, 10818.24272300947, 18442.07789610541, 18750.718739218923, 18754.718679219823, 18785.624287514172, 18799.0, 7632.961835190788, 7799.610019499116, 7841.490303130278, 7853.607319633996, 7923.722669706648, 4299.527052024275, 4324.17840610283, 4340.739555626673, 4368.148211098869, 4423.623991960655, 3239.6760323967414, 3247.0, 3262.5758651375168, 3278.164068162603, 3282.983585082059, 598.0670154558815, 607.0499668019623, 609.5306613907355, 625.4621025917708, 627.6736097229415, 499.2261993909426, 519.9480051994846, 637.2926052082186, 665.4643012374988, 688.9276625954303, 8503.574821258911, 8634.395592308603, 8734.781630459162, 8739.082396348293, 9714.174295184846, 567.957403194762, 634.9301576826546, 646.6734299178885, 669.4577392312243, 725.0465637686531, 3830.272248272819, 3882.417637354363, 4012.578679238696, 4027.453576281241, 4156.937645935313, 51274.23088653673, 52449.737751311, 52659.47340526546, 52910.0, 53341.46658533443, 47781.0, 48633.756831215615, 49375.753121234164, 49521.25718114231, 49738.50261497411, 44099.0, 44346.0, 44487.0, 44621.77689111534, 44667.32999005017, 8040.67837286502, 8049.678012879419, 8206.507609543207, 8325.500469971821, 8414.368922330726, 33558.66441335653, 33692.83153584216, 33768.0, 34604.65395346115, 35140.12149696278, 42826.14347713091, 42854.142917142104, 43207.567924320356, 43985.78007109944, 44153.0, 10735.409552474688, 10905.618303359344, 10937.83593246118, 10974.396408197306, 11634.6509604712, 12115.75768484643, 12129.818052729039, 12481.251124932533, 12566.434510446868, 12619.558315458915, 10969.396683182502, 11656.592019279284, 11889.524419023142, 11955.880441195824, 12069.215500992408, 11360.53848555888, 11672.182947193614, 11710.355930423568, 11734.647960561197, 12138.211016283913, 11498.195126341076, 11867.525298988288, 11899.405029748652, 11935.283882967049, 12265.202761820454, 9533.380330278509, 9938.602455901972, 10092.596296148073, 10191.133753630727, 10196.847047294445, 8728.258098061737, 8865.601047952987, 9215.953920230357, 10269.281150319406, 10317.432541210006], "unit": "score", "name": "yui.html", "value": 6305.919338641903}], "name": "dromaeo_css", "value": 6914.577993906419}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 112.0, 111.0, 111.0, 100.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 148.0, 169.0, 129.0, 154.0, 151.0, 130.0, 166.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 161.0, 161.0, 175.0, 160.0, 161.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 96.0, 96.0, 73.0, 73.0, 74.0, 120.0, 99.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 96.0, 96.0, 142.0, 96.0, 96.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 56.0, 57.0, 56.0, 59.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 82.0, 83.0, 90.0, 82.0, 81.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 114.0, 122.0, 122.0, 114.0, 126.0, 118.0, 115.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [155.0, 146.0, 164.0, 154.0, 154.0, 147.0, 155.0, 153.0, 148.0, 159.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 71.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1518.3999999999999}]} 23:24:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1518.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6914.58"}}} 23:24:36 INFO - Return code: 0 23:24:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:24:36 INFO - # TBPL SUCCESS # 23:24:36 INFO - Running post-action listener: _resource_record_post_action 23:24:36 INFO - Running post-run listener: _resource_record_post_run 23:24:37 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 36864; Write bytes: 536440832; Read time: 240; Write time: 622076 23:24:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240148480; Read time: 176; Write time: 305736 23:24:37 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 32768; Write bytes: 296194048; Read time: 64; Write time: 316340 23:24:37 INFO - Running post-run listener: _upload_blobber_files 23:24:37 INFO - Blob upload gear active. 23:24:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:24:37 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 23:24:37 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'] 23:24:37 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 23:24:38 INFO - (blobuploader) - INFO - Open directory for files ... 23:24:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:24:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:24:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:39 INFO - (blobuploader) - INFO - Done attempting. 23:24:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:24:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:24:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:39 INFO - (blobuploader) - INFO - Done attempting. 23:24:39 INFO - (blobuploader) - INFO - Iteration through files over. 23:24:39 INFO - Return code: 0 23:24:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:24:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:24:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3627c923fd61952fd6af51d248e7a0d7f5ef56ccd33bc636724e19169620e648d9484ef594ddf84f34acd4152d5347f58752c4ef9f49da0ffab035980732178a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc727631c2a41efdba0bd7f747a1a14690288844529ceceb3687259bd1d1ad4af3eb80548118f368ea35dfa49100c18048c0b3d08d2b2cc0623d1aa03cc33cd6"} 23:24:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:24:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:24:39 INFO - Contents: 23:24:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3627c923fd61952fd6af51d248e7a0d7f5ef56ccd33bc636724e19169620e648d9484ef594ddf84f34acd4152d5347f58752c4ef9f49da0ffab035980732178a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc727631c2a41efdba0bd7f747a1a14690288844529ceceb3687259bd1d1ad4af3eb80548118f368ea35dfa49100c18048c0b3d08d2b2cc0623d1aa03cc33cd6"} 23:24:39 INFO - Running post-run listener: copy_logs_to_upload_dir 23:24:39 INFO - Copying logs to upload dir... 23:24:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:24:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.110829 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-13 23:24:39.897720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 23:24:39.901584) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 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/3627c923fd61952fd6af51d248e7a0d7f5ef56ccd33bc636724e19169620e648d9484ef594ddf84f34acd4152d5347f58752c4ef9f49da0ffab035980732178a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc727631c2a41efdba0bd7f747a1a14690288844529ceceb3687259bd1d1ad4af3eb80548118f368ea35dfa49100c18048c0b3d08d2b2cc0623d1aa03cc33cd6"} build_url:https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/OSGyDYauTEKQ-57mRykseg/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/3627c923fd61952fd6af51d248e7a0d7f5ef56ccd33bc636724e19169620e648d9484ef594ddf84f34acd4152d5347f58752c4ef9f49da0ffab035980732178a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc727631c2a41efdba0bd7f747a1a14690288844529ceceb3687259bd1d1ad4af3eb80548118f368ea35dfa49100c18048c0b3d08d2b2cc0623d1aa03cc33cd6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 23:24:39.928285) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:24:39.928818) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1455427489.542464-217096300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 23:24:40.011662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 23:24:40.011944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 23:24:40.012238) ========= ========= Total master_lag: 0.26 =========