builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1458004564.27 results: success (0) buildid: 20160314153957 builduid: d418b97d82d440a5918cd72cf4c4dea6 revision: b21c3e5856ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.266615) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.267281) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.267649) ========= 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004815 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.318625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.319033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.413408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.413697) ========= 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021568 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.483119) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.483442) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:04.483827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 18:16:04.484137) ========= 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 18:16:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.9M=0s 2016-03-14 18:16:04 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208386 ========= master_lag: 0.85 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 18:16:05.542871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:05.543184) ========= 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083603 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:05.664586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:05.664931) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b21c3e5856ae --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 b21c3e5856ae --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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 18:16:05,796 Setting DEBUG logging. 2016-03-14 18:16:05,796 attempt 1/10 2016-03-14 18:16:05,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b21c3e5856ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 18:16:06,052 unpacking tar archive at: fx-team-b21c3e5856ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550098 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:06.236877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:06.240256) ========= echo b21c3e5856ae in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b21c3e5856ae'] 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b21c3e5856ae program finished with exit code 0 elapsedTime=0.004609 script_repo_revision: 'b21c3e5856ae' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:06.299693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:06.300042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 18:16:06.311902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-14 18:16:06.312277) ========= /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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:06 INFO - MultiFileLogger online at 20160314 18:16:06 in /builds/slave/test-pgo 18:16:06 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 18:16:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:16:06 INFO - {'append_to_log': False, 18:16:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:16:06 INFO - 'blob_upload_branch': 'Fx-Team', 18:16:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:16:06 INFO - 'branch': 'Fx-Team', 18:16:06 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:06 INFO - 'config_files': ('talos/linux_config.py',), 18:16:06 INFO - 'default_actions': ('clobber', 18:16:06 INFO - 'read-buildbot-config', 18:16:06 INFO - 'download-and-extract', 18:16:06 INFO - 'populate-webroot', 18:16:06 INFO - 'create-virtualenv', 18:16:06 INFO - 'install', 18:16:06 INFO - 'run-tests'), 18:16:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:06 INFO - 'download_minidump_stackwalk': True, 18:16:06 INFO - 'download_symbols': 'ondemand', 18:16:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:06 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:06 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:06 INFO - 'installer_path': 'installer.exe', 18:16:06 INFO - 'log_level': 'info', 18:16:06 INFO - 'log_name': 'talos', 18:16:06 INFO - 'log_to_console': True, 18:16:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:06 INFO - 'opt_config_files': (), 18:16:06 INFO - 'pip_index': False, 18:16:06 INFO - 'sps_profile': False, 18:16:06 INFO - 'sps_profile_interval': 0, 18:16:06 INFO - 'suite': 'dromaeojs', 18:16:06 INFO - 'system_bits': '32', 18:16:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:06 INFO - 'title': 'talos-linux64-ix-017', 18:16:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:06 INFO - 'use_talos_json': True, 18:16:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:16:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:06 INFO - 'work_dir': 'build'} 18:16:06 INFO - ##### 18:16:06 INFO - ##### Running clobber step. 18:16:06 INFO - ##### 18:16:06 INFO - Running pre-action listener: _resource_record_pre_action 18:16:06 INFO - Running main action method: clobber 18:16:06 INFO - rmtree: /builds/slave/test-pgo/build 18:16:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:16:07 INFO - Running post-action listener: _resource_record_post_action 18:16:07 INFO - ##### 18:16:07 INFO - ##### Running read-buildbot-config step. 18:16:07 INFO - ##### 18:16:07 INFO - Running pre-action listener: _resource_record_pre_action 18:16:07 INFO - Running main action method: read_buildbot_config 18:16:07 INFO - Using buildbot properties: 18:16:07 INFO - { 18:16:07 INFO - "project": "", 18:16:07 INFO - "product": "firefox", 18:16:07 INFO - "script_repo_revision": "production", 18:16:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:16:07 INFO - "repository": "", 18:16:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:16:07 INFO - "buildid": "20160314153957", 18:16:07 INFO - "pgo_build": "True", 18:16:07 INFO - "basedir": "/builds/slave/test-pgo", 18:16:07 INFO - "buildnumber": 718, 18:16:07 INFO - "slavename": "talos-linux64-ix-017", 18:16:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:16:07 INFO - "platform": "ubuntu64_hw", 18:16:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:16:07 INFO - "branch": "fx-team", 18:16:07 INFO - "repo_path": "integration/fx-team", 18:16:07 INFO - "revision": "b21c3e5856ae", 18:16:07 INFO - "stage_platform": "linux64-pgo", 18:16:07 INFO - "builduid": "d418b97d82d440a5918cd72cf4c4dea6", 18:16:07 INFO - "slavebuilddir": "test" 18:16:07 INFO - } 18:16:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:16:07 INFO - Running post-action listener: _resource_record_post_action 18:16:07 INFO - ##### 18:16:07 INFO - ##### Running download-and-extract step. 18:16:07 INFO - ##### 18:16:07 INFO - Running pre-action listener: _resource_record_pre_action 18:16:07 INFO - Running main action method: download_and_extract 18:16:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:07 INFO - https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:16:08 INFO - Downloaded 1361 bytes. 18:16:08 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:16:08 INFO - Using the following test package requirements: 18:16:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:16:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:16:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'jsshell-linux-x86_64.zip'], 18:16:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:16:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:16:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:16:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:16:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:16:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:16: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')]} 18:16:08 INFO - https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:11 INFO - Downloaded 23560995 bytes. 18:16:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:16:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:16:13 INFO - Return code: 0 18:16:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:16: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')]} 18:16:13 INFO - https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:16:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:16:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:18 INFO - Downloaded 23560995 bytes. 18:16:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:16:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:16:20 INFO - Return code: 0 18:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:20 INFO - https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:16:22 INFO - Downloaded 10845263 bytes. 18:16:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:16:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:16:22 INFO - Return code: 0 18:16: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')]} 18:16:22 INFO - https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:16:25 INFO - Downloaded 57672873 bytes. 18:16:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:16:25 INFO - mkdir: /builds/slave/test-pgo/properties 18:16:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:16:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:16:25 INFO - Contents: 18:16:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:16:26 INFO - Running post-action listener: _resource_record_post_action 18:16:26 INFO - Running post-action listener: set_extra_try_arguments 18:16:26 INFO - ##### 18:16:26 INFO - ##### Running populate-webroot step. 18:16:26 INFO - ##### 18:16:26 INFO - Running pre-action listener: _resource_record_pre_action 18:16:26 INFO - Running main action method: populate_webroot 18:16:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:16:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:16:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:16:26 INFO - '--tppagecycles', 18:16:26 INFO - '7'], 18:16:26 INFO - 'tests': ['tsvgm']}}, 18:16:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:16:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:16:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:16:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:16:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'tests': ['damp', 'tps']}, 18:16:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['damp', 'tps']}, 18:16:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:16:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:16:26 INFO - 'other': {'tests': ['a11yr', 18:16:26 INFO - 'ts_paint', 18:16:26 INFO - 'tpaint', 18:16:26 INFO - 'sessionrestore', 18:16:26 INFO - 'sessionrestore_no_auto_restore', 18:16:26 INFO - 'tabpaint']}, 18:16:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['a11yr', 18:16:26 INFO - 'ts_paint', 18:16:26 INFO - 'tpaint', 18:16:26 INFO - 'sessionrestore', 18:16:26 INFO - 'sessionrestore_no_auto_restore', 18:16:26 INFO - 'tabpaint']}, 18:16:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['a11yr', 18:16:26 INFO - 'ts_paint', 18:16:26 INFO - 'tpaint', 18:16:26 INFO - 'sessionrestore', 18:16:26 INFO - 'sessionrestore_no_auto_restore', 18:16:26 INFO - 'tabpaint']}, 18:16:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['a11yr', 18:16:26 INFO - 'ts_paint', 18:16:26 INFO - 'tpaint', 18:16:26 INFO - 'sessionrestore', 18:16:26 INFO - 'sessionrestore_no_auto_restore', 18:16:26 INFO - 'tabpaint']}, 18:16:26 INFO - 'other_l64': {'tests': ['a11yr', 18:16:26 INFO - 'ts_paint', 18:16:26 INFO - 'tpaint', 18:16:26 INFO - 'sessionrestore', 18:16:26 INFO - 'sessionrestore_no_auto_restore', 18:16:26 INFO - 'tabpaint']}, 18:16:26 INFO - 'other_nol64': {'tests': ['a11yr', 18:16:26 INFO - 'ts_paint', 18:16:26 INFO - 'tpaint', 18:16:26 INFO - 'sessionrestore', 18:16:26 INFO - 'sessionrestore_no_auto_restore', 18:16:26 INFO - 'tabpaint']}, 18:16:26 INFO - 'svgr': {'tests': ['tsvgx', 18:16:26 INFO - 'tsvgr_opacity', 18:16:26 INFO - 'tart', 18:16:26 INFO - 'tscrollx', 18:16:26 INFO - 'cart']}, 18:16:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['tsvgx', 18:16:26 INFO - 'tsvgr_opacity', 18:16:26 INFO - 'tart', 18:16:26 INFO - 'tscrollx', 18:16:26 INFO - 'cart']}, 18:16:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'tests': ['tp5o']}, 18:16:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'talos_options': ['--e10s'], 18:16:26 INFO - 'tests': ['tp5o']}, 18:16:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'talos_options': ['--xperf_path', 18:16:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:26 INFO - 'tests': ['tp5n']}, 18:16:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:26 INFO - 'talos_options': ['--e10s', 18:16:26 INFO - '--xperf_path', 18:16:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:26 INFO - 'tests': ['tp5n']}}, 18:16:26 INFO - 'talos.zip': {'path': '', 18:16:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:16:26 INFO - Running post-action listener: _resource_record_post_action 18:16:26 INFO - ##### 18:16:26 INFO - ##### Running create-virtualenv step. 18:16:26 INFO - ##### 18:16:26 INFO - Running pre-action listener: _resource_record_pre_action 18:16:26 INFO - Running main action method: create_virtualenv 18:16:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:16:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:16:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:16:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:16:27 INFO - Using real prefix '/usr' 18:16:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:16:27 INFO - Installing distribute.............................................................................................................................................................................................done. 18:16:29 INFO - Installing pip.................done. 18:16:29 INFO - Return code: 0 18:16:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:29 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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:16:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:16:29 INFO - Using env: {'DISPLAY': ':0', 18:16:29 INFO - 'HOME': '/home/cltbld', 18:16:29 INFO - 'LANG': 'en_US.UTF-8', 18:16:29 INFO - 'LANGUAGE': 'en_US:en', 18:16:29 INFO - 'LOGNAME': 'cltbld', 18:16:29 INFO - 'MAIL': '/var/mail/cltbld', 18:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:29 INFO - 'MOZ_NO_REMOTE': '1', 18:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:29 INFO - 'NO_EM_RESTART': '1', 18:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:29 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:29 INFO - 'SHELL': '/bin/bash', 18:16:29 INFO - 'SHLVL': '1', 18:16:29 INFO - 'TERM': 'linux', 18:16:29 INFO - 'TMOUT': '86400', 18:16:29 INFO - 'USER': 'cltbld', 18:16:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:29 INFO - '_': '/tools/buildbot/bin/python'} 18:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:16:30 INFO - Cleaning up... 18:16:30 INFO - Return code: 0 18:16:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:30 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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:16:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:16:30 INFO - Using env: {'DISPLAY': ':0', 18:16:30 INFO - 'HOME': '/home/cltbld', 18:16:30 INFO - 'LANG': 'en_US.UTF-8', 18:16:30 INFO - 'LANGUAGE': 'en_US:en', 18:16:30 INFO - 'LOGNAME': 'cltbld', 18:16:30 INFO - 'MAIL': '/var/mail/cltbld', 18:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:30 INFO - 'MOZ_NO_REMOTE': '1', 18:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:30 INFO - 'NO_EM_RESTART': '1', 18:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:30 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:30 INFO - 'SHELL': '/bin/bash', 18:16:30 INFO - 'SHLVL': '1', 18:16:30 INFO - 'TERM': 'linux', 18:16:30 INFO - 'TMOUT': '86400', 18:16:30 INFO - 'USER': 'cltbld', 18:16:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:30 INFO - '_': '/tools/buildbot/bin/python'} 18:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:30 INFO - Downloading/unpacking psutil>=0.7.1 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:16:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:32 INFO - Installing collected packages: psutil 18:16:32 INFO - Running setup.py install for psutil 18:16:32 INFO - building 'psutil._psutil_linux' extension 18:16:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:16:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:16:33 INFO - building 'psutil._psutil_posix' extension 18:16:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:16:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:33 INFO - Successfully installed psutil 18:16:33 INFO - Cleaning up... 18:16:33 INFO - Return code: 0 18:16:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:33 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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:16:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:16:33 INFO - Using env: {'DISPLAY': ':0', 18:16:33 INFO - 'HOME': '/home/cltbld', 18:16:33 INFO - 'LANG': 'en_US.UTF-8', 18:16:33 INFO - 'LANGUAGE': 'en_US:en', 18:16:33 INFO - 'LOGNAME': 'cltbld', 18:16:33 INFO - 'MAIL': '/var/mail/cltbld', 18:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:33 INFO - 'MOZ_NO_REMOTE': '1', 18:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:33 INFO - 'NO_EM_RESTART': '1', 18:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:33 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:33 INFO - 'SHELL': '/bin/bash', 18:16:33 INFO - 'SHLVL': '1', 18:16:33 INFO - 'TERM': 'linux', 18:16:33 INFO - 'TMOUT': '86400', 18:16:33 INFO - 'USER': 'cltbld', 18:16:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:33 INFO - '_': '/tools/buildbot/bin/python'} 18:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:16:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:16:35 INFO - Installing collected packages: mozsystemmonitor 18:16:35 INFO - Running setup.py install for mozsystemmonitor 18:16:35 INFO - Successfully installed mozsystemmonitor 18:16:35 INFO - Cleaning up... 18:16:36 INFO - Return code: 0 18:16:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:16:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:16:36 INFO - Using env: {'DISPLAY': ':0', 18:16:36 INFO - 'HOME': '/home/cltbld', 18:16:36 INFO - 'LANG': 'en_US.UTF-8', 18:16:36 INFO - 'LANGUAGE': 'en_US:en', 18:16:36 INFO - 'LOGNAME': 'cltbld', 18:16:36 INFO - 'MAIL': '/var/mail/cltbld', 18:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:36 INFO - 'MOZ_NO_REMOTE': '1', 18:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:36 INFO - 'NO_EM_RESTART': '1', 18:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:36 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:36 INFO - 'SHELL': '/bin/bash', 18:16:36 INFO - 'SHLVL': '1', 18:16:36 INFO - 'TERM': 'linux', 18:16:36 INFO - 'TMOUT': '86400', 18:16:36 INFO - 'USER': 'cltbld', 18:16:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:36 INFO - '_': '/tools/buildbot/bin/python'} 18:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:36 INFO - Downloading/unpacking blobuploader==1.2.4 18:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:38 INFO - Downloading blobuploader-1.2.4.tar.gz 18:16:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:16:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:16:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:38 INFO - Downloading docopt-0.6.1.tar.gz 18:16:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:16:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:16:38 INFO - Running setup.py install for blobuploader 18:16:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:16:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:16:38 INFO - Running setup.py install for requests 18:16:39 INFO - Running setup.py install for docopt 18:16:39 INFO - Successfully installed blobuploader requests docopt 18:16:39 INFO - Cleaning up... 18:16:39 INFO - Return code: 0 18:16:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:39 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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:16:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:39 INFO - Using env: {'DISPLAY': ':0', 18:16:39 INFO - 'HOME': '/home/cltbld', 18:16:39 INFO - 'LANG': 'en_US.UTF-8', 18:16:39 INFO - 'LANGUAGE': 'en_US:en', 18:16:39 INFO - 'LOGNAME': 'cltbld', 18:16:39 INFO - 'MAIL': '/var/mail/cltbld', 18:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:39 INFO - 'MOZ_NO_REMOTE': '1', 18:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:39 INFO - 'NO_EM_RESTART': '1', 18:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:39 INFO - 'SHELL': '/bin/bash', 18:16:39 INFO - 'SHLVL': '1', 18:16:39 INFO - 'TERM': 'linux', 18:16:39 INFO - 'TMOUT': '86400', 18:16:39 INFO - 'USER': 'cltbld', 18:16:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:39 INFO - '_': '/tools/buildbot/bin/python'} 18:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:16:39 INFO - Running setup.py (path:/tmp/pip-llphUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:16:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:16:39 INFO - Running setup.py (path:/tmp/pip-7dcn_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:16:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:16:39 INFO - Running setup.py (path:/tmp/pip-98DYat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:16:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:16:39 INFO - Running setup.py (path:/tmp/pip-snQpmJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:16:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:16:39 INFO - Running setup.py (path:/tmp/pip-l8Hiuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:16:40 INFO - Running setup.py (path:/tmp/pip-As6NC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:16:40 INFO - Running setup.py (path:/tmp/pip-ROIu7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:16:40 INFO - Running setup.py (path:/tmp/pip-pGf19S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:16:40 INFO - Running setup.py (path:/tmp/pip-mCicHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:16:40 INFO - Running setup.py (path:/tmp/pip-CmTufa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:16:40 INFO - Running setup.py (path:/tmp/pip-YWK5Am-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:16:40 INFO - Running setup.py (path:/tmp/pip-KfP0u0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:16:40 INFO - Running setup.py (path:/tmp/pip-MhbPqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:16:40 INFO - Running setup.py (path:/tmp/pip-GPVY7N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:16:40 INFO - Running setup.py (path:/tmp/pip-KH41Gt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:16:40 INFO - Running setup.py (path:/tmp/pip-M5ZT7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:16:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:16:40 INFO - Running setup.py (path:/tmp/pip-cwW2WE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:16:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:16:40 INFO - Running setup.py install for manifestparser 18:16:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Running setup.py install for mozcrash 18:16:41 INFO - Running setup.py install for mozdebug 18:16:41 INFO - Running setup.py install for mozdevice 18:16:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Running setup.py install for mozfile 18:16:41 INFO - Running setup.py install for mozhttpd 18:16:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Running setup.py install for mozinfo 18:16:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Running setup.py install for mozInstall 18:16:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Running setup.py install for mozleak 18:16:41 INFO - Running setup.py install for mozlog 18:16:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:16:41 INFO - Running setup.py install for moznetwork 18:16:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:16:42 INFO - Running setup.py install for mozprocess 18:16:42 INFO - Running setup.py install for mozprofile 18:16:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:16:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:16:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:16:42 INFO - Running setup.py install for mozrunner 18:16:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:16:42 INFO - Running setup.py install for mozscreenshot 18:16:42 INFO - Running setup.py install for moztest 18:16:42 INFO - Running setup.py install for mozversion 18:16:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:16:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:16:42 INFO - Cleaning up... 18:16:42 INFO - Return code: 0 18:16:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:42 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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:16:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:42 INFO - Using env: {'DISPLAY': ':0', 18:16:42 INFO - 'HOME': '/home/cltbld', 18:16:42 INFO - 'LANG': 'en_US.UTF-8', 18:16:42 INFO - 'LANGUAGE': 'en_US:en', 18:16:42 INFO - 'LOGNAME': 'cltbld', 18:16:42 INFO - 'MAIL': '/var/mail/cltbld', 18:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:42 INFO - 'MOZ_NO_REMOTE': '1', 18:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:42 INFO - 'NO_EM_RESTART': '1', 18:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:42 INFO - 'SHELL': '/bin/bash', 18:16:42 INFO - 'SHLVL': '1', 18:16:42 INFO - 'TERM': 'linux', 18:16:42 INFO - 'TMOUT': '86400', 18:16:42 INFO - 'USER': 'cltbld', 18:16:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:42 INFO - '_': '/tools/buildbot/bin/python'} 18:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:16:42 INFO - Running setup.py (path:/tmp/pip-S_DNSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:16:42 INFO - Running setup.py (path:/tmp/pip-7kiya0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:16:43 INFO - Running setup.py (path:/tmp/pip-hYMSbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:16:43 INFO - Running setup.py (path:/tmp/pip-ZVRri0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:16:43 INFO - Running setup.py (path:/tmp/pip-9DJNNH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:16:43 INFO - Running setup.py (path:/tmp/pip-gVE_lW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:16:43 INFO - Running setup.py (path:/tmp/pip-shdxoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:16:43 INFO - Running setup.py (path:/tmp/pip-jhlc33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:16:43 INFO - Running setup.py (path:/tmp/pip-bBqbjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:16:43 INFO - Running setup.py (path:/tmp/pip-rQo0zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:16:43 INFO - Running setup.py (path:/tmp/pip-IeTI3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:16:43 INFO - Running setup.py (path:/tmp/pip-_lc35g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:16:43 INFO - Running setup.py (path:/tmp/pip-shnWEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:16:43 INFO - Running setup.py (path:/tmp/pip-7QllSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:16:43 INFO - Running setup.py (path:/tmp/pip-KVtXCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:16:44 INFO - Running setup.py (path:/tmp/pip-hLXRhf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:16:44 INFO - Running setup.py (path:/tmp/pip-PEeuba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:45 INFO - Downloading blessings-1.6.tar.gz 18:16:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:46 INFO - Installing collected packages: blessings 18:16:46 INFO - Running setup.py install for blessings 18:16:46 INFO - Successfully installed blessings 18:16:46 INFO - Cleaning up... 18:16:46 INFO - Return code: 0 18:16:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:16:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:16:46 INFO - Reading from file tmpfile_stdout 18:16:46 INFO - Current package versions: 18:16:46 INFO - argparse == 1.2.1 18:16:46 INFO - blessings == 1.6 18:16:46 INFO - blobuploader == 1.2.4 18:16:46 INFO - docopt == 0.6.1 18:16:46 INFO - manifestparser == 1.1 18:16:46 INFO - mozInstall == 1.12 18:16:46 INFO - mozcrash == 0.17 18:16:46 INFO - mozdebug == 0.1 18:16:46 INFO - mozdevice == 0.48 18:16:46 INFO - mozfile == 1.2 18:16:46 INFO - mozhttpd == 0.7 18:16:46 INFO - mozinfo == 0.9 18:16:46 INFO - mozleak == 0.1 18:16:46 INFO - mozlog == 3.1 18:16:46 INFO - moznetwork == 0.27 18:16:46 INFO - mozprocess == 0.22 18:16:46 INFO - mozprofile == 0.28 18:16:46 INFO - mozrunner == 6.11 18:16:46 INFO - mozscreenshot == 0.1 18:16:46 INFO - mozsystemmonitor == 0.0 18:16:46 INFO - moztest == 0.7 18:16:46 INFO - mozversion == 1.4 18:16:46 INFO - psutil == 3.1.1 18:16:46 INFO - requests == 1.2.3 18:16:46 INFO - wsgiref == 0.1.2 18:16:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 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 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:46 INFO - Using env: {'DISPLAY': ':0', 18:16:46 INFO - 'HOME': '/home/cltbld', 18:16:46 INFO - 'LANG': 'en_US.UTF-8', 18:16:46 INFO - 'LANGUAGE': 'en_US:en', 18:16:46 INFO - 'LOGNAME': 'cltbld', 18:16:46 INFO - 'MAIL': '/var/mail/cltbld', 18:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:46 INFO - 'MOZ_NO_REMOTE': '1', 18:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:46 INFO - 'NO_EM_RESTART': '1', 18:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:46 INFO - 'SHELL': '/bin/bash', 18:16:46 INFO - 'SHLVL': '1', 18:16:46 INFO - 'TERM': 'linux', 18:16:46 INFO - 'TMOUT': '86400', 18:16:46 INFO - 'USER': 'cltbld', 18:16:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:46 INFO - '_': '/tools/buildbot/bin/python'} 18:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:16:46 INFO - Cleaning up... 18:16:46 INFO - Return code: 0 18:16:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:16:46 INFO - Using env: {'DISPLAY': ':0', 18:16:46 INFO - 'HOME': '/home/cltbld', 18:16:46 INFO - 'LANG': 'en_US.UTF-8', 18:16:46 INFO - 'LANGUAGE': 'en_US:en', 18:16:46 INFO - 'LOGNAME': 'cltbld', 18:16:46 INFO - 'MAIL': '/var/mail/cltbld', 18:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:46 INFO - 'MOZ_NO_REMOTE': '1', 18:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:46 INFO - 'NO_EM_RESTART': '1', 18:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:46 INFO - 'SHELL': '/bin/bash', 18:16:46 INFO - 'SHLVL': '1', 18:16:46 INFO - 'TERM': 'linux', 18:16:46 INFO - 'TMOUT': '86400', 18:16:46 INFO - 'USER': 'cltbld', 18:16:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:46 INFO - '_': '/tools/buildbot/bin/python'} 18:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:46 INFO - Downloading/unpacking jsonschema 18:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:16:48 INFO - Downloading/unpacking functools32 (from jsonschema) 18:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:48 INFO - Downloading functools32-3.2.3-2.tar.gz 18:16:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:16:49 INFO - warning: no files found matching '*.txt' 18:16:49 INFO - no previously-included directories found matching 'build' 18:16:49 INFO - no previously-included directories found matching 'dist' 18:16:49 INFO - no previously-included directories found matching '.git*' 18:16:49 INFO - Installing collected packages: jsonschema, functools32 18:16:49 INFO - Running setup.py install for functools32 18:16:49 INFO - warning: no files found matching '*.txt' 18:16:49 INFO - no previously-included directories found matching 'build' 18:16:49 INFO - no previously-included directories found matching 'dist' 18:16:49 INFO - no previously-included directories found matching '.git*' 18:16:49 INFO - Successfully installed jsonschema functools32 18:16:49 INFO - Cleaning up... 18:16:49 INFO - Return code: 0 18:16:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1241cd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16006d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, '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': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:16:49 INFO - Using env: {'DISPLAY': ':0', 18:16:49 INFO - 'HOME': '/home/cltbld', 18:16:49 INFO - 'LANG': 'en_US.UTF-8', 18:16:49 INFO - 'LANGUAGE': 'en_US:en', 18:16:49 INFO - 'LOGNAME': 'cltbld', 18:16:49 INFO - 'MAIL': '/var/mail/cltbld', 18:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:49 INFO - 'MOZ_NO_REMOTE': '1', 18:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:49 INFO - 'NO_EM_RESTART': '1', 18:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:16:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:16:49 INFO - 'SHELL': '/bin/bash', 18:16:49 INFO - 'SHLVL': '1', 18:16:49 INFO - 'TERM': 'linux', 18:16:49 INFO - 'TMOUT': '86400', 18:16:49 INFO - 'USER': 'cltbld', 18:16:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:49 INFO - '_': '/tools/buildbot/bin/python'} 18:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:49 INFO - Downloading/unpacking flake8 18:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:16:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:16:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:16:51 INFO - no previously-included directories found matching 'docs/_build' 18:16:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:16:52 INFO - Running setup.py install for pep8 18:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:16:52 INFO - no previously-included directories found matching 'docs/_build' 18:16:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:16:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:16:52 INFO - Cleaning up... 18:16:52 INFO - Return code: 0 18:16:52 INFO - Running post-action listener: _resource_record_post_action 18:16:52 INFO - Running post-action listener: _start_resource_monitoring 18:16:52 INFO - Starting resource monitoring. 18:16:52 INFO - ##### 18:16:52 INFO - ##### Running install step. 18:16:52 INFO - ##### 18:16:52 INFO - Running pre-action listener: _resource_record_pre_action 18:16:52 INFO - Running main action method: install 18:16:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:16:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:16:52 INFO - Reading from file tmpfile_stdout 18:16:52 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:16:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:16:52 INFO - Reading from file tmpfile_stdout 18:16:52 INFO - Output received: 18:16:52 INFO - Usage: mozinstall [options] installer 18:16:52 INFO - Options: 18:16:52 INFO - -h, --help show this help message and exit 18:16:52 INFO - -d DEST, --destination=DEST 18:16:52 INFO - Directory to install application into. [default: 18:16:52 INFO - "/builds/slave/test-pgo"] 18:16:52 INFO - --app=APP Application being installed. [default: firefox] 18:16:52 INFO - mkdir: /builds/slave/test-pgo/build/application 18:16:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:16:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:17:08 INFO - Reading from file tmpfile_stdout 18:17:08 INFO - Output received: 18:17:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:17:08 INFO - Running post-action listener: _resource_record_post_action 18:17:08 INFO - ##### 18:17:08 INFO - ##### Running run-tests step. 18:17:08 INFO - ##### 18:17:08 INFO - Running pre-action listener: _resource_record_pre_action 18:17:08 INFO - Running main action method: run_tests 18:17:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:17:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:17:08 INFO - Python 2.7.3 18:17:08 INFO - Return code: 0 18:17:08 INFO - grabbing minidump binary from tooltool 18:17: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')]} 18:17:08 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 0x168f920>, '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 0x1690820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:17:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:17:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:17:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:17:08 INFO - Return code: 0 18:17:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:17:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:17:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:17:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:17:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:17:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:17:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:17:09 INFO - Return code: 0 18:17:09 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/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:17:09 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/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:17:09 INFO - Using env: {'DISPLAY': ':0', 18:17:09 INFO - 'HOME': '/home/cltbld', 18:17:09 INFO - 'LANG': 'en_US.UTF-8', 18:17:09 INFO - 'LANGUAGE': 'en_US:en', 18:17:09 INFO - 'LOGNAME': 'cltbld', 18:17:09 INFO - 'MAIL': '/var/mail/cltbld', 18:17:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:17:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:09 INFO - 'MOZ_NO_REMOTE': '1', 18:17:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:09 INFO - 'NO_EM_RESTART': '1', 18:17:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:17:09 INFO - 'PWD': '/builds/slave/test-pgo', 18:17:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:17:09 INFO - 'SHELL': '/bin/bash', 18:17:09 INFO - 'SHLVL': '1', 18:17:09 INFO - 'TERM': 'linux', 18:17:09 INFO - 'TMOUT': '86400', 18:17:09 INFO - 'USER': 'cltbld', 18:17:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046', 18:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:09 INFO - '_': '/tools/buildbot/bin/python'} 18:17:09 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/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:17:10 INFO - mozversion application_buildid: 20160314153957 18:17:10 INFO - mozversion application_changeset: b21c3e5856ae8873a4ee618517c738f579bd2d39 18:17:10 INFO - mozversion application_display_name: Nightly 18:17:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:17:10 INFO - mozversion application_name: Firefox 18:17:10 INFO - mozversion application_remotingname: firefox 18:17:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:17:10 INFO - mozversion application_vendor: Mozilla 18:17:10 INFO - mozversion application_version: 48.0a1 18:17:10 INFO - mozversion platform_buildid: 20160314153957 18:17:10 INFO - mozversion platform_changeset: b21c3e5856ae8873a4ee618517c738f579bd2d39 18:17:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:17:10 INFO - mozversion platform_version: 48.0a1 18:17:10 INFO - using testdate: 1458004630 18:17:10 INFO - actual date: 1458004630 18:17:10 INFO - starting webserver on 'localhost:45098' 18:17:10 INFO - SUITE-START | Running 2 tests 18:17:10 INFO - TEST-START | dromaeo_css 18:17:10 INFO - operating with platform_type : linux_ 18:17:10 INFO - Initialising browser for dromaeo_css test... 18:17:10 INFO - TEST-INFO | started process 3305 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3TUbNs/profile http://localhost:45098/getInfo.html) 18:17:16 INFO - PROCESS | 3305 | __metrics Screen width/height:1600/1200 18:17:16 INFO - PROCESS | 3305 | colorDepth:24 18:17:16 INFO - PROCESS | 3305 | Browser inner width/height: 1024/697 18:17:16 INFO - PROCESS | 3305 | __metrics 18:17:17 ERROR - PROCESS | 3305 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:17:18 INFO - TEST-INFO | 3305: exit 0 18:17:18 INFO - Browser initialized. 18:17:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:17:18 INFO - TEST-INFO | started process 3399 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3TUbNs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:30 INFO - PROCESS | 3399 | RSS: Main: 153501696 18:17:30 INFO - PROCESS | 3399 | 18:18:21 INFO - PROCESS | 3399 | 1458004701845 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:20:28 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:45098/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45098/tests/dromaeo/cssquery-ext.html) 18:20:29 INFO - PROCESS | 3399 | RSS: Main: 247042048 18:20:29 INFO - PROCESS | 3399 | 18:23:31 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:45098/tests/dromaeo/cssquery-ext.html (next: http://localhost:45098/tests/dromaeo/cssquery-jquery.html) 18:23:32 INFO - PROCESS | 3399 | RSS: Main: 234655744 18:23:32 INFO - PROCESS | 3399 | 18:26:34 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:45098/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45098/tests/dromaeo/cssquery-mootools.html) 18:26:34 INFO - PROCESS | 3399 | RSS: Main: 223035392 18:26:34 INFO - PROCESS | 3399 | 18:29:36 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:45098/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45098/tests/dromaeo/cssquery-prototype.html) 18:29:37 INFO - PROCESS | 3399 | RSS: Main: 213307392 18:29:37 INFO - PROCESS | 3399 | 18:32:39 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:45098/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45098/tests/dromaeo/cssquery-yui.html) 18:32:40 INFO - PROCESS | 3399 | RSS: Main: 220299264 18:32:40 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:45098/tests/dromaeo/cssquery-yui.html (next: http://localhost:45098/tests/dromaeo/cssquery-dojo.html) 18:35:42 INFO - PROCESS | 3399 | RSS: Main: 264531968 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | __start_tp_report 18:35:42 INFO - PROCESS | 3399 | _x_x_mozilla_page_load 18:35:42 INFO - PROCESS | 3399 | _x_x_mozilla_page_load_details 18:35:42 INFO - PROCESS | 3399 | |i|pagename|runs| 18:35:42 INFO - PROCESS | 3399 | |0;dojo.html;2966.2732630505525;3028.8788448462064;3044.162855214816;3059.709327613877;3099.7520198384123;5071.213961835912;5222.68663880167;5246.606504512158;5247.370315562129;5251.264822924789;5188.48115188481;5201.0898092833695;5220.556252718514;5226.2944502492155;5287.47125287472;4719.055595910483;4735.408073990742;4784.210605250129;4882.511748825107;4892.730899800509;4691.272852707819;4852.393450818648;4866.416030076396;4883.12103821312;4898;4772.498887616803;4780.808767649272;4792.472827988919;4800.063987522434;4835.419749630032;4753.382060332169;4770.809167633291;4771.165046116916;4784.067106914154;4793.976030119862;4582.450105987269;4714.622830173578;4761.59526440253;4784.330193772875;4806.423229212517;5202.687838729688;5214.687118772886;5225.817096401608;5229.660072095302;5237.633365664405;5600.103983362643;5631.267935168443;5632.3804381518;5640.182173584807;5680.5455563554815;5490.890182196334;5509.641873278224;5562.193481945095;5587.38538760736;5640.576956728261;5192;5226.503482169226;5230.189320655267;5232.450592687789;5239.423663397023;5712.6286791358425;5719.084946408638;5719.113537401709;5723.370429252779;5732.942670573324;5335.306410166653;5458.61789674719;5483.396826349099;5512.614117011851;5512.980098681756;5534.418886016991;5548.4451554845;5564.081926482085;5568.638038527563;5573.303337082864;5362.892742145135;5495.917561236584;5505.697186654773;5507.476789704971;5543.77824887;5456.890862182734;5466.6993315367245;5513.476219759116;5535.252740880011;5562.110062389998;4174.31123864559;4176.373543968369;4176.874693759192;4200.306949353322;4213.5154457237195;3703.2408356286896;3744.9438258426144;3791.6208379161862;3795.3358162321483;3797.35444974355;5240.4497527759795;5270.894582108336;5301.098813201765;5301.522862942354;5301.973490132525;5540.529055030368;5562.694051827189;5563.360213575491;5569.136783798518;5573.386927437979;5130.102232109366;5241.135212689864;5257.263983042377;5260.815871444481;5305.761240744098;4793.209120495149;4806.2310030394965;4818.855434336905;4841.346418233494;4863.10032643962;5669.348024977098;5709.035894926555;5710.172025056344;5711;5722.856928576819;5478.589105817;5528.80649177293;5554.1946417770005;5563.554915606823;5611.130274807329;5720.599558031065;5732.914006289992;5763.625364351304;5779.133130030529;5792.247007889116;5460.863478413072;5462.590305727166;5467.753951072132;5469.425710300361;5473.863153421196;5413.160960051198;5535.169724541351;5542.667439953454;5546.58400619947;5590.2453168821685;5373.865653358697;5420.701861397661;5421.9186712200135;5461.672299662033;5473.014857325719;5348.465153484621;5387.2727181831515;5400.702961337164;5414.269073675004;5420.53925416344;5193.169092945111;5355.30381050461;5358.705271210121;5387.434319396407;5393.541548968225;5458.945410546003;5470.835874923759;5484.2047903053035;5484.698341591251;5529.198266251291;5355.464453554613;5364.973175134255;5367.463253674601;5372.328458942632;5373.247745315581 18:35:42 INFO - PROCESS | 3399 | |1;ext.html;561.2153352339561;569.7578529125121;582.205289779451;602.936691647377;618.0050119307914;29267.268318292052;37860.810695946515;38452.80773596135;38460.42309365362;38538.41193027013;41909.58090419095;42563.57436425635;42597;42598.57401425985;42661.786691066576;7619;7734.690612375498;8544.316454683625;8744.125587441236;10065.446400447972;10097.949510252438;10251.589936402535;10252.743681407987;10256.435896025716;10261.38431694097;10224.897751022507;10323.174146068297;10327.173826093933;10328.845067323997;10330.58677652893;10094.444805535693;10266.12737917278;10274.178065754722;10278.22913281507;10282.434466104361;10140.239482038876;10273.589056437733;10278;10294.073533382032;10623.087844188043;41107.177856443006;41388.37917431241;41408.378874316906;41517.37723934143;41533.79233103845;3589.052042752977;3622.510961020255;3863;4067.89830254246;4397.384366188704;31038.68961310403;31373.84313078443;31398.686013139806;31634.362048364503;32928.6707132928;4278.42241297424;4313.266744653416;4345.217860785057;4465.352523884051;4504.909901801946;309434;309986;310459;311577;314053;47525;48148.5185148144;48164;60450.395496045356;60915.695421523495;49429;49480.75259623751;49702.25446618304;49854;49884;14993.625159371102;15046.172460514557;15046.699066018618;15051.548453546411;15051.774223386657;10984.945075274572;12644.620661380173;12836.229826210458;12843.935780321039;12849.807252891214;15676.529704108894;15703.371865125495;15723.606909827116;15728.370865165265;15757.369705211893;6304.558680892385;6398.776042838478;6405.29541750407;6406.135171751847;6417.935820641827;1062.9415382154057;1065.8081545321916;1082.9891701082888;1127.8533790607169;1236.1223531292883;31805.36389272248;31997.442761817183;32098.679013210036;32795.344093118;32884;1204.566356111799;1225.8467691538558;1239.8388209532702;1246.9438875250635;1289.1620446709715;16526.091064991542;16609.08650024236;16846.578835528966;16906;17019.82980170207;398387.1129020941;398562;403006;404746;405022;55340;56070.15894761582;56105.158422623696;56165;56243.718781405834;1249.6063739921894;1274.4456161569747;1392.658798594371;1402.3128666953119;1422.11118051218;29933.018557153282;30087.097387078422;30908.22729431782;30968.380632386776;31192.844035780585;41223.1755364897;42296.15407691767;42975.140497189255;43265.13469730651;43342.783286083366;267655;268376;268632;269293;270680;31016.224594384417;36023.63976360203;36079.098022549646;36087.45868811917;36242;40560;41373.172536548496;41406.378904315854;41841.58158418377;41956.37065444082;34586.654133458345;34738.305233895684;34849.82575087108;34924;35090.47364289487;34161.48757768586;34689.30621387609;34807.12982175466;34851;34936.30127397489;39158.2168356637;39417.802910985265;39545.80227098846;43021.35467967921;43497;31511.36977260396;32949.83525082455;33042;33119.83440082784;33214.5017824728;26038.479230414905;26388.604170937837;26518.337041573344;26616.733832661426;27054.729452706008 18:35:42 INFO - PROCESS | 3399 | |2;jquery.html;358.8510768031267;365.8975486863678;368.36640977518675;373.5946498049616;381.56120461469305;17789.288428462864;19004.619907601857;19573.510662233435;19940.50148746282;19950.800491995076;18583.163757630904;18711.15799789009;19337.613247735037;19427.514312142204;19476.70784938227;5505.587080968923;5646.632968857031;5667.829965101033;5668;5668.886622267552;4086.693497987663;5678.801241956532;5949.494292985101;6178.783742569011;6199.814005579818;6110.266767987825;6112.358202388752;6133.264008319008;6133.877322453548;6152.600080994721;5954.434328738763;6235;6279.654618995976;6282.937170628281;6290.182276304074;3705.073731567108;5151.484851514856;5317.229001794757;5328.946710532922;5511.5039646432015;21915.232966846084;22553.548929021326;22729.090836366526;22767.203147889744;22789.08843646252;2400.3279081856936;2416.371743346725;2450.387403149213;2673.4385778986243;2740.8903643854223;14147.151170929674;14226.85773142276;14312.713745725132;14424.206668633222;14524.491642792556;1977.7626684797772;1994.9202031918705;1999.950001249966;2038.5311378383055;2059.073416962373;73646.63176684083;74094;74278.25721742767;74717.25282747157;74832;10602.310849794738;10709.410982396043;10887.129029677606;10893.128549716004;11033.448327583588;14116.364763585663;14145.717085658229;14204.71590568183;14212;14231.288435578179;8042.90884370068;8267.338612910953;8290.875636865452;8418.747437576883;8437.367197460093;8231.547264900368;8286.46138001028;8289.58552072394;8362.665493380318;8403.747887563382;6525.3474652535315;6604.1084453599115;6659.600423974577;6684.364985326386;6779.525433219627;1703.7870266216723;1808.7158117736553;1872.9063546822604;1873.1289950173234;1882.6422979633826;1006.6174853555602;1076.311160857052;1100.779844031197;1127.515168477546;1176.858776946772;16982.915085424742;17784.55538611545;18321;18861.339853105077;19009.260591150316;1021.9386836789816;1026.2405819693522;1064.1965316186229;1068.2415485005577;1074.570171931218;10209.489525523693;10679.786404272027;10699.786004280026;10788.78422431547;10931.945340273407;475131;478808;481024;484217;490005;86824;87903.56048219846;90429;91067;92005.53997229971;1065.6003998500562;1096.353151640536;1104.9723756906142;1107.0866535108407;1111.8610173728284;16374.426895058616;16523.33906643721;17087.914560427118;17175.475307008004;17187.484375468757;39478.40782388324;39751;39866.60133398629;39934;40139.59860401358;54364.45635543594;54788.72605637106;54807.725961369935;54995;55119.173212402646;8425.873611895704;8457.281131103926;8492.660293588187;8509.106543813057;8520.914790852012;9514.33399662017;12763.361831908182;12880.613581592566;12902.225866448043;12918.741625167257;11179.944100279772;11238.550457981915;11396.088312935111;11396.829047564459;11402.543898243977;11018.025887397735;11154.219204655596;11332.830007549728;11464.598739044093;11586.652400428;9135;11233.708123565568;11334.489947952197;11621;11885.702857428634;7466.925330746623;7748.845023099394;7801.570913599579;8266.83466330658;8268.958655206685;11364.772704546029;11519.712007199887;11533.653990380302;11614.825777613512;11879.168458207843 18:35:42 INFO - PROCESS | 3399 | |3;mootools.html;1356.9932150339246;1457.672023794646;1476.9261536923154;1642.9424970126047;1817.5092724964268;7368.078990126234;7501.887471687915;7503.962480187605;7507.737229196972;7521.172671006185;7444.478886477948;7581.393488520919;7584.127825300092;7589.203133670968;7589.886151707715;1971.8521110916668;2018.606371757508;2284.977150228501;2316.930492085236;2345.5074434368803;2289.919852805152;2299.620562607168;2300.4363930836967;2300.7929286364224;2300.953980920389;2246.4833088389682;2280.2817112609473;2281.2129815213725;2281.8288628352857;2283.200879692111;2237.865728056322;2256.8645881247094;2262.1743063781682;2303.585354636165;2321.628539433699;2282.988585057064;2284.0521183708743;2305.873176975266;2306.550222706573;2307.307807657696;7663.7317693881005;7713.730019449293;7723.691052357899;7732.149463559061;7732.30409263169;4767.308740232682;4850.83022094225;4856;4859.805607775685;4866.491387669834;3243.4323993301314;3253.2517520970073;3317.270200555874;3350.8157051362164;3362.7309815214726;1090.9890901090967;1115.2360632966445;1124.4040658450951;1133.53525054728;1140.640698180079;10625.20310976672;10707.1434285257;10728.839067413996;10743.355398676105;10747.62383316588;4276.679249056271;4318.093200427946;4331.7834108294455;4373.715708478939;4403.053343531156;8985.865212021825;8990.415622984485;8990.820183596423;9024.232940200156;9041.547922603975;4938.703677779345;4942.283368911488;4942.431620363633;4942.5057494251005;4947.82682606107;3921.3725803871816;4354.042110735633;4402.84590039347;4442.067165895198;4458.9331160032625;3719.590845007047;3829.1384438501113;3833.674137698327;3856.0359910022494;3888.300105980951;1182.8166634171716;1195.1036722458157;1196.0431654676224;1209.9153059285766;1214.6598952293373;1380.2063813307389;1386.5147198480452;1398.0493264580184;1413.1379858286437;1415.0943396226423;7066.92933070673;7209.963950180216;7215.675294611755;7219.061522002106;7228.49400541957;468.29755366949576;472.6478773313903;474.6037059055658;475.3606399392811;479.03713535793304;5463.153211252262;5473.233747275384;5476.370217424967;5522.392536820947;5522.751476183581;9026.909730902738;9186.448813071238;9556.187724043533;9567.091126342986;9574.808503829885;9394.295427842939;9458.148766611039;9473.052694730472;9496;9525.333226674065;7072.646367681596;7128.037714908421;7252.347288743933;7260.709571617076;7262.419006479469;6936.826579335557;6956.5478243913985;6967.477439192182;6981.057557229709;7029.578225306498;8375.62309696053;8448.197421244971;8495.617697203517;8520.14798520143;8664.870026949475;8586.398952073545;8687.261582765535;8747.300215982834;8755.912440875765;8774.122587741174;6333.493320534254;6815.114035175396;6831.9658401707675;6943;7092.219855815753;7401.5189012714;7424.109106907205;7437.330640242404;7439.442041846775;7455.515391499535;6551.967240163769;6777.118974533476;6781.796546103625;6854.554453960476;6856.554323968926;6572.375624315682;6634.270230274762;6679.4656427484715;6682.63245521501;6710.563813352116;7131.108611423572;7185.964070179615;7228.168760592599;7233.855322893618;7251.601161936144;6524.314946930694;6570.934290657032;6572.079908812674;6572.375624315682;6572.868542629216;6546.116274302908;6554.377334153248;6556.18047744032;6558.311377305505;6564.442022427956 18:35:42 INFO - PROCESS | 3399 | |4;prototype.html;325.6613122352753;327.66578090347843;335.2774770369852;337.35396715290216;339.6060569739103;5922.3781502942165;5995.100734889768;6007.909881351783;6019.9999999999945;6056.091586262052;5957.791477298296;5962.135490353896;5965.552583556239;5969.224000879891;5973.133895585138;4335.436393268887;4398.010447649285;4494.617957473619;4521.502634710179;4587.747673877935;4492.61812745917;4502.977485112586;4503.887402814923;4506.504284528699;4524.751138687371;4459.643228541725;4466.642668586522;4467.932981005288;4475.149721552911;4475.507694153641;4331.220380331539;4462.97768511157;4520.050789334244;4545.909081818345;4558.020025694458;3988;3990.221906728189;3997.920041599152;4001.519817621904;4014.9397759033636;5725.599208055438;5748.396418376094;5758.078707406795;5766.826995190151;5773.8556536086935;5271.65734227274;5299.629025968184;5306.124489459235;5312.6281160318795;5313.840584782462;6244.281907580641;6249.468795152417;6250.937490625081;6253.468455181315;6257.624542527417;4188.4555007848785;4310.676699247569;4317.827286908551;4449.866504004885;4450.332450132473;6480.347511384614;6523.347665233486;6570.178727659043;6584.473242140617;6587;4451.087527056946;4453.643708503312;4454.7549884756;4456.6211871991245;4459.554044595579;4515.5484451554585;4516.977415112903;4517.638588912879;4518.457785065813;4519.389882365838;5227.398849132398;5232.424433312409;5233.502817232356;5235.816746413857;5244.475552444801;6093.086037094471;6320.27316858558;6327.96836015817;6329.430351268408;6333.588316759396;1555.4944642991072;1564.5541020809014;1574.4568123997203;1576.4797616786434;1580.2335867104446;983.8573406855966;1047.3925123428546;1059.5073290919759;1076.9461526923621;1090.9509072091776;5907.113932910098;5907.881842363128;5913.852153696192;5926.496247818897;5929.644221346733;6361.745530178833;6363.936360636427;6367.299597044322;6369.33122022181;6479.352064793483;5953.672548009901;5993.760249590055;6002.489788368038;6006.399360064046;6007.669578173242;3432.1762776933856;3467.653234676512;3470.5314782504543;3472.357613841397;3474.1314671332166;6600.570962887493;6677;6755.189377274758;6823.931760682429;6837.726490940307;6690.59856408617;6710.798676039727;6712.395884370332;6716.194056713128;6721.764738234138;6796.8300792479595;6854.417374523221;6879.277675844064;6879.724811007603;6880.2431732508385;6508.60948343101;6550.8362290943105;6561.311062338576;6571.671416429063;6578.868422631424;6259.812205633838;6495.610263384212;6500.512461565307;6502.2443940136845;6504.772332968323;6777.186737591521;6793;6812.931870681428;6813.318668133147;6824.146981627297;4432.756198409118;4435.179491794029;4463.419755431773;4473.261911784519;4475.462944446557;6500.447461965786;6507.511936604868;6509.251436084911;6512.837179070561;6513.185851768529;6121.938780612137;6242.563020588696;6289.993601023814;6304.590201636879;6306.590071645328;6255.499560035278;6283.151774510383;6286.968565157145;6299.244090709144;6302.306746257999;6189.257289125334;6193.84515387119;6198.287196972406;6202.503799695924;6213.720382582885;6326.272478665012;6329.46199573023;6330.303666596763;6332.366763323631;6337.524685648687;5954.821355359346;6018;6190.597611155261;6196.783112591038;6198.659073750987 18:35:42 INFO - PROCESS | 3399 | |5;yui.html;861.7285555050163;883.3595643158711;889.5329951775319;891.1222445890797;903.105925134117;13854.792178117325;14960.251987400627;15118.244087795621;15153.242337883103;15162.924185379057;14071.015028947977;14204.92897535511;14214.431422743104;14230.928845355758;14260.786088208684;688.4389222783416;819.3445243804947;828.1056459024239;830.8546004449228;840.3949156607264;833.7165363776314;839.2530647723531;840.470503582742;841.1588411588411;843.5234092737614;884.3500027479797;884.5798245833242;884.7434244069212;886.6985225023491;894.4677916639589;720.4380583145129;729.7810656802991;869.586946200556;872.4677946452658;893.0845882969975;637.7959053103009;637.8628594852129;637.9744810207633;644.2880616918285;648.9188851393576;14615.123092614476;14629.268536573236;14650.780238296435;14687.971841971066;14698.853011469855;13634.659133521642;13989.510367137204;14480.710385792225;14484.203368814711;14525.491607793781;11776.764464710743;11810.291382517076;11932.821007684892;11943.701407464796;11953.163278570504;3791.450239715226;3808.0437128178887;3853.5761066282685;3867.3425517662067;3902.0830104925603;56687.43312566863;57081.71459142719;57134;57232.42767572313;58358.83282334372;11124.49939752713;11130.16523760705;11156;11246.43767811606;11540.192186547029;20642;20754.377368678965;20789.272375466786;20823.479413014797;20888.895555522427;8147.307478864363;8341.582920853933;8442.409031367746;8526.445781024213;8658.56707164652;4788.784504697297;4822.445418776885;4841.346418233494;4859.95140048602;4975.950240497548;3357.378349569887;3365.0409633254403;3380.983095084509;3384.272381438003;3388.423967925459;572.4395826288154;609.9878002439926;615.4553220399889;617.607819034916;617.7374615788361;708.3270892652001;753.2618034326391;762.710170135345;782.6791015683542;799.2566912771063;9392.95303523478;9639;9891.851622225673;9906.306558540977;9924.50377481123;713.5682911838367;715.720430429085;730.575378012877;730.8867125595541;736.9792836920797;4503.099380123923;4504.121696269196;4629.791659375336;4629.814807407666;4687.718736875799;61823.690881545306;62050.68974655188;62360.37639623637;62419.375806242264;66298;52680.736596316776;54193.1871021935;54421.72789136029;54872.45127548753;55353.446465535635;48573.271400929014;48883;49245.75377123091;49279.50720492749;49444.505554944706;9651.613935442785;9845.488688098369;9986.550605222928;9986.649395252278;10102.39385636864;37078.25843483169;37551.81224093862;38592.61407386002;38860.41709374418;40054.399184012844;46661.533384665716;50132.49867501279;50365.74817126038;50610.49389506205;50738.49261507337;11998.58004969822;12120.93939530332;12242.449089790802;12314.568990085305;12421.565245216374;13530.729385412433;13573.59279221625;13685.794713079511;13873.167609943435;13889.305534723426;12673.93663031679;12889.355532223164;13019.544315949275;13242;13422.463101475832;12740.758463931255;12908.935455322664;13116.868831311565;13139.868601313865;13599.456021759019;12056.321793394181;12079.335636540074;12435.326404823007;12561.43473543711;12733.87266127364;10052.949735251277;10199.490025498844;10233.84649230277;10370.170386369224;10403.271770975958;9488.525573721425;9661.9033809661;9803.852942206015;9809.656662016796;9839.212862971088 18:35:42 INFO - PROCESS | 3399 | __end_tp_report 18:35:42 INFO - PROCESS | 3399 | __start_cc_report 18:35:42 INFO - PROCESS | 3399 | _x_x_mozilla_cycle_collect,753 18:35:42 INFO - PROCESS | 3399 | __end_cc_report 18:35:42 INFO - PROCESS | 3399 | __startTimestamp1458005742671__endTimestamp 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | ------- Summary: start ------- 18:35:42 INFO - PROCESS | 3399 | Number of tests: 6 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | [#0] dojo.html Cycles:165 Average:5171.66 Median:5364.97 stddev:578.02 (10.8%) stddev-sans-first:553.29 18:35:42 INFO - PROCESS | 3399 | Values: 2966.3 3028.9 3044.2 3059.7 3099.8 5071.2 5222.7 5246.6 5247.4 5251.3 5188.5 5201.1 5220.6 5226.3 5287.5 4719.1 4735.4 4784.2 4882.5 4892.7 4691.3 4852.4 4866.4 4883.1 4898.0 4772.5 4780.8 4792.5 4800.1 4835.4 4753.4 4770.8 4771.2 4784.1 4794.0 4582.5 4714.6 4761.6 4784.3 4806.4 5202.7 5214.7 5225.8 5229.7 5237.6 5600.1 5631.3 5632.4 5640.2 5680.5 5490.9 5509.6 5562.2 5587.4 5640.6 5192.0 5226.5 5230.2 5232.5 5239.4 5712.6 5719.1 5719.1 5723.4 5732.9 5335.3 5458.6 5483.4 5512.6 5513.0 5534.4 5548.4 5564.1 5568.6 5573.3 5362.9 5495.9 5505.7 5507.5 5543.8 5456.9 5466.7 5513.5 5535.3 5562.1 4174.3 4176.4 4176.9 4200.3 4213.5 3703.2 3744.9 3791.6 3795.3 3797.4 5240.4 5270.9 5301.1 5301.5 5302.0 5540.5 5562.7 5563.4 5569.1 5573.4 5130.1 5241.1 5257.3 5260.8 5305.8 4793.2 4806.2 4818.9 4841.3 4863.1 5669.3 5709.0 5710.2 5711.0 5722.9 5478.6 5528.8 5554.2 5563.6 5611.1 5720.6 5732.9 5763.6 5779.1 5792.2 5460.9 5462.6 5467.8 5469.4 5473.9 5413.2 5535.2 5542.7 5546.6 5590.2 5373.9 5420.7 5421.9 5461.7 5473.0 5348.5 5387.3 5400.7 5414.3 5420.5 5193.2 5355.3 5358.7 5387.4 5393.5 5458.9 5470.8 5484.2 5484.7 5529.2 5355.5 5365.0 5367.5 5372.3 5373.2 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | [#1] ext.html Cycles:180 Average:49252.91 Median:33080.92 stddev:87129.78 (263.4%) stddev-sans-first:87297.51 18:35:42 INFO - PROCESS | 3399 | Values: 561.2 569.8 582.2 602.9 618.0 29267.3 37860.8 38452.8 38460.4 38538.4 41909.6 42563.6 42597.0 42598.6 42661.8 7619.0 7734.7 8544.3 8744.1 10065.4 10097.9 10251.6 10252.7 10256.4 10261.4 10224.9 10323.2 10327.2 10328.8 10330.6 10094.4 10266.1 10274.2 10278.2 10282.4 10140.2 10273.6 10278.0 10294.1 10623.1 41107.2 41388.4 41408.4 41517.4 41533.8 3589.1 3622.5 3863.0 4067.9 4397.4 31038.7 31373.8 31398.7 31634.4 32928.7 4278.4 4313.3 4345.2 4465.4 4504.9 309434.0 309986.0 310459.0 311577.0 314053.0 47525.0 48148.5 48164.0 60450.4 60915.7 49429.0 49480.8 49702.3 49854.0 49884.0 14993.6 15046.2 15046.7 15051.5 15051.8 10984.9 12644.6 12836.2 12843.9 12849.8 15676.5 15703.4 15723.6 15728.4 15757.4 6304.6 6398.8 6405.3 6406.1 6417.9 1062.9 1065.8 1083.0 1127.9 1236.1 31805.4 31997.4 32098.7 32795.3 32884.0 1204.6 1225.8 1239.8 1246.9 1289.2 16526.1 16609.1 16846.6 16906.0 17019.8 398387.1 398562.0 403006.0 404746.0 405022.0 55340.0 56070.2 56105.2 56165.0 56243.7 1249.6 1274.4 1392.7 1402.3 1422.1 29933.0 30087.1 30908.2 30968.4 31192.8 41223.2 42296.2 42975.1 43265.1 43342.8 267655.0 268376.0 268632.0 269293.0 270680.0 31016.2 36023.6 36079.1 36087.5 36242.0 40560.0 41373.2 41406.4 41841.6 41956.4 34586.7 34738.3 34849.8 34924.0 35090.5 34161.5 34689.3 34807.1 34851.0 34936.3 39158.2 39417.8 39545.8 43021.4 43497.0 31511.4 32949.8 33042.0 33119.8 33214.5 26038.5 26388.6 26518.3 26616.7 27054.7 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | [#2] jquery.html Cycles:180 Average:28391.66 Median:22748.15 stddev:79275.70 (348.5%) stddev-sans-first:79470.14 18:35:42 INFO - PROCESS | 3399 | Values: 358.9 365.9 368.4 373.6 381.6 17789.3 19004.6 19573.5 19940.5 19950.8 18583.2 18711.2 19337.6 19427.5 19476.7 5505.6 5646.6 5667.8 5668.0 5668.9 4086.7 5678.8 5949.5 6178.8 6199.8 6110.3 6112.4 6133.3 6133.9 6152.6 5954.4 6235.0 6279.7 6282.9 6290.2 3705.1 5151.5 5317.2 5328.9 5511.5 21915.2 22553.5 22729.1 22767.2 22789.1 2400.3 2416.4 2450.4 2673.4 2740.9 14147.2 14226.9 14312.7 14424.2 14524.5 1977.8 1994.9 2000.0 2038.5 2059.1 73646.6 74094.0 74278.3 74717.3 74832.0 10602.3 10709.4 10887.1 10893.1 11033.4 14116.4 14145.7 14204.7 14212.0 14231.3 8042.9 8267.3 8290.9 8418.7 8437.4 8231.5 8286.5 8289.6 8362.7 8403.7 6525.3 6604.1 6659.6 6684.4 6779.5 1703.8 1808.7 1872.9 1873.1 1882.6 1006.6 1076.3 1100.8 1127.5 1176.9 16982.9 17784.6 18321.0 18861.3 19009.3 1021.9 1026.2 1064.2 1068.2 1074.6 10209.5 10679.8 10699.8 10788.8 10931.9 475131.0 478808.0 481024.0 484217.0 490005.0 86824.0 87903.6 90429.0 91067.0 92005.5 1065.6 1096.4 1105.0 1107.1 1111.9 16374.4 16523.3 17087.9 17175.5 17187.5 39478.4 39751.0 39866.6 39934.0 40139.6 54364.5 54788.7 54807.7 54995.0 55119.2 8425.9 8457.3 8492.7 8509.1 8520.9 9514.3 12763.4 12880.6 12902.2 12918.7 11179.9 11238.6 11396.1 11396.8 11402.5 11018.0 11154.2 11332.8 11464.6 11586.7 9135.0 11233.7 11334.5 11621.0 11885.7 7466.9 7748.8 7801.6 8266.8 8269.0 11364.8 11519.7 11533.7 11614.8 11879.2 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | [#3] mootools.html Cycles:180 Average:5444.67 Median:6428.90 stddev:2811.37 (43.7%) stddev-sans-first:2802.46 18:35:42 INFO - PROCESS | 3399 | Values: 1357.0 1457.7 1476.9 1642.9 1817.5 7368.1 7501.9 7504.0 7507.7 7521.2 7444.5 7581.4 7584.1 7589.2 7589.9 1971.9 2018.6 2285.0 2316.9 2345.5 2289.9 2299.6 2300.4 2300.8 2301.0 2246.5 2280.3 2281.2 2281.8 2283.2 2237.9 2256.9 2262.2 2303.6 2321.6 2283.0 2284.1 2305.9 2306.6 2307.3 7663.7 7713.7 7723.7 7732.1 7732.3 4767.3 4850.8 4856.0 4859.8 4866.5 3243.4 3253.3 3317.3 3350.8 3362.7 1091.0 1115.2 1124.4 1133.5 1140.6 10625.2 10707.1 10728.8 10743.4 10747.6 4276.7 4318.1 4331.8 4373.7 4403.1 8985.9 8990.4 8990.8 9024.2 9041.5 4938.7 4942.3 4942.4 4942.5 4947.8 3921.4 4354.0 4402.8 4442.1 4458.9 3719.6 3829.1 3833.7 3856.0 3888.3 1182.8 1195.1 1196.0 1209.9 1214.7 1380.2 1386.5 1398.0 1413.1 1415.1 7066.9 7210.0 7215.7 7219.1 7228.5 468.3 472.6 474.6 475.4 479.0 5463.2 5473.2 5476.4 5522.4 5522.8 9026.9 9186.4 9556.2 9567.1 9574.8 9394.3 9458.1 9473.1 9496.0 9525.3 7072.6 7128.0 7252.3 7260.7 7262.4 6936.8 6956.5 6967.5 6981.1 7029.6 8375.6 8448.2 8495.6 8520.1 8664.9 8586.4 8687.3 8747.3 8755.9 8774.1 6333.5 6815.1 6832.0 6943.0 7092.2 7401.5 7424.1 7437.3 7439.4 7455.5 6552.0 6777.1 6781.8 6854.6 6856.6 6572.4 6634.3 6679.5 6682.6 6710.6 7131.1 7186.0 7228.2 7233.9 7251.6 6524.3 6570.9 6572.1 6572.4 6572.9 6546.1 6554.4 6556.2 6558.3 6564.4 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | [#4] prototype.html Cycles:180 Average:5265.51 Median:5971.18 stddev:1598.74 (26.8%) stddev-sans-first:1559.64 18:35:42 INFO - PROCESS | 3399 | Values: 325.7 327.7 335.3 337.4 339.6 5922.4 5995.1 6007.9 6020.0 6056.1 5957.8 5962.1 5965.6 5969.2 5973.1 4335.4 4398.0 4494.6 4521.5 4587.7 4492.6 4503.0 4503.9 4506.5 4524.8 4459.6 4466.6 4467.9 4475.1 4475.5 4331.2 4463.0 4520.1 4545.9 4558.0 3988.0 3990.2 3997.9 4001.5 4014.9 5725.6 5748.4 5758.1 5766.8 5773.9 5271.7 5299.6 5306.1 5312.6 5313.8 6244.3 6249.5 6250.9 6253.5 6257.6 4188.5 4310.7 4317.8 4449.9 4450.3 6480.3 6523.3 6570.2 6584.5 6587.0 4451.1 4453.6 4454.8 4456.6 4459.6 4515.5 4517.0 4517.6 4518.5 4519.4 5227.4 5232.4 5233.5 5235.8 5244.5 6093.1 6320.3 6328.0 6329.4 6333.6 1555.5 1564.6 1574.5 1576.5 1580.2 983.9 1047.4 1059.5 1076.9 1091.0 5907.1 5907.9 5913.9 5926.5 5929.6 6361.7 6363.9 6367.3 6369.3 6479.4 5953.7 5993.8 6002.5 6006.4 6007.7 3432.2 3467.7 3470.5 3472.4 3474.1 6600.6 6677.0 6755.2 6823.9 6837.7 6690.6 6710.8 6712.4 6716.2 6721.8 6796.8 6854.4 6879.3 6879.7 6880.2 6508.6 6550.8 6561.3 6571.7 6578.9 6259.8 6495.6 6500.5 6502.2 6504.8 6777.2 6793.0 6812.9 6813.3 6824.1 4432.8 4435.2 4463.4 4473.3 4475.5 6500.4 6507.5 6509.3 6512.8 6513.2 6121.9 6242.6 6290.0 6304.6 6306.6 6255.5 6283.2 6287.0 6299.2 6302.3 6189.3 6193.8 6198.3 6202.5 6213.7 6326.3 6329.5 6330.3 6332.4 6337.5 5954.8 6018.0 6190.6 6196.8 6198.7 18:35:42 INFO - PROCESS | 3399 | 18:35:42 INFO - PROCESS | 3399 | [#5] yui.html Cycles:180 Average:15271.82 Median:26716.61 stddev:17592.01 (65.8%) stddev-sans-first:17608.07 18:35:42 INFO - PROCESS | 3399 | Values: 861.7 883.4 889.5 891.1 903.1 13854.8 14960.3 15118.2 15153.2 15162.9 14071.0 14204.9 14214.4 14230.9 14260.8 688.4 819.3 828.1 830.9 840.4 833.7 839.3 840.5 841.2 843.5 884.4 884.6 884.7 886.7 894.5 720.4 729.8 869.6 872.5 893.1 637.8 637.9 638.0 644.3 648.9 14615.1 14629.3 14650.8 14688.0 14698.9 13634.7 13989.5 14480.7 14484.2 14525.5 11776.8 11810.3 11932.8 11943.7 11953.2 3791.5 3808.0 3853.6 3867.3 3902.1 56687.4 57081.7 57134.0 57232.4 58358.8 11124.5 11130.2 11156.0 11246.4 11540.2 20642.0 20754.4 20789.3 20823.5 20888.9 8147.3 8341.6 8442.4 8526.4 8658.6 4788.8 4822.4 4841.3 4860.0 4976.0 3357.4 3365.0 3381.0 3384.3 3388.4 572.4 610.0 615.5 617.6 617.7 708.3 753.3 762.7 782.7 799.3 9393.0 9639.0 9891.9 9906.3 9924.5 713.6 715.7 730.6 730.9 737.0 4503.1 4504.1 4629.8 4629.8 4687.7 61823.7 62050.7 62360.4 62419.4 66298.0 52680.7 54193.2 54421.7 54872.5 55353.4 48573.3 48883.0 49245.8 49279.5 49444.5 9651.6 9845.5 9986.6 9986.6 10102.4 37078.3 37551.8 38592.6 38860.4 40054.4 46661.5 50132.5 50365.7 50610.5 50738.5 11998.6 12120.9 12242.4 12314.6 12421.6 13530.7 13573.6 13685.8 13873.2 13889.3 12673.9 12889.4 13019.5 13242.0 13422.5 12740.8 12908.9 13116.9 13139.9 13599.5 12056.3 12079.3 12435.3 12561.4 12733.9 10052.9 10199.5 10233.8 10370.2 10403.3 9488.5 9661.9 9803.9 9809.7 9839.2 18:35:42 INFO - PROCESS | 3399 | -------- Summary: end -------- 18:35:42 INFO - PROCESS | 3399 | 18:35:43 INFO - TEST-INFO | 3399: exit 0 18:35:43 INFO - TEST-OK | dromaeo_css | took 1113102ms 18:35:43 INFO - TEST-START | kraken 18:35:43 INFO - operating with platform_type : linux_ 18:35:43 INFO - Initialising browser for kraken test... 18:35:43 INFO - TEST-INFO | started process 3582 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAzUq8R/profile http://localhost:45098/getInfo.html) 18:35:47 INFO - PROCESS | 3582 | __metrics Screen width/height:1600/1200 18:35:47 INFO - PROCESS | 3582 | colorDepth:24 18:35:47 INFO - PROCESS | 3582 | Browser inner width/height: 1024/697 18:35:47 INFO - PROCESS | 3582 | __metrics 18:35:48 ERROR - PROCESS | 3582 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:35:49 INFO - TEST-INFO | 3582: exit 0 18:35:49 INFO - Browser initialized. 18:35:49 INFO - Running cycle 1/1 for kraken test... 18:35:49 INFO - TEST-INFO | started process 3664 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAzUq8R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:00 INFO - PROCESS | 3664 | RSS: Main: 152641536 18:36:00 INFO - PROCESS | 3664 | 18:36:03 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45098/tests/kraken/driver.html?testName=audio-beat-detection) 18:36:03 INFO - PROCESS | 3664 | RSS: Main: 195137536 18:36:03 INFO - PROCESS | 3664 | 18:36:06 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45098/tests/kraken/driver.html?testName=audio-dft) 18:36:07 INFO - PROCESS | 3664 | RSS: Main: 184758272 18:36:07 INFO - PROCESS | 3664 | 18:36:12 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45098/tests/kraken/driver.html?testName=audio-fft) 18:36:12 INFO - PROCESS | 3664 | RSS: Main: 171974656 18:36:12 INFO - PROCESS | 3664 | 18:36:14 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45098/tests/kraken/driver.html?testName=audio-oscillator) 18:36:15 INFO - PROCESS | 3664 | RSS: Main: 172892160 18:36:15 INFO - PROCESS | 3664 | 18:36:17 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45098/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:36:18 INFO - PROCESS | 3664 | RSS: Main: 172359680 18:36:18 INFO - PROCESS | 3664 | 18:36:21 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45098/tests/kraken/driver.html?testName=imaging-darkroom) 18:36:21 INFO - PROCESS | 3664 | RSS: Main: 174612480 18:36:21 INFO - PROCESS | 3664 | 18:36:25 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45098/tests/kraken/driver.html?testName=imaging-desaturate) 18:36:26 INFO - PROCESS | 3664 | RSS: Main: 172576768 18:36:26 INFO - PROCESS | 3664 | 18:36:29 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45098/tests/kraken/driver.html?testName=json-parse-financial) 18:36:29 INFO - PROCESS | 3664 | RSS: Main: 174039040 18:36:29 INFO - PROCESS | 3664 | 18:36:31 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45098/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:36:31 INFO - PROCESS | 3664 | RSS: Main: 187535360 18:36:31 INFO - PROCESS | 3664 | 18:36:33 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:36:34 INFO - PROCESS | 3664 | RSS: Main: 184573952 18:36:34 INFO - PROCESS | 3664 | 18:36:36 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:36:36 INFO - PROCESS | 3664 | RSS: Main: 194347008 18:36:36 INFO - PROCESS | 3664 | 18:36:39 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:36:39 INFO - PROCESS | 3664 | RSS: Main: 197857280 18:36:39 INFO - PROCESS | 3664 | 18:36:42 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:36:42 INFO - PROCESS | 3664 | RSS: Main: 197251072 18:36:42 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:45098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45098/tests/kraken/driver.html?testName=ai-astar) 18:36:44 INFO - PROCESS | 3664 | RSS: Main: 258441216 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | __start_tp_report 18:36:44 INFO - PROCESS | 3664 | _x_x_mozilla_page_load 18:36:44 INFO - PROCESS | 3664 | _x_x_mozilla_page_load_details 18:36:44 INFO - PROCESS | 3664 | |i|pagename|runs| 18:36:44 INFO - PROCESS | 3664 | |0;ai-astar;110;111;106;110;110;110;100;110;110;109 18:36:44 INFO - PROCESS | 3664 | |1;audio-beat-detection;155;126;152;162;125;148;151;126;165;125 18:36:44 INFO - PROCESS | 3664 | |2;audio-dft;379;378;377;375;378;376;377;378;377;378 18:36:44 INFO - PROCESS | 3664 | |3;audio-fft;72;84;98;95;74;74;75;119;93;72 18:36:44 INFO - PROCESS | 3664 | |4;audio-oscillator;92;93;136;92;94;93;149;91;92;142 18:36:44 INFO - PROCESS | 3664 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 18:36:44 INFO - PROCESS | 3664 | |6;imaging-darkroom;193;193;193;193;192;193;193;194;192;192 18:36:44 INFO - PROCESS | 3664 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;96;96 18:36:44 INFO - PROCESS | 3664 | |8;json-parse-financial;56;55;55;55;57;56;57;63;54;54 18:36:44 INFO - PROCESS | 3664 | |9;json-stringify-tinderbox;58;60;59;59;60;59;60;59;60;59 18:36:44 INFO - PROCESS | 3664 | |10;stanford-crypto-aes;76;84;80;86;78;76;85;77;88;86 18:36:44 INFO - PROCESS | 3664 | |11;stanford-crypto-ccm;113;110;114;109;114;109;107;124;109;125 18:36:44 INFO - PROCESS | 3664 | |12;stanford-crypto-pbkdf2;144;137;150;142;151;144;142;144;144;142 18:36:44 INFO - PROCESS | 3664 | |13;stanford-crypto-sha256-iterative;69;63;64;63;63;62;63;63;63;63 18:36:44 INFO - PROCESS | 3664 | __end_tp_report 18:36:44 INFO - PROCESS | 3664 | __start_cc_report 18:36:44 INFO - PROCESS | 3664 | _x_x_mozilla_cycle_collect,1034 18:36:44 INFO - PROCESS | 3664 | __end_cc_report 18:36:44 INFO - PROCESS | 3664 | __startTimestamp1458005804866__endTimestamp 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | ------- Summary: start ------- 18:36:44 INFO - PROCESS | 3664 | Number of tests: 14 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.31 (3.0%) stddev-sans-first:3.47 18:36:44 INFO - PROCESS | 3664 | Values: 110.0 111.0 106.0 110.0 110.0 110.0 100.0 110.0 110.0 109.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:151.50 stddev:16.27 (10.7%) stddev-sans-first:16.72 18:36:44 INFO - PROCESS | 3664 | Values: 155.0 126.0 152.0 162.0 125.0 148.0 151.0 126.0 165.0 125.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#2] audio-dft Cycles:10 Average:377.30 Median:378.00 stddev:1.16 (0.3%) stddev-sans-first:1.05 18:36:44 INFO - PROCESS | 3664 | Values: 379.0 378.0 377.0 375.0 378.0 376.0 377.0 378.0 377.0 378.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#3] audio-fft Cycles:10 Average:85.60 Median:79.50 stddev:15.51 (19.5%) stddev-sans-first:15.66 18:36:44 INFO - PROCESS | 3664 | Values: 72.0 84.0 98.0 95.0 74.0 74.0 75.0 119.0 93.0 72.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:92.00 stddev:24.31 (26.4%) stddev-sans-first:25.14 18:36:44 INFO - PROCESS | 3664 | Values: 92.0 93.0 136.0 92.0 94.0 93.0 149.0 91.0 92.0 142.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:36:44 INFO - PROCESS | 3664 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#6] imaging-darkroom Cycles:10 Average:192.80 Median:193.00 stddev:0.63 (0.3%) stddev-sans-first:0.67 18:36:44 INFO - PROCESS | 3664 | Values: 193.0 193.0 193.0 193.0 192.0 193.0 193.0 194.0 192.0 192.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:36:44 INFO - PROCESS | 3664 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.62 (4.7%) stddev-sans-first:2.77 18:36:44 INFO - PROCESS | 3664 | Values: 56.0 55.0 55.0 55.0 57.0 56.0 57.0 63.0 54.0 54.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 18:36:44 INFO - PROCESS | 3664 | Values: 58.0 60.0 59.0 59.0 60.0 59.0 60.0 59.0 60.0 59.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:84.50 stddev:4.67 (5.5%) stddev-sans-first:4.49 18:36:44 INFO - PROCESS | 3664 | Values: 76.0 84.0 80.0 86.0 78.0 76.0 85.0 77.0 88.0 86.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:113.50 stddev:6.31 (5.6%) stddev-sans-first:6.69 18:36:44 INFO - PROCESS | 3664 | Values: 113.0 110.0 114.0 109.0 114.0 109.0 107.0 124.0 109.0 125.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:144.00 stddev:4.03 (2.8%) stddev-sans-first:4.27 18:36:44 INFO - PROCESS | 3664 | Values: 144.0 137.0 150.0 142.0 151.0 144.0 142.0 144.0 144.0 142.0 18:36:44 INFO - PROCESS | 3664 | 18:36:44 INFO - PROCESS | 3664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:1.96 (3.1%) stddev-sans-first:0.50 18:36:44 INFO - PROCESS | 3664 | Values: 69.0 63.0 64.0 63.0 63.0 62.0 63.0 63.0 63.0 63.0 18:36:44 INFO - PROCESS | 3664 | -------- Summary: end -------- 18:36:44 INFO - PROCESS | 3664 | 18:36:45 INFO - TEST-INFO | 3664: exit 0 18:36:45 INFO - TEST-OK | kraken | took 62340ms 18:36:45 INFO - SUITE-END | took 1175s 18:36:46 INFO - Completed test suite (00:19:35) 18:36:46 INFO - javascript benchmark 18:36:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2966.2732630505525, 3028.8788448462064, 3044.162855214816, 3059.709327613877, 3099.7520198384123, 5071.213961835912, 5222.68663880167, 5246.606504512158, 5247.370315562129, 5251.264822924789, 5188.48115188481, 5201.0898092833695, 5220.556252718514, 5226.2944502492155, 5287.47125287472, 4719.055595910483, 4735.408073990742, 4784.210605250129, 4882.511748825107, 4892.730899800509, 4691.272852707819, 4852.393450818648, 4866.416030076396, 4883.12103821312, 4898.0, 4772.498887616803, 4780.808767649272, 4792.472827988919, 4800.063987522434, 4835.419749630032, 4753.382060332169, 4770.809167633291, 4771.165046116916, 4784.067106914154, 4793.976030119862, 4582.450105987269, 4714.622830173578, 4761.59526440253, 4784.330193772875, 4806.423229212517, 5202.687838729688, 5214.687118772886, 5225.817096401608, 5229.660072095302, 5237.633365664405, 5600.103983362643, 5631.267935168443, 5632.3804381518, 5640.182173584807, 5680.5455563554815, 5490.890182196334, 5509.641873278224, 5562.193481945095, 5587.38538760736, 5640.576956728261, 5192.0, 5226.503482169226, 5230.189320655267, 5232.450592687789, 5239.423663397023, 5712.6286791358425, 5719.084946408638, 5719.113537401709, 5723.370429252779, 5732.942670573324, 5335.306410166653, 5458.61789674719, 5483.396826349099, 5512.614117011851, 5512.980098681756, 5534.418886016991, 5548.4451554845, 5564.081926482085, 5568.638038527563, 5573.303337082864, 5362.892742145135, 5495.917561236584, 5505.697186654773, 5507.476789704971, 5543.77824887, 5456.890862182734, 5466.6993315367245, 5513.476219759116, 5535.252740880011, 5562.110062389998, 4174.31123864559, 4176.373543968369, 4176.874693759192, 4200.306949353322, 4213.5154457237195, 3703.2408356286896, 3744.9438258426144, 3791.6208379161862, 3795.3358162321483, 3797.35444974355, 5240.4497527759795, 5270.894582108336, 5301.098813201765, 5301.522862942354, 5301.973490132525, 5540.529055030368, 5562.694051827189, 5563.360213575491, 5569.136783798518, 5573.386927437979, 5130.102232109366, 5241.135212689864, 5257.263983042377, 5260.815871444481, 5305.761240744098, 4793.209120495149, 4806.2310030394965, 4818.855434336905, 4841.346418233494, 4863.10032643962, 5669.348024977098, 5709.035894926555, 5710.172025056344, 5711.0, 5722.856928576819, 5478.589105817, 5528.80649177293, 5554.1946417770005, 5563.554915606823, 5611.130274807329, 5720.599558031065, 5732.914006289992, 5763.625364351304, 5779.133130030529, 5792.247007889116, 5460.863478413072, 5462.590305727166, 5467.753951072132, 5469.425710300361, 5473.863153421196, 5413.160960051198, 5535.169724541351, 5542.667439953454, 5546.58400619947, 5590.2453168821685, 5373.865653358697, 5420.701861397661, 5421.9186712200135, 5461.672299662033, 5473.014857325719, 5348.465153484621, 5387.2727181831515, 5400.702961337164, 5414.269073675004, 5420.53925416344, 5193.169092945111, 5355.30381050461, 5358.705271210121, 5387.434319396407, 5393.541548968225, 5458.945410546003, 5470.835874923759, 5484.2047903053035, 5484.698341591251, 5529.198266251291, 5355.464453554613, 5364.973175134255, 5367.463253674601, 5372.328458942632, 5373.247745315581], "unit": "score", "name": "dojo.html", "value": 5133.037338632445}, {"lowerIsBetter": false, "replicates": [561.2153352339561, 569.7578529125121, 582.205289779451, 602.936691647377, 618.0050119307914, 29267.268318292052, 37860.810695946515, 38452.80773596135, 38460.42309365362, 38538.41193027013, 41909.58090419095, 42563.57436425635, 42597.0, 42598.57401425985, 42661.786691066576, 7619.0, 7734.690612375498, 8544.316454683625, 8744.125587441236, 10065.446400447972, 10097.949510252438, 10251.589936402535, 10252.743681407987, 10256.435896025716, 10261.38431694097, 10224.897751022507, 10323.174146068297, 10327.173826093933, 10328.845067323997, 10330.58677652893, 10094.444805535693, 10266.12737917278, 10274.178065754722, 10278.22913281507, 10282.434466104361, 10140.239482038876, 10273.589056437733, 10278.0, 10294.073533382032, 10623.087844188043, 41107.177856443006, 41388.37917431241, 41408.378874316906, 41517.37723934143, 41533.79233103845, 3589.052042752977, 3622.510961020255, 3863.0, 4067.89830254246, 4397.384366188704, 31038.68961310403, 31373.84313078443, 31398.686013139806, 31634.362048364503, 32928.6707132928, 4278.42241297424, 4313.266744653416, 4345.217860785057, 4465.352523884051, 4504.909901801946, 309434.0, 309986.0, 310459.0, 311577.0, 314053.0, 47525.0, 48148.5185148144, 48164.0, 60450.395496045356, 60915.695421523495, 49429.0, 49480.75259623751, 49702.25446618304, 49854.0, 49884.0, 14993.625159371102, 15046.172460514557, 15046.699066018618, 15051.548453546411, 15051.774223386657, 10984.945075274572, 12644.620661380173, 12836.229826210458, 12843.935780321039, 12849.807252891214, 15676.529704108894, 15703.371865125495, 15723.606909827116, 15728.370865165265, 15757.369705211893, 6304.558680892385, 6398.776042838478, 6405.29541750407, 6406.135171751847, 6417.935820641827, 1062.9415382154057, 1065.8081545321916, 1082.9891701082888, 1127.8533790607169, 1236.1223531292883, 31805.36389272248, 31997.442761817183, 32098.679013210036, 32795.344093118, 32884.0, 1204.566356111799, 1225.8467691538558, 1239.8388209532702, 1246.9438875250635, 1289.1620446709715, 16526.091064991542, 16609.08650024236, 16846.578835528966, 16906.0, 17019.82980170207, 398387.1129020941, 398562.0, 403006.0, 404746.0, 405022.0, 55340.0, 56070.15894761582, 56105.158422623696, 56165.0, 56243.718781405834, 1249.6063739921894, 1274.4456161569747, 1392.658798594371, 1402.3128666953119, 1422.11118051218, 29933.018557153282, 30087.097387078422, 30908.22729431782, 30968.380632386776, 31192.844035780585, 41223.1755364897, 42296.15407691767, 42975.140497189255, 43265.13469730651, 43342.783286083366, 267655.0, 268376.0, 268632.0, 269293.0, 270680.0, 31016.224594384417, 36023.63976360203, 36079.098022549646, 36087.45868811917, 36242.0, 40560.0, 41373.172536548496, 41406.378904315854, 41841.58158418377, 41956.37065444082, 34586.654133458345, 34738.305233895684, 34849.82575087108, 34924.0, 35090.47364289487, 34161.48757768586, 34689.30621387609, 34807.12982175466, 34851.0, 34936.30127397489, 39158.2168356637, 39417.802910985265, 39545.80227098846, 43021.35467967921, 43497.0, 31511.36977260396, 32949.83525082455, 33042.0, 33119.83440082784, 33214.5017824728, 26038.479230414905, 26388.604170937837, 26518.337041573344, 26616.733832661426, 27054.729452706008], "unit": "score", "name": "ext.html", "value": 19171.719329800893}, {"lowerIsBetter": false, "replicates": [358.8510768031267, 365.8975486863678, 368.36640977518675, 373.5946498049616, 381.56120461469305, 17789.288428462864, 19004.619907601857, 19573.510662233435, 19940.50148746282, 19950.800491995076, 18583.163757630904, 18711.15799789009, 19337.613247735037, 19427.514312142204, 19476.70784938227, 5505.587080968923, 5646.632968857031, 5667.829965101033, 5668.0, 5668.886622267552, 4086.693497987663, 5678.801241956532, 5949.494292985101, 6178.783742569011, 6199.814005579818, 6110.266767987825, 6112.358202388752, 6133.264008319008, 6133.877322453548, 6152.600080994721, 5954.434328738763, 6235.0, 6279.654618995976, 6282.937170628281, 6290.182276304074, 3705.073731567108, 5151.484851514856, 5317.229001794757, 5328.946710532922, 5511.5039646432015, 21915.232966846084, 22553.548929021326, 22729.090836366526, 22767.203147889744, 22789.08843646252, 2400.3279081856936, 2416.371743346725, 2450.387403149213, 2673.4385778986243, 2740.8903643854223, 14147.151170929674, 14226.85773142276, 14312.713745725132, 14424.206668633222, 14524.491642792556, 1977.7626684797772, 1994.9202031918705, 1999.950001249966, 2038.5311378383055, 2059.073416962373, 73646.63176684083, 74094.0, 74278.25721742767, 74717.25282747157, 74832.0, 10602.310849794738, 10709.410982396043, 10887.129029677606, 10893.128549716004, 11033.448327583588, 14116.364763585663, 14145.717085658229, 14204.71590568183, 14212.0, 14231.288435578179, 8042.90884370068, 8267.338612910953, 8290.875636865452, 8418.747437576883, 8437.367197460093, 8231.547264900368, 8286.46138001028, 8289.58552072394, 8362.665493380318, 8403.747887563382, 6525.3474652535315, 6604.1084453599115, 6659.600423974577, 6684.364985326386, 6779.525433219627, 1703.7870266216723, 1808.7158117736553, 1872.9063546822604, 1873.1289950173234, 1882.6422979633826, 1006.6174853555602, 1076.311160857052, 1100.779844031197, 1127.515168477546, 1176.858776946772, 16982.915085424742, 17784.55538611545, 18321.0, 18861.339853105077, 19009.260591150316, 1021.9386836789816, 1026.2405819693522, 1064.1965316186229, 1068.2415485005577, 1074.570171931218, 10209.489525523693, 10679.786404272027, 10699.786004280026, 10788.78422431547, 10931.945340273407, 475131.0, 478808.0, 481024.0, 484217.0, 490005.0, 86824.0, 87903.56048219846, 90429.0, 91067.0, 92005.53997229971, 1065.6003998500562, 1096.353151640536, 1104.9723756906142, 1107.0866535108407, 1111.8610173728284, 16374.426895058616, 16523.33906643721, 17087.914560427118, 17175.475307008004, 17187.484375468757, 39478.40782388324, 39751.0, 39866.60133398629, 39934.0, 40139.59860401358, 54364.45635543594, 54788.72605637106, 54807.725961369935, 54995.0, 55119.173212402646, 8425.873611895704, 8457.281131103926, 8492.660293588187, 8509.106543813057, 8520.914790852012, 9514.33399662017, 12763.361831908182, 12880.613581592566, 12902.225866448043, 12918.741625167257, 11179.944100279772, 11238.550457981915, 11396.088312935111, 11396.829047564459, 11402.543898243977, 11018.025887397735, 11154.219204655596, 11332.830007549728, 11464.598739044093, 11586.652400428, 9135.0, 11233.708123565568, 11334.489947952197, 11621.0, 11885.702857428634, 7466.925330746623, 7748.845023099394, 7801.570913599579, 8266.83466330658, 8268.958655206685, 11364.772704546029, 11519.712007199887, 11533.653990380302, 11614.825777613512, 11879.168458207843], "unit": "score", "name": "jquery.html", "value": 9280.6710946759}, {"lowerIsBetter": false, "replicates": [1356.9932150339246, 1457.672023794646, 1476.9261536923154, 1642.9424970126047, 1817.5092724964268, 7368.078990126234, 7501.887471687915, 7503.962480187605, 7507.737229196972, 7521.172671006185, 7444.478886477948, 7581.393488520919, 7584.127825300092, 7589.203133670968, 7589.886151707715, 1971.8521110916668, 2018.606371757508, 2284.977150228501, 2316.930492085236, 2345.5074434368803, 2289.919852805152, 2299.620562607168, 2300.4363930836967, 2300.7929286364224, 2300.953980920389, 2246.4833088389682, 2280.2817112609473, 2281.2129815213725, 2281.8288628352857, 2283.200879692111, 2237.865728056322, 2256.8645881247094, 2262.1743063781682, 2303.585354636165, 2321.628539433699, 2282.988585057064, 2284.0521183708743, 2305.873176975266, 2306.550222706573, 2307.307807657696, 7663.7317693881005, 7713.730019449293, 7723.691052357899, 7732.149463559061, 7732.30409263169, 4767.308740232682, 4850.83022094225, 4856.0, 4859.805607775685, 4866.491387669834, 3243.4323993301314, 3253.2517520970073, 3317.270200555874, 3350.8157051362164, 3362.7309815214726, 1090.9890901090967, 1115.2360632966445, 1124.4040658450951, 1133.53525054728, 1140.640698180079, 10625.20310976672, 10707.1434285257, 10728.839067413996, 10743.355398676105, 10747.62383316588, 4276.679249056271, 4318.093200427946, 4331.7834108294455, 4373.715708478939, 4403.053343531156, 8985.865212021825, 8990.415622984485, 8990.820183596423, 9024.232940200156, 9041.547922603975, 4938.703677779345, 4942.283368911488, 4942.431620363633, 4942.5057494251005, 4947.82682606107, 3921.3725803871816, 4354.042110735633, 4402.84590039347, 4442.067165895198, 4458.9331160032625, 3719.590845007047, 3829.1384438501113, 3833.674137698327, 3856.0359910022494, 3888.300105980951, 1182.8166634171716, 1195.1036722458157, 1196.0431654676224, 1209.9153059285766, 1214.6598952293373, 1380.2063813307389, 1386.5147198480452, 1398.0493264580184, 1413.1379858286437, 1415.0943396226423, 7066.92933070673, 7209.963950180216, 7215.675294611755, 7219.061522002106, 7228.49400541957, 468.29755366949576, 472.6478773313903, 474.6037059055658, 475.3606399392811, 479.03713535793304, 5463.153211252262, 5473.233747275384, 5476.370217424967, 5522.392536820947, 5522.751476183581, 9026.909730902738, 9186.448813071238, 9556.187724043533, 9567.091126342986, 9574.808503829885, 9394.295427842939, 9458.148766611039, 9473.052694730472, 9496.0, 9525.333226674065, 7072.646367681596, 7128.037714908421, 7252.347288743933, 7260.709571617076, 7262.419006479469, 6936.826579335557, 6956.5478243913985, 6967.477439192182, 6981.057557229709, 7029.578225306498, 8375.62309696053, 8448.197421244971, 8495.617697203517, 8520.14798520143, 8664.870026949475, 8586.398952073545, 8687.261582765535, 8747.300215982834, 8755.912440875765, 8774.122587741174, 6333.493320534254, 6815.114035175396, 6831.9658401707675, 6943.0, 7092.219855815753, 7401.5189012714, 7424.109106907205, 7437.330640242404, 7439.442041846775, 7455.515391499535, 6551.967240163769, 6777.118974533476, 6781.796546103625, 6854.554453960476, 6856.554323968926, 6572.375624315682, 6634.270230274762, 6679.4656427484715, 6682.63245521501, 6710.563813352116, 7131.108611423572, 7185.964070179615, 7228.168760592599, 7233.855322893618, 7251.601161936144, 6524.314946930694, 6570.934290657032, 6572.079908812674, 6572.375624315682, 6572.868542629216, 6546.116274302908, 6554.377334153248, 6556.18047744032, 6558.311377305505, 6564.442022427956], "unit": "score", "name": "mootools.html", "value": 4426.928040029926}, {"lowerIsBetter": false, "replicates": [325.6613122352753, 327.66578090347843, 335.2774770369852, 337.35396715290216, 339.6060569739103, 5922.3781502942165, 5995.100734889768, 6007.909881351783, 6019.9999999999945, 6056.091586262052, 5957.791477298296, 5962.135490353896, 5965.552583556239, 5969.224000879891, 5973.133895585138, 4335.436393268887, 4398.010447649285, 4494.617957473619, 4521.502634710179, 4587.747673877935, 4492.61812745917, 4502.977485112586, 4503.887402814923, 4506.504284528699, 4524.751138687371, 4459.643228541725, 4466.642668586522, 4467.932981005288, 4475.149721552911, 4475.507694153641, 4331.220380331539, 4462.97768511157, 4520.050789334244, 4545.909081818345, 4558.020025694458, 3988.0, 3990.221906728189, 3997.920041599152, 4001.519817621904, 4014.9397759033636, 5725.599208055438, 5748.396418376094, 5758.078707406795, 5766.826995190151, 5773.8556536086935, 5271.65734227274, 5299.629025968184, 5306.124489459235, 5312.6281160318795, 5313.840584782462, 6244.281907580641, 6249.468795152417, 6250.937490625081, 6253.468455181315, 6257.624542527417, 4188.4555007848785, 4310.676699247569, 4317.827286908551, 4449.866504004885, 4450.332450132473, 6480.347511384614, 6523.347665233486, 6570.178727659043, 6584.473242140617, 6587.0, 4451.087527056946, 4453.643708503312, 4454.7549884756, 4456.6211871991245, 4459.554044595579, 4515.5484451554585, 4516.977415112903, 4517.638588912879, 4518.457785065813, 4519.389882365838, 5227.398849132398, 5232.424433312409, 5233.502817232356, 5235.816746413857, 5244.475552444801, 6093.086037094471, 6320.27316858558, 6327.96836015817, 6329.430351268408, 6333.588316759396, 1555.4944642991072, 1564.5541020809014, 1574.4568123997203, 1576.4797616786434, 1580.2335867104446, 983.8573406855966, 1047.3925123428546, 1059.5073290919759, 1076.9461526923621, 1090.9509072091776, 5907.113932910098, 5907.881842363128, 5913.852153696192, 5926.496247818897, 5929.644221346733, 6361.745530178833, 6363.936360636427, 6367.299597044322, 6369.33122022181, 6479.352064793483, 5953.672548009901, 5993.760249590055, 6002.489788368038, 6006.399360064046, 6007.669578173242, 3432.1762776933856, 3467.653234676512, 3470.5314782504543, 3472.357613841397, 3474.1314671332166, 6600.570962887493, 6677.0, 6755.189377274758, 6823.931760682429, 6837.726490940307, 6690.59856408617, 6710.798676039727, 6712.395884370332, 6716.194056713128, 6721.764738234138, 6796.8300792479595, 6854.417374523221, 6879.277675844064, 6879.724811007603, 6880.2431732508385, 6508.60948343101, 6550.8362290943105, 6561.311062338576, 6571.671416429063, 6578.868422631424, 6259.812205633838, 6495.610263384212, 6500.512461565307, 6502.2443940136845, 6504.772332968323, 6777.186737591521, 6793.0, 6812.931870681428, 6813.318668133147, 6824.146981627297, 4432.756198409118, 4435.179491794029, 4463.419755431773, 4473.261911784519, 4475.462944446557, 6500.447461965786, 6507.511936604868, 6509.251436084911, 6512.837179070561, 6513.185851768529, 6121.938780612137, 6242.563020588696, 6289.993601023814, 6304.590201636879, 6306.590071645328, 6255.499560035278, 6283.151774510383, 6286.968565157145, 6299.244090709144, 6302.306746257999, 6189.257289125334, 6193.84515387119, 6198.287196972406, 6202.503799695924, 6213.720382582885, 6326.272478665012, 6329.46199573023, 6330.303666596763, 6332.366763323631, 6337.524685648687, 5954.821355359346, 6018.0, 6190.597611155261, 6196.783112591038, 6198.659073750987], "unit": "score", "name": "prototype.html", "value": 4743.718156315172}, {"lowerIsBetter": false, "replicates": [861.7285555050163, 883.3595643158711, 889.5329951775319, 891.1222445890797, 903.105925134117, 13854.792178117325, 14960.251987400627, 15118.244087795621, 15153.242337883103, 15162.924185379057, 14071.015028947977, 14204.92897535511, 14214.431422743104, 14230.928845355758, 14260.786088208684, 688.4389222783416, 819.3445243804947, 828.1056459024239, 830.8546004449228, 840.3949156607264, 833.7165363776314, 839.2530647723531, 840.470503582742, 841.1588411588411, 843.5234092737614, 884.3500027479797, 884.5798245833242, 884.7434244069212, 886.6985225023491, 894.4677916639589, 720.4380583145129, 729.7810656802991, 869.586946200556, 872.4677946452658, 893.0845882969975, 637.7959053103009, 637.8628594852129, 637.9744810207633, 644.2880616918285, 648.9188851393576, 14615.123092614476, 14629.268536573236, 14650.780238296435, 14687.971841971066, 14698.853011469855, 13634.659133521642, 13989.510367137204, 14480.710385792225, 14484.203368814711, 14525.491607793781, 11776.764464710743, 11810.291382517076, 11932.821007684892, 11943.701407464796, 11953.163278570504, 3791.450239715226, 3808.0437128178887, 3853.5761066282685, 3867.3425517662067, 3902.0830104925603, 56687.43312566863, 57081.71459142719, 57134.0, 57232.42767572313, 58358.83282334372, 11124.49939752713, 11130.16523760705, 11156.0, 11246.43767811606, 11540.192186547029, 20642.0, 20754.377368678965, 20789.272375466786, 20823.479413014797, 20888.895555522427, 8147.307478864363, 8341.582920853933, 8442.409031367746, 8526.445781024213, 8658.56707164652, 4788.784504697297, 4822.445418776885, 4841.346418233494, 4859.95140048602, 4975.950240497548, 3357.378349569887, 3365.0409633254403, 3380.983095084509, 3384.272381438003, 3388.423967925459, 572.4395826288154, 609.9878002439926, 615.4553220399889, 617.607819034916, 617.7374615788361, 708.3270892652001, 753.2618034326391, 762.710170135345, 782.6791015683542, 799.2566912771063, 9392.95303523478, 9639.0, 9891.851622225673, 9906.306558540977, 9924.50377481123, 713.5682911838367, 715.720430429085, 730.575378012877, 730.8867125595541, 736.9792836920797, 4503.099380123923, 4504.121696269196, 4629.791659375336, 4629.814807407666, 4687.718736875799, 61823.690881545306, 62050.68974655188, 62360.37639623637, 62419.375806242264, 66298.0, 52680.736596316776, 54193.1871021935, 54421.72789136029, 54872.45127548753, 55353.446465535635, 48573.271400929014, 48883.0, 49245.75377123091, 49279.50720492749, 49444.505554944706, 9651.613935442785, 9845.488688098369, 9986.550605222928, 9986.649395252278, 10102.39385636864, 37078.25843483169, 37551.81224093862, 38592.61407386002, 38860.41709374418, 40054.399184012844, 46661.533384665716, 50132.49867501279, 50365.74817126038, 50610.49389506205, 50738.49261507337, 11998.58004969822, 12120.93939530332, 12242.449089790802, 12314.568990085305, 12421.565245216374, 13530.729385412433, 13573.59279221625, 13685.794713079511, 13873.167609943435, 13889.305534723426, 12673.93663031679, 12889.355532223164, 13019.544315949275, 13242.0, 13422.463101475832, 12740.758463931255, 12908.935455322664, 13116.868831311565, 13139.868601313865, 13599.456021759019, 12056.321793394181, 12079.335636540074, 12435.326404823007, 12561.43473543711, 12733.87266127364, 10052.949735251277, 10199.490025498844, 10233.84649230277, 10370.170386369224, 10403.271770975958, 9488.525573721425, 9661.9033809661, 9803.852942206015, 9809.656662016796, 9839.212862971088], "unit": "score", "name": "yui.html", "value": 6919.353002119628}], "name": "dromaeo_css", "value": 7142.066430323773}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 110.0, 110.0, 100.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 152.0, 162.0, 125.0, 148.0, 151.0, 126.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [379.0, 378.0, 377.0, 375.0, 378.0, 376.0, 377.0, 378.0, 377.0, 378.0], "unit": "score", "name": "audio-dft", "value": 377.3}, {"lowerIsBetter": true, "replicates": [72.0, 84.0, 98.0, 95.0, 74.0, 74.0, 75.0, 119.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 136.0, 92.0, 94.0, 93.0, 149.0, 91.0, 92.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [193.0, 193.0, 193.0, 193.0, 192.0, 193.0, 193.0, 194.0, 192.0, 192.0], "unit": "score", "name": "imaging-darkroom", "value": 192.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 57.0, 56.0, 57.0, 63.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.3}, {"lowerIsBetter": true, "replicates": [76.0, 84.0, 80.0, 86.0, 78.0, 76.0, 85.0, 77.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 114.0, 109.0, 114.0, 109.0, 107.0, 124.0, 109.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [144.0, 137.0, 150.0, 142.0, 151.0, 144.0, 142.0, 144.0, 144.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [69.0, 63.0, 64.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.6}], "name": "kraken", "value": 1745.5}]} 18:36:46 INFO - Return code: 0 18:36:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:36:46 ERROR - # TBPL SUCCESS # 18:36:46 INFO - Running post-action listener: _resource_record_post_action 18:36:46 INFO - Running post-run listener: _resource_record_post_run 18:36:47 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 10362880; Write bytes: 379437056; Read time: 2072; Write time: 304280 18:36:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 40960; Write bytes: 95326208; Read time: 240; Write time: 69504 18:36:47 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8560640; Write bytes: 284110848; Read time: 1792; Write time: 234776 18:36:47 INFO - Running post-run listener: _upload_blobber_files 18:36:47 INFO - Blob upload gear active. 18:36:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:36:47 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 18:36:47 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'] 18:36:47 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 18:36:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:48 INFO - (blobuploader) - INFO - Done attempting. 18:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 18:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:36:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:49 INFO - (blobuploader) - INFO - Done attempting. 18:36:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:36:49 INFO - Return code: 0 18:36:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:36:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:36:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45508ce60b4ad03088c43be2fc9507df1bb34f8a40efd71840b30618558915166683ac617f81827fefdcbd9084b6de0594832a21f0d095dc6aa15d58ff2a01b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a48ae7ebc1045257abb152d2dc7b8790e24e9ae3ad1eef7e0e8d37882161f6b265886c5307a20626b6b72d0c9b1f0939363773e9b4e3cfcab76d95f37a6a222b"} 18:36:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:36:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:36:49 INFO - Contents: 18:36:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45508ce60b4ad03088c43be2fc9507df1bb34f8a40efd71840b30618558915166683ac617f81827fefdcbd9084b6de0594832a21f0d095dc6aa15d58ff2a01b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a48ae7ebc1045257abb152d2dc7b8790e24e9ae3ad1eef7e0e8d37882161f6b265886c5307a20626b6b72d0c9b1f0939363773e9b4e3cfcab76d95f37a6a222b"} 18:36:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:36:49 INFO - Copying logs to upload dir... 18:36:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 18:36:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.798424 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-14 18:36:49.127526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 18:36:49.130747) ========= 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 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/45508ce60b4ad03088c43be2fc9507df1bb34f8a40efd71840b30618558915166683ac617f81827fefdcbd9084b6de0594832a21f0d095dc6aa15d58ff2a01b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a48ae7ebc1045257abb152d2dc7b8790e24e9ae3ad1eef7e0e8d37882161f6b265886c5307a20626b6b72d0c9b1f0939363773e9b4e3cfcab76d95f37a6a222b"} build_url:https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/QPkJn3SpR-mLHXyob-6Kzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45508ce60b4ad03088c43be2fc9507df1bb34f8a40efd71840b30618558915166683ac617f81827fefdcbd9084b6de0594832a21f0d095dc6aa15d58ff2a01b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a48ae7ebc1045257abb152d2dc7b8790e24e9ae3ad1eef7e0e8d37882161f6b265886c5307a20626b6b72d0c9b1f0939363773e9b4e3cfcab76d95f37a6a222b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 18:36:49.156330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:36:49.156707) ========= 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=0333a256a5e4f052382dd180000001b1-1458003386.319103-1641953046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004932 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:36:49.239700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 18:36:49.240064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 18:36:49.240439) ========= ========= Total master_lag: 1.17 =========