builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1450410279.37 results: success (0) buildid: 20151217173001 builduid: b96c6d39aa53421db69d08b0e202a113 revision: e1ce5b4fa814367b46379641a77f06eabd9348ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.371086) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.371629) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.371941) ========= 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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.396929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.397290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.411474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.411917) ========= 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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.463016) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.463393) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.463774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.464083) ========= 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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 19:44:39-- 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% 222M=0s 2015-12-17 19:44:39 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.665101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.665408) ========= 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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016725 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.715662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.716020) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1ce5b4fa814367b46379641a77f06eabd9348ed --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 e1ce5b4fa814367b46379641a77f06eabd9348ed --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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 19:44:39,834 truncating revision to first 12 chars 2015-12-17 19:44:39,834 Setting DEBUG logging. 2015-12-17 19:44:39,834 attempt 1/10 2015-12-17 19:44:39,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1ce5b4fa814?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 19:44:40,097 unpacking tar archive at: fx-team-e1ce5b4fa814/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.279149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.279440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.289423) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.289727) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.290173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-17 19:44:40.290496) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:44:40 INFO - MultiFileLogger online at 20151217 19:44:40 in /builds/slave/test-pgo 19:44:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:44:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:44:40 INFO - {'append_to_log': False, 19:44:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:44:40 INFO - 'blob_upload_branch': 'Fx-Team', 19:44:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:44:40 INFO - 'branch': 'Fx-Team', 19:44:40 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:40 INFO - 'config_files': ('talos/linux_config.py',), 19:44:40 INFO - 'default_actions': ('clobber', 19:44:40 INFO - 'read-buildbot-config', 19:44:40 INFO - 'download-and-extract', 19:44:40 INFO - 'populate-webroot', 19:44:40 INFO - 'create-virtualenv', 19:44:40 INFO - 'install', 19:44:40 INFO - 'run-tests'), 19:44:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:40 INFO - 'download_minidump_stackwalk': True, 19:44:40 INFO - 'download_symbols': 'ondemand', 19:44:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:44:40 INFO - 'tooltool.py': '/tools/tooltool.py', 19:44:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:44:40 INFO - '/tools/misc-python/virtualenv.py')}, 19:44:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:40 INFO - 'installer_path': 'installer.exe', 19:44:40 INFO - 'log_level': 'info', 19:44:40 INFO - 'log_name': 'talos', 19:44:40 INFO - 'log_to_console': True, 19:44:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:44:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:44:40 INFO - 'opt_config_files': (), 19:44:40 INFO - 'pip_index': False, 19:44:40 INFO - 'sps_profile': False, 19:44:40 INFO - 'sps_profile_interval': 0, 19:44:40 INFO - 'suite': 'dromaeojs-e10s', 19:44:40 INFO - 'system_bits': '64', 19:44:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:40 INFO - 'title': 'talos-linux64-ix-031', 19:44:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:44:40 INFO - 'use_talos_json': True, 19:44:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:44:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:40 INFO - 'work_dir': 'build'} 19:44:40 INFO - ##### 19:44:40 INFO - ##### Running clobber step. 19:44:40 INFO - ##### 19:44:40 INFO - Running pre-action listener: _resource_record_pre_action 19:44:40 INFO - Running main action method: clobber 19:44:40 INFO - rmtree: /builds/slave/test-pgo/build 19:44:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:44:40 INFO - Running post-action listener: _resource_record_post_action 19:44:40 INFO - ##### 19:44:40 INFO - ##### Running read-buildbot-config step. 19:44:40 INFO - ##### 19:44:40 INFO - Running pre-action listener: _resource_record_pre_action 19:44:40 INFO - Running main action method: read_buildbot_config 19:44:40 INFO - Using buildbot properties: 19:44:40 INFO - { 19:44:40 INFO - "project": "", 19:44:40 INFO - "product": "firefox", 19:44:40 INFO - "script_repo_revision": "production", 19:44:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:44:40 INFO - "repository": "", 19:44:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:44:40 INFO - "buildid": "20151217173001", 19:44:40 INFO - "pgo_build": "True", 19:44:40 INFO - "basedir": "/builds/slave/test-pgo", 19:44:40 INFO - "buildnumber": 392, 19:44:40 INFO - "slavename": "talos-linux64-ix-031", 19:44:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:44:40 INFO - "platform": "ubuntu64_hw", 19:44:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:44:40 INFO - "branch": "fx-team", 19:44:40 INFO - "repo_path": "integration/fx-team", 19:44:40 INFO - "revision": "e1ce5b4fa814367b46379641a77f06eabd9348ed", 19:44:40 INFO - "stage_platform": "linux64-pgo", 19:44:40 INFO - "builduid": "b96c6d39aa53421db69d08b0e202a113", 19:44:40 INFO - "slavebuilddir": "test" 19:44:40 INFO - } 19:44:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:44:40 INFO - Running post-action listener: _resource_record_post_action 19:44:40 INFO - ##### 19:44:40 INFO - ##### Running download-and-extract step. 19:44:40 INFO - ##### 19:44:40 INFO - Running pre-action listener: _resource_record_pre_action 19:44:40 INFO - Running main action method: download_and_extract 19:44:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:40 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json 19:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json 19:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:44:43 INFO - Downloaded 1302 bytes. 19:44:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:44:43 INFO - Using the following test package requirements: 19:44:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:44:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'jsshell-linux-x86_64.zip'], 19:44:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:44:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:44:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:44:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:44:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:44:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:43 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:44:44 INFO - Downloaded 23119750 bytes. 19:44:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:44:45 INFO - Return code: 0 19:44:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:45 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:44:46 INFO - Downloaded 23119750 bytes. 19:44:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:44:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:44:47 INFO - Return code: 0 19:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:47 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:44:48 INFO - Downloaded 11132039 bytes. 19:44:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:44:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:44:49 INFO - Return code: 0 19:44: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')]} 19:44:49 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:44:50 INFO - Downloaded 54645377 bytes. 19:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:50 INFO - mkdir: /builds/slave/test-pgo/properties 19:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:44:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:44:50 INFO - Contents: 19:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:50 INFO - Running post-action listener: _resource_record_post_action 19:44:50 INFO - Running post-action listener: set_extra_try_arguments 19:44:50 INFO - ##### 19:44:50 INFO - ##### Running populate-webroot step. 19:44:50 INFO - ##### 19:44:50 INFO - Running pre-action listener: _resource_record_pre_action 19:44:50 INFO - Running main action method: populate_webroot 19:44:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:50 INFO - '--tppagecycles', 19:44:50 INFO - '7'], 19:44:50 INFO - 'tests': ['tsvgm']}}, 19:44:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:44:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'tests': ['damp', 'tps']}, 19:44:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['damp', 'tps']}, 19:44:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:44:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:44:50 INFO - 'other': {'tests': ['a11yr', 19:44:50 INFO - 'ts_paint', 19:44:50 INFO - 'tpaint', 19:44:50 INFO - 'sessionrestore', 19:44:50 INFO - 'sessionrestore_no_auto_restore']}, 19:44:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['a11yr', 19:44:50 INFO - 'ts_paint', 19:44:50 INFO - 'tpaint', 19:44:50 INFO - 'sessionrestore', 19:44:50 INFO - 'sessionrestore_no_auto_restore']}, 19:44:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['a11yr', 19:44:50 INFO - 'ts_paint', 19:44:50 INFO - 'tpaint', 19:44:50 INFO - 'sessionrestore', 19:44:50 INFO - 'sessionrestore_no_auto_restore']}, 19:44:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['a11yr', 19:44:50 INFO - 'ts_paint', 19:44:50 INFO - 'tpaint', 19:44:50 INFO - 'sessionrestore', 19:44:50 INFO - 'sessionrestore_no_auto_restore']}, 19:44:50 INFO - 'other_l64': {'tests': ['a11yr', 19:44:50 INFO - 'ts_paint', 19:44:50 INFO - 'tpaint', 19:44:50 INFO - 'sessionrestore', 19:44:50 INFO - 'sessionrestore_no_auto_restore']}, 19:44:50 INFO - 'other_nol64': {'tests': ['a11yr', 19:44:50 INFO - 'ts_paint', 19:44:50 INFO - 'tpaint', 19:44:50 INFO - 'sessionrestore', 19:44:50 INFO - 'sessionrestore_no_auto_restore']}, 19:44:50 INFO - 'svgr': {'tests': ['tsvgx', 19:44:50 INFO - 'tsvgr_opacity', 19:44:50 INFO - 'tart', 19:44:50 INFO - 'tscrollx', 19:44:50 INFO - 'cart']}, 19:44:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['tsvgx', 19:44:50 INFO - 'tsvgr_opacity', 19:44:50 INFO - 'tart', 19:44:50 INFO - 'tscrollx', 19:44:50 INFO - 'cart']}, 19:44:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'tests': ['tp5o']}, 19:44:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'talos_options': ['--e10s'], 19:44:50 INFO - 'tests': ['tp5o']}, 19:44:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'talos_options': ['--xperf_path', 19:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:50 INFO - 'tests': ['tp5n']}, 19:44:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:50 INFO - 'talos_options': ['--e10s', 19:44:50 INFO - '--xperf_path', 19:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:50 INFO - 'tests': ['tp5n']}}, 19:44:50 INFO - 'talos.zip': {'path': '', 19:44:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:50 INFO - Running post-action listener: _resource_record_post_action 19:44:50 INFO - ##### 19:44:50 INFO - ##### Running create-virtualenv step. 19:44:50 INFO - ##### 19:44:50 INFO - Running pre-action listener: _resource_record_pre_action 19:44:50 INFO - Running main action method: create_virtualenv 19:44:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:44:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:44:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:44:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:50 INFO - Using real prefix '/usr' 19:44:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:44:51 INFO - Installing distribute.............................................................................................................................................................................................done. 19:44:53 INFO - Installing pip.................done. 19:44:53 INFO - Return code: 0 19:44:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:44:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:44:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:44:53 INFO - Using env: {'DISPLAY': ':0', 19:44:53 INFO - 'HOME': '/home/cltbld', 19:44:53 INFO - 'LANG': 'en_US.UTF-8', 19:44:53 INFO - 'LANGUAGE': 'en_US:en', 19:44:53 INFO - 'LOGNAME': 'cltbld', 19:44:53 INFO - 'MAIL': '/var/mail/cltbld', 19:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:53 INFO - 'MOZ_NO_REMOTE': '1', 19:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:53 INFO - 'NO_EM_RESTART': '1', 19:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:53 INFO - 'SHELL': '/bin/bash', 19:44:53 INFO - 'SHLVL': '1', 19:44:53 INFO - 'TERM': 'linux', 19:44:53 INFO - 'TMOUT': '86400', 19:44:53 INFO - 'USER': 'cltbld', 19:44:53 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:53 INFO - '_': '/tools/buildbot/bin/python'} 19:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:44:53 INFO - Cleaning up... 19:44:53 INFO - Return code: 0 19:44:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:44:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:44:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:44:53 INFO - Using env: {'DISPLAY': ':0', 19:44:53 INFO - 'HOME': '/home/cltbld', 19:44:53 INFO - 'LANG': 'en_US.UTF-8', 19:44:53 INFO - 'LANGUAGE': 'en_US:en', 19:44:53 INFO - 'LOGNAME': 'cltbld', 19:44:53 INFO - 'MAIL': '/var/mail/cltbld', 19:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:53 INFO - 'MOZ_NO_REMOTE': '1', 19:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:53 INFO - 'NO_EM_RESTART': '1', 19:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:53 INFO - 'SHELL': '/bin/bash', 19:44:53 INFO - 'SHLVL': '1', 19:44:53 INFO - 'TERM': 'linux', 19:44:53 INFO - 'TMOUT': '86400', 19:44:53 INFO - 'USER': 'cltbld', 19:44:53 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:53 INFO - '_': '/tools/buildbot/bin/python'} 19:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:53 INFO - Downloading/unpacking psutil>=0.7.1 19:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:44:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:44:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:44:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:55 INFO - Installing collected packages: psutil 19:44:55 INFO - Running setup.py install for psutil 19:44:55 INFO - building 'psutil._psutil_linux' extension 19:44:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:44:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:44:55 INFO - building 'psutil._psutil_posix' extension 19:44:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:44:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:44:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:55 INFO - Successfully installed psutil 19:44:55 INFO - Cleaning up... 19:44:55 INFO - Return code: 0 19:44:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:44:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:44:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:44:55 INFO - Using env: {'DISPLAY': ':0', 19:44:55 INFO - 'HOME': '/home/cltbld', 19:44:55 INFO - 'LANG': 'en_US.UTF-8', 19:44:55 INFO - 'LANGUAGE': 'en_US:en', 19:44:55 INFO - 'LOGNAME': 'cltbld', 19:44:55 INFO - 'MAIL': '/var/mail/cltbld', 19:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:55 INFO - 'MOZ_NO_REMOTE': '1', 19:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:55 INFO - 'NO_EM_RESTART': '1', 19:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:55 INFO - 'SHELL': '/bin/bash', 19:44:55 INFO - 'SHLVL': '1', 19:44:55 INFO - 'TERM': 'linux', 19:44:55 INFO - 'TMOUT': '86400', 19:44:55 INFO - 'USER': 'cltbld', 19:44:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:55 INFO - '_': '/tools/buildbot/bin/python'} 19:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:44:57 INFO - Installing collected packages: mozsystemmonitor 19:44:57 INFO - Running setup.py install for mozsystemmonitor 19:44:57 INFO - Successfully installed mozsystemmonitor 19:44:57 INFO - Cleaning up... 19:44:57 INFO - Return code: 0 19:44:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:44:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:44:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:44:57 INFO - Using env: {'DISPLAY': ':0', 19:44:57 INFO - 'HOME': '/home/cltbld', 19:44:57 INFO - 'LANG': 'en_US.UTF-8', 19:44:57 INFO - 'LANGUAGE': 'en_US:en', 19:44:57 INFO - 'LOGNAME': 'cltbld', 19:44:57 INFO - 'MAIL': '/var/mail/cltbld', 19:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:57 INFO - 'MOZ_NO_REMOTE': '1', 19:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:57 INFO - 'NO_EM_RESTART': '1', 19:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:57 INFO - 'SHELL': '/bin/bash', 19:44:57 INFO - 'SHLVL': '1', 19:44:57 INFO - 'TERM': 'linux', 19:44:57 INFO - 'TMOUT': '86400', 19:44:57 INFO - 'USER': 'cltbld', 19:44:57 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:57 INFO - '_': '/tools/buildbot/bin/python'} 19:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:44:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:44:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:44:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:00 INFO - Downloading docopt-0.6.1.tar.gz 19:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:45:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:45:00 INFO - Running setup.py install for blobuploader 19:45:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:45:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:45:00 INFO - Running setup.py install for requests 19:45:00 INFO - Running setup.py install for docopt 19:45:01 INFO - Successfully installed blobuploader requests docopt 19:45:01 INFO - Cleaning up... 19:45:01 INFO - Return code: 0 19:45:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:45:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:01 INFO - Using env: {'DISPLAY': ':0', 19:45:01 INFO - 'HOME': '/home/cltbld', 19:45:01 INFO - 'LANG': 'en_US.UTF-8', 19:45:01 INFO - 'LANGUAGE': 'en_US:en', 19:45:01 INFO - 'LOGNAME': 'cltbld', 19:45:01 INFO - 'MAIL': '/var/mail/cltbld', 19:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:01 INFO - 'MOZ_NO_REMOTE': '1', 19:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:01 INFO - 'NO_EM_RESTART': '1', 19:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:01 INFO - 'SHELL': '/bin/bash', 19:45:01 INFO - 'SHLVL': '1', 19:45:01 INFO - 'TERM': 'linux', 19:45:01 INFO - 'TMOUT': '86400', 19:45:01 INFO - 'USER': 'cltbld', 19:45:01 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:01 INFO - '_': '/tools/buildbot/bin/python'} 19:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:01 INFO - Running setup.py (path:/tmp/pip-mxsRKr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:01 INFO - Running setup.py (path:/tmp/pip-eq5M0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:01 INFO - Running setup.py (path:/tmp/pip-Oog1kk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:01 INFO - Running setup.py (path:/tmp/pip-EcEiBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:01 INFO - Running setup.py (path:/tmp/pip-n76mvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:01 INFO - Running setup.py (path:/tmp/pip-2PbMsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:01 INFO - Running setup.py (path:/tmp/pip-rKl2yt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:01 INFO - Running setup.py (path:/tmp/pip-TMQ_gE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:01 INFO - Running setup.py (path:/tmp/pip-q3ngzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:01 INFO - Running setup.py (path:/tmp/pip-OunpgO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:02 INFO - Running setup.py (path:/tmp/pip-VIyWhz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:02 INFO - Running setup.py (path:/tmp/pip-7AVZWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:02 INFO - Running setup.py (path:/tmp/pip-KY8faw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:02 INFO - Running setup.py (path:/tmp/pip-F10W0I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:02 INFO - Running setup.py (path:/tmp/pip-nHL6vu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:02 INFO - Running setup.py (path:/tmp/pip-8z8MqL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:02 INFO - Running setup.py (path:/tmp/pip-NIXu4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:45:02 INFO - Running setup.py install for manifestparser 19:45:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:45:02 INFO - Running setup.py install for mozcrash 19:45:02 INFO - Running setup.py install for mozdebug 19:45:02 INFO - Running setup.py install for mozdevice 19:45:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for mozfile 19:45:03 INFO - Running setup.py install for mozhttpd 19:45:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for mozinfo 19:45:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for mozInstall 19:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for mozleak 19:45:03 INFO - Running setup.py install for mozlog 19:45:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for moznetwork 19:45:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for mozprocess 19:45:03 INFO - Running setup.py install for mozprofile 19:45:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:45:03 INFO - Running setup.py install for mozrunner 19:45:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:45:04 INFO - Running setup.py install for mozscreenshot 19:45:04 INFO - Running setup.py install for moztest 19:45:04 INFO - Running setup.py install for mozversion 19:45:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:45:04 INFO - Cleaning up... 19:45:04 INFO - Return code: 0 19:45:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:45:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:04 INFO - Using env: {'DISPLAY': ':0', 19:45:04 INFO - 'HOME': '/home/cltbld', 19:45:04 INFO - 'LANG': 'en_US.UTF-8', 19:45:04 INFO - 'LANGUAGE': 'en_US:en', 19:45:04 INFO - 'LOGNAME': 'cltbld', 19:45:04 INFO - 'MAIL': '/var/mail/cltbld', 19:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:04 INFO - 'MOZ_NO_REMOTE': '1', 19:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:04 INFO - 'NO_EM_RESTART': '1', 19:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:04 INFO - 'SHELL': '/bin/bash', 19:45:04 INFO - 'SHLVL': '1', 19:45:04 INFO - 'TERM': 'linux', 19:45:04 INFO - 'TMOUT': '86400', 19:45:04 INFO - 'USER': 'cltbld', 19:45:04 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:04 INFO - '_': '/tools/buildbot/bin/python'} 19:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:04 INFO - Running setup.py (path:/tmp/pip-t9NKdz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:04 INFO - Running setup.py (path:/tmp/pip-uvS23W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:04 INFO - Running setup.py (path:/tmp/pip-Zy4p1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:04 INFO - Running setup.py (path:/tmp/pip-LfyZrA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:04 INFO - Running setup.py (path:/tmp/pip-zf4eXi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:04 INFO - Running setup.py (path:/tmp/pip-Tk4Eds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:05 INFO - Running setup.py (path:/tmp/pip-lrrD60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:05 INFO - Running setup.py (path:/tmp/pip-9XtkjY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:05 INFO - Running setup.py (path:/tmp/pip-EsYgby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:05 INFO - Running setup.py (path:/tmp/pip-DOZFKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:05 INFO - Running setup.py (path:/tmp/pip-78SRsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:05 INFO - Running setup.py (path:/tmp/pip-e6_ERo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:05 INFO - Running setup.py (path:/tmp/pip-NTMfj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:05 INFO - Running setup.py (path:/tmp/pip-4SG8YJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:05 INFO - Running setup.py (path:/tmp/pip-MYExAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:05 INFO - Running setup.py (path:/tmp/pip-9VbOfi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:05 INFO - Running setup.py (path:/tmp/pip-1Lad0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:45:05 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:05 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:07 INFO - Downloading blessings-1.5.1.tar.gz 19:45:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:45:07 INFO - Installing collected packages: blessings 19:45:07 INFO - Running setup.py install for blessings 19:45:07 INFO - Successfully installed blessings 19:45:07 INFO - Cleaning up... 19:45:07 INFO - Return code: 0 19:45:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:45:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:07 INFO - Reading from file tmpfile_stdout 19:45:07 INFO - Current package versions: 19:45:07 INFO - argparse == 1.2.1 19:45:07 INFO - blessings == 1.5.1 19:45:07 INFO - blobuploader == 1.2.4 19:45:07 INFO - docopt == 0.6.1 19:45:07 INFO - manifestparser == 1.1 19:45:07 INFO - mozInstall == 1.12 19:45:07 INFO - mozcrash == 0.16 19:45:07 INFO - mozdebug == 0.1 19:45:07 INFO - mozdevice == 0.47 19:45:07 INFO - mozfile == 1.2 19:45:07 INFO - mozhttpd == 0.7 19:45:07 INFO - mozinfo == 0.9 19:45:07 INFO - mozleak == 0.1 19:45:07 INFO - mozlog == 3.1 19:45:07 INFO - moznetwork == 0.27 19:45:07 INFO - mozprocess == 0.22 19:45:07 INFO - mozprofile == 0.27 19:45:07 INFO - mozrunner == 6.11 19:45:07 INFO - mozscreenshot == 0.1 19:45:07 INFO - mozsystemmonitor == 0.0 19:45:07 INFO - moztest == 0.7 19:45:07 INFO - mozversion == 1.4 19:45:07 INFO - psutil == 3.1.1 19:45:07 INFO - requests == 1.2.3 19:45:07 INFO - wsgiref == 0.1.2 19:45:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:45:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:07 INFO - Using env: {'DISPLAY': ':0', 19:45:07 INFO - 'HOME': '/home/cltbld', 19:45:07 INFO - 'LANG': 'en_US.UTF-8', 19:45:07 INFO - 'LANGUAGE': 'en_US:en', 19:45:07 INFO - 'LOGNAME': 'cltbld', 19:45:07 INFO - 'MAIL': '/var/mail/cltbld', 19:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:07 INFO - 'MOZ_NO_REMOTE': '1', 19:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:07 INFO - 'NO_EM_RESTART': '1', 19:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:07 INFO - 'SHELL': '/bin/bash', 19:45:07 INFO - 'SHLVL': '1', 19:45:07 INFO - 'TERM': 'linux', 19:45:07 INFO - 'TMOUT': '86400', 19:45:07 INFO - 'USER': 'cltbld', 19:45:07 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:07 INFO - '_': '/tools/buildbot/bin/python'} 19:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:08 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 1)) 19:45:08 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 2)) 19:45:08 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 3)) 19:45:08 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 4)) 19:45:08 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 5)) 19:45:08 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 6)) 19:45:08 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 7)) 19:45:08 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 8)) 19:45:08 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:08 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 3)) 19:45:08 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:08 INFO - Cleaning up... 19:45:08 INFO - Return code: 0 19:45:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:45:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:45:08 INFO - Using env: {'DISPLAY': ':0', 19:45:08 INFO - 'HOME': '/home/cltbld', 19:45:08 INFO - 'LANG': 'en_US.UTF-8', 19:45:08 INFO - 'LANGUAGE': 'en_US:en', 19:45:08 INFO - 'LOGNAME': 'cltbld', 19:45:08 INFO - 'MAIL': '/var/mail/cltbld', 19:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:08 INFO - 'MOZ_NO_REMOTE': '1', 19:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:08 INFO - 'NO_EM_RESTART': '1', 19:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:08 INFO - 'SHELL': '/bin/bash', 19:45:08 INFO - 'SHLVL': '1', 19:45:08 INFO - 'TERM': 'linux', 19:45:08 INFO - 'TMOUT': '86400', 19:45:08 INFO - 'USER': 'cltbld', 19:45:08 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:08 INFO - '_': '/tools/buildbot/bin/python'} 19:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:08 INFO - Downloading/unpacking jsonschema 19:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:45:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:45:10 INFO - Downloading/unpacking functools32 (from jsonschema) 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:45:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:45:10 INFO - warning: no files found matching '*.txt' 19:45:10 INFO - no previously-included directories found matching 'build' 19:45:10 INFO - no previously-included directories found matching 'dist' 19:45:10 INFO - no previously-included directories found matching '.git*' 19:45:10 INFO - Installing collected packages: jsonschema, functools32 19:45:10 INFO - Running setup.py install for functools32 19:45:10 INFO - warning: no files found matching '*.txt' 19:45:10 INFO - no previously-included directories found matching 'build' 19:45:10 INFO - no previously-included directories found matching 'dist' 19:45:10 INFO - no previously-included directories found matching '.git*' 19:45:10 INFO - Successfully installed jsonschema functools32 19:45:10 INFO - Cleaning up... 19:45:10 INFO - Return code: 0 19:45:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f366e523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, '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': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:45:10 INFO - Using env: {'DISPLAY': ':0', 19:45:10 INFO - 'HOME': '/home/cltbld', 19:45:10 INFO - 'LANG': 'en_US.UTF-8', 19:45:10 INFO - 'LANGUAGE': 'en_US:en', 19:45:10 INFO - 'LOGNAME': 'cltbld', 19:45:10 INFO - 'MAIL': '/var/mail/cltbld', 19:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:10 INFO - 'MOZ_NO_REMOTE': '1', 19:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:10 INFO - 'NO_EM_RESTART': '1', 19:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:10 INFO - 'SHELL': '/bin/bash', 19:45:10 INFO - 'SHLVL': '1', 19:45:10 INFO - 'TERM': 'linux', 19:45:10 INFO - 'TMOUT': '86400', 19:45:10 INFO - 'USER': 'cltbld', 19:45:10 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:10 INFO - '_': '/tools/buildbot/bin/python'} 19:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:10 INFO - Downloading/unpacking flake8 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:45:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:45:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:45:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:45:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:45:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:45:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:13 INFO - no previously-included directories found matching 'docs/_build' 19:45:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:45:13 INFO - Running setup.py install for pep8 19:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:13 INFO - no previously-included directories found matching 'docs/_build' 19:45:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:45:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:45:13 INFO - Cleaning up... 19:45:13 INFO - Return code: 0 19:45:13 INFO - Running post-action listener: _resource_record_post_action 19:45:13 INFO - Running post-action listener: _start_resource_monitoring 19:45:13 INFO - Starting resource monitoring. 19:45:13 INFO - ##### 19:45:13 INFO - ##### Running install step. 19:45:13 INFO - ##### 19:45:13 INFO - Running pre-action listener: _resource_record_pre_action 19:45:13 INFO - Running main action method: install 19:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:13 INFO - Reading from file tmpfile_stdout 19:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:45:13 INFO - Reading from file tmpfile_stdout 19:45:13 INFO - Output received: 19:45:13 INFO - Usage: mozinstall [options] installer 19:45:13 INFO - Options: 19:45:13 INFO - -h, --help show this help message and exit 19:45:13 INFO - -d DEST, --destination=DEST 19:45:13 INFO - Directory to install application into. [default: 19:45:13 INFO - "/builds/slave/test-pgo"] 19:45:13 INFO - --app=APP Application being installed. [default: firefox] 19:45:13 INFO - mkdir: /builds/slave/test-pgo/build/application 19:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:45:29 INFO - Reading from file tmpfile_stdout 19:45:29 INFO - Output received: 19:45:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:45:29 INFO - Running post-action listener: _resource_record_post_action 19:45:29 INFO - ##### 19:45:29 INFO - ##### Running run-tests step. 19:45:29 INFO - ##### 19:45:29 INFO - Running pre-action listener: _resource_record_pre_action 19:45:29 INFO - Running main action method: run_tests 19:45:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:45:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:45:29 INFO - Python 2.7.3 19:45:29 INFO - Return code: 0 19:45:29 INFO - grabbing minidump binary from tooltool 19:45: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')]} 19:45:29 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 0x1084350>, '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 0x1085250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:45:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:45:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:45:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:45:29 INFO - Return code: 0 19:45:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:45:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:45:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:45:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:45:30 INFO - Return code: 0 19:45:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:45:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 19:45:30 INFO - Using env: {'DISPLAY': ':0', 19:45:30 INFO - 'HOME': '/home/cltbld', 19:45:30 INFO - 'LANG': 'en_US.UTF-8', 19:45:30 INFO - 'LANGUAGE': 'en_US:en', 19:45:30 INFO - 'LOGNAME': 'cltbld', 19:45:30 INFO - 'MAIL': '/var/mail/cltbld', 19:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:30 INFO - 'MOZ_NO_REMOTE': '1', 19:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:30 INFO - 'NO_EM_RESTART': '1', 19:45:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:45:30 INFO - 'SHELL': '/bin/bash', 19:45:30 INFO - 'SHLVL': '1', 19:45:30 INFO - 'TERM': 'linux', 19:45:30 INFO - 'TMOUT': '86400', 19:45:30 INFO - 'USER': 'cltbld', 19:45:30 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636', 19:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:30 INFO - '_': '/tools/buildbot/bin/python'} 19:45:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 19:45:30 INFO - mozversion INFO | application_buildid: 20151217173001 19:45:30 INFO - mozversion INFO | application_changeset: e1ce5b4fa814367b46379641a77f06eabd9348ed 19:45:30 INFO - mozversion INFO | application_display_name: Nightly 19:45:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:45:30 INFO - mozversion INFO | application_name: Firefox 19:45:30 INFO - mozversion INFO | application_remotingname: firefox 19:45:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:45:30 INFO - mozversion INFO | application_vendor: Mozilla 19:45:30 INFO - mozversion INFO | application_version: 46.0a1 19:45:30 INFO - mozversion INFO | platform_buildid: 20151217173001 19:45:30 INFO - mozversion INFO | platform_changeset: e1ce5b4fa814367b46379641a77f06eabd9348ed 19:45:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:45:30 INFO - mozversion INFO | platform_version: 46.0a1 19:45:30 INFO - 2015-12-17 19:45:30,662 DEBUG : using testdate: 1450410330 19:45:30 INFO - 2015-12-17 19:45:30,662 DEBUG : actual date: 1450410330 19:45:30 INFO - 2015-12-17 19:45:30,740 INFO : starting webserver on 'localhost:59747' 19:45:30 INFO - 2015-12-17 19:45:30,741 INFO : Starting test suite talos-linux64-ix-031.e 19:45:30 INFO - 2015-12-17 19:45:30,741 INFO : Starting test dromaeo_css 19:45:30 INFO - 2015-12-17 19:45:30,741 DEBUG : operating with platform_type : linux_ 19:45:30 INFO - 2015-12-17 19:45:30,742 INFO : Initialising browser for dromaeo_css test... 19:45:30 INFO - 2015-12-17 19:45:30,759 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCRwzPj/profile http://localhost:59747/getInfo.html 19:45:35 INFO - 2015-12-17 19:45:35,191 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:45:35 INFO - 2015-12-17 19:45:35,191 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:45:35 INFO - 2015-12-17 19:45:35,191 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:45:35 INFO - 2015-12-17 19:45:35,192 DEBUG : BROWSER_OUTPUT: __metrics 19:45:35 INFO - 2015-12-17 19:45:35,288 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:45:36 INFO - 2015-12-17 19:45:36,084 INFO : Browser initialized. 19:45:36 INFO - 2015-12-17 19:45:36,085 INFO : Running cycle 1/1 for dromaeo_css test... 19:45:36 INFO - 2015-12-17 19:45:36,085 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCRwzPj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:45:47 INFO - 2015-12-17 19:45:47,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 150822912 19:45:47 INFO - 2015-12-17 19:45:47,885 DEBUG : BROWSER_OUTPUT: 19:46:37 INFO - 2015-12-17 19:46:37,513 DEBUG : BROWSER_OUTPUT: 1450410397510 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:48:46 INFO - 2015-12-17 19:48:46,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59747/tests/dromaeo/cssquery-ext.html) 19:48:47 INFO - 2015-12-17 19:48:47,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 158318592 19:48:47 INFO - 2015-12-17 19:48:47,424 DEBUG : BROWSER_OUTPUT: 19:51:49 INFO - 2015-12-17 19:51:49,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/dromaeo/cssquery-ext.html (next: http://localhost:59747/tests/dromaeo/cssquery-jquery.html) 19:51:49 INFO - 2015-12-17 19:51:49,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 152121344 19:51:49 INFO - 2015-12-17 19:51:49,973 DEBUG : BROWSER_OUTPUT: 19:54:51 INFO - 2015-12-17 19:54:51,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59747/tests/dromaeo/cssquery-mootools.html) 19:54:52 INFO - 2015-12-17 19:54:52,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 154677248 19:54:52 INFO - 2015-12-17 19:54:52,194 DEBUG : BROWSER_OUTPUT: 19:57:53 INFO - 2015-12-17 19:57:53,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59747/tests/dromaeo/cssquery-prototype.html) 19:57:54 INFO - 2015-12-17 19:57:54,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 152735744 19:57:54 INFO - 2015-12-17 19:57:54,505 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-12-17 20:00:56,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59747/tests/dromaeo/cssquery-yui.html) 20:00:57 INFO - 2015-12-17 20:00:57,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 152375296 20:00:57 INFO - 2015-12-17 20:00:57,542 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/dromaeo/cssquery-yui.html (next: http://localhost:59747/tests/dromaeo/cssquery-dojo.html) 20:04:00 INFO - 2015-12-17 20:04:00,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 155938816 20:04:00 INFO - 2015-12-17 20:04:00,321 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,321 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:04:00 INFO - 2015-12-17 20:04:00,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:04:00 INFO - 2015-12-17 20:04:00,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:04:00 INFO - 2015-12-17 20:04:00,322 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:04:00 INFO - 2015-12-17 20:04:00,322 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3147.95278070829;3175.380800743856;3205.8236796976184;3224.484082546793;3236.2233064064617;5108.157154069583;5270.7364631768405;5312.150055991042;5319.574434045272;5322.33470816148;5253.185756207794;5270.92093618595;5319;5332.253484512162;5351.652142610737;4792.688475249098;4837.830675926343;4883.047805677894;4918.016396720653;4960.553550180483;4818.927716084244;4862.2220444728855;4870.269459581055;4875.268709693557;4954.479779623141;4659.62722982164;4735.952640473585;4740.881477963044;4862.805487780484;4867.488913664068;4808.2547205183255;4826.541478559567;4857.587105096071;4868.9269660955115;4892.486288939645;4773.570378665902;4798.736069516175;4834.830780922686;4848.442429120661;4867.2212446008825;4976.477469865685;5021.874453138665;5079.974600127012;5080;5128.358955130609;5687.175359572881;5701.344345400249;5704.8859022819315;5720.399358067426;5726.226959360475;5750.971245143789;5751.1085781703905;5754.3094828620415;5754.395788442237;5761.654300741927;5151.7681704323395;5205.843824685266;5216.087184742655;5286.20706893969;5336.759845806987;5800.767969281182;5805.10020946754;5814.011618024946;5820.767169313265;5825.650460972355;5397.325334333208;5630.324361076697;5645.774169033275;5650;5661.745221465044;5538.833834984957;5630.859228519238;5729.341125770507;5742.339630942495;5794.710264486843;5572.219889215513;5583.05088135018;5587.273654424899;5588.161775733591;5595.244641973281;5515.062439385314;5550.5282051026115;5571.609987300931;5633.239512665819;5643.661380317194;4362.498312694017;4428.291473364311;4437.534058923831;4449.065696203834;4472.284434490466;3955.5253369595257;3958.782266975344;3967.4643923070016;3975.582563830756;3997.420374045747;5213;5277.709725965032;5369.087255166631;5426.810061647823;5471.972640136773;5742.368339482654;5744.281964754406;5762.769489220468;5767.971160144172;5778;5406.324209473816;5451.618386712892;5451.972740136274;5454.400015998237;5463.399026107125;4589.495155532889;4640.234361330343;4694.882627934329;4777.641676874248;4849.733264670406;5801.6809075500405;5842.298924129132;5852.4440178183;5864.794732184353;5868.4424979626865;5673.716314184357;5735.827925162252;5741.1388291756575;5758.596898217253;5767.5674324425;5619.269494965628;5648;5725.370209277059;5728.484436400744;5735.11105778605;5486.588505861996;5554.611177217556;5560.527355174855;5562.527185189142;5610.102383618601;5731.283589551306;5775.451332123442;5787.305523337226;5797.333306669787;5802.448767367094;5382.031234377693;5611.466910643482;5617.943820561905;5621.578381621313;5647.745851436613;5439.700816455133;5499.7250137492165;5554.750036248298;5572.665640061609;5610.635308705085;5409.864753381197;5427.158790387496;5447.101228297287;5460.290162279037;5474.808381706621;5430.809921652881;5515.172724091419;5620.690862002629;5640.294963129609;5673.120666296731;5312.309399778004;5350.250964865;5457.20870473787;5464.863378415572;5500 20:04:00 INFO - 2015-12-17 20:04:00,322 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.9657420554767;577.068035123276;577.376433451872;598.4703537369429;601.9909701354478;34856.47715284269;35690.8215458923;35769.1057723557;35792.105197370045;35915.10212244695;41507.58492415075;41816.79091604545;42077.7896110519;42105.78947105268;42195.57804421955;8619.87070193946;8821.2942964563;8830.514321712304;8836.646534138627;8837.911620883806;8672.913270867273;8688.695895643654;8765.386422950396;8769.298456123495;8773.868391974125;8717.912820871774;8719.651213951434;8754.474731516098;8802.559872006406;8832;8719.04090550039;8744.693935712283;8791.076936921596;8805.823883522293;8818.250448711835;8643.17889800468;8692.913070869274;8721.825563488757;8738.737837864874;8751.256143227833;38481;38772.80613596942;38996.61003389958;39038.414423783666;39047;3191.872325106993;3382.374260761767;3700.6299370063048;3738.934403694961;4064.5935406459116;29073.563896541567;29245.415091698258;29338.853305733333;29458.116256512338;30322;3786.8863934082024;3868.303705333039;3879.72841901067;3929.5088113985753;3988.3618621020787;251192;251447;251447.99999999817;252015;253408;57846.421535784946;57847.421525785045;57985.71007144937;58358.416415836145;58365.416345836;68067.65966170236;68777.31222687809;68892.655536722;68900.65549672219;69026.65486672636;13688.041837071509;13892.444302227797;13965.162090274616;14057.22685252321;14098.365573549216;9644.565994530263;9759.072888075621;9787.706368808947;9840;9980.251481138943;19801;19916.50208744793;19928.800711992695;20058.498537536678;20079.49801254951;7884.476967370387;8147.877781833277;8209.466384684976;8243.340532757486;8253.380996425292;941.7551436626527;974.5224839828433;1014.7058095619894;1116.6705821782593;1136.2671077155353;27962.72037279642;27981.860090699418;28180.577291340647;28197.57703634447;28519.28701782472;995.4176806568094;1018.6791160784329;1024.8257796174669;1107.385401102396;1146.2091157101572;14420.134791912518;14622.926885365505;14816;14928.925355373154;15074.849251507345;321824;322314;325810;325986;329088;51190.48809511932;51351.229731554056;51614.22578661323;51632.483675163516;51833.481665182866;1310.2138716769862;1310.724747802953;1321;1336.5322137251885;1337.3580681273043;26735.732642673323;27654.861725691244;28000.43999120047;28219.858900706186;28336.57495137616;47446.28830567475;47645.52354476411;47854.521454785005;47894;48006.519934800206;287876;291224;292493;292610;294151;32663;44524.33213501735;44828.77585612051;45181;45436;42791.3581296287;42830.35754463623;43071.35392969046;43149;43393.78303108464;36445.81777091097;36506;36544.81727591345;37181.442278365306;37398.8130059348;35385.64614353824;36309;36559;36591.08522286964;36603.45094823633;35539.644603553636;36887.26225475422;37354;37551.81224093971;37850.24299514049;30524.389512210077;32751;33152;33276.66723332736;33361;25100.49799003973;25277.241682749547;25495.36261593475;25617.193441123043;25744 20:04:00 INFO - 2015-12-17 20:04:00,322 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.9467579863021;359.0538929919661;361.7449697962936;363.1447940101062;364.4824349423818;13565.32173391329;13639.727205455885;16420.34318627255;16811.915940420295;17401.216945237462;14171.929140354283;14204.857951420483;14631.561053168396;14658.340374683139;14665.340059697313;5262.842114736545;5307.761150748206;5329.880725047745;5354.892902141954;5357.357117145948;5037.168867136918;5208.609354298424;5222.242774797652;5251.842444726664;5296.179092240709;5162.974185129069;5191.740412979355;5248.0553500369915;5331.253624492574;5996.19051428056;5912.054071348585;5912.615679980788;5917.763289468416;5935.317438494585;5969.164316995624;4899.7550122494085;5076.13705670037;5267.55225805807;5280;5290.761915713802;12838;12901.354932253444;13037.804432933513;18640.25438982439;20024.599508009906;2088.5196404826825;2151.4728891421546;2174.510735084609;2204.9669254961186;2226.9665955010687;9382.10869967352;9571.473568953705;9603.087706667926;9723.693459128279;12591.622251332476;1760.7887053553527;1794.2195145111918;1815.9909200454044;1849;1879.7650293713286;58249.7087514564;58571;58893;61220.69389653023;61220.69389653023;9991.700248992542;10125.886152523217;10188.184945204366;10189.184865210766;10256.794864102676;13141.868581314257;13266.734665306833;13267.601971940858;13303.46786128544;13307.800382994263;6978.825529361705;7009.9649501752165;7094.68073936674;7214.67533960973;7260.709571617182;6818;6842;6869.278725733826;6869.553479023847;6919.861602767916;4275;4332.371806088163;4399.978000109979;4439.556044395535;4443.6667249955735;1815.337401848316;1829.4603092087866;1834.0737927346604;1847.9722804157948;1856.9071546422624;889.9377043606885;904.0778406025948;925.8518637018045;927.3693888155984;975.0882924465648;16038.278277477542;16434;16628;16823.15884205785;16920.830791692173;941.1717688434271;947.5215016416665;963.8409662405764;982.4498280962541;1009.1239966096566;9415.529223538795;9646;9877.209823214269;10332.845007324897;10405.947970260251;499593;506293.0909490871;531605;541892;542860;79024.60487697525;79926.20073799304;80029;80889.19110808935;81983;1088.8638920134983;1101.2016288190998;1107.3909349857547;1115.70991542198;1143.445428966967;15043.623909402353;15098.54704358871;15167;15199.620009499851;15340.539783806504;35477;36333.45499817452;36840.81579592085;37766.811165944;38030.619693802706;45044.77477612591;47001;47008.29487557621;47831.76084119557;51346.22980655368;9417.340786144903;9431.386959847589;9616.75958101053;9674.177694896012;9678.70963871085;12471.875281247072;16939.983600983982;17076.23156957915;17194.31222751076;17545.736813947547;14186.3616137272;14239;14491.275436227936;14521.201333926736;14667.266636667911;11957.521699132285;13597.932010339884;14071.226082565558;14488.840892728345;14578.125312481285;14944.925275373553;14968.85031149718;15138.167400793061;15144.54566363011;15172.772408413663;9547.474888881177;9623.230141588796;9703.417794932328;9715.9028409715;9741.295273326998;12559.497620095093;14610.92694536563;14760.852391475948;14941.701165976838;15038.398464061314 20:04:00 INFO - 2015-12-17 20:04:00,323 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1458.4166333466615;1466.1423067505511;1618.8219295877452;1764.664713704396;1765.7704498415203;7160.069191005168;7179.138503379601;7312.37844783194;7329.890051649216;7395.999999999994;7304.269573042693;7348.2651734826495;7378.33594976452;7419.851602967938;7425.591592462412;2136.700861879338;2175.2060497918305;2175.4996350839315;2175.9564808703817;2177.2706143441965;2076.678114892194;2079.324219628627;2134.5410736691606;2135.9252426165085;2137.7969092936146;1892.9716054259197;1935.6225536020481;2124.968125478119;2176.6952626632283;2204.195468653938;2105.842061845368;2126.1282874021654;2141.2612648636195;2144.378130342199;2148.3340164548963;2102.3167470572125;2134.957300853974;2151.9892400537897;2163.1888041984257;2166.73999120105;7168.9283107168785;7194.748183813594;7242.384397326234;7272.818179545501;7310.195878453366;4282.486101667789;4427.867163985085;4434.800433980478;4435.667324950609;4446.799894004777;2849.9430011399863;2862.3416614178855;2978.4936560784718;2979.016924414938;2979.657339405974;995.213591603067;1009.0464511037073;1009.1926458832904;1011.549860312154;1018.332991890313;9186.26509879208;9397.248220142372;9502.382345147613;9528.380655257455;9544.95227523865;3839.212961342918;3847.5382954045695;3896.3960586109197;3934.1148241645974;3941.4087886817206;8012.639431225492;8025.518468891885;8038.035435747748;8045.396595255379;8053.6375863086305;4368.235558777201;4377.715448495837;4388.4953230378915;4395.450568678915;4402.537733537996;4015.6185162409524;4038.1116154445976;4061.2283666103344;4065.166640838621;4066.268071747114;3270.8528116234825;3274.6561611030497;3285.868565257411;3296.225387034045;3313.436715758327;990.7721224118493;1011.1506334678905;1019.0930072235716;1019.8266294729914;1020.7754294055296;1066.8399740039056;1072.855164552791;1130.728625129963;1247.812828075796;1269.57469247803;6994.755183568551;7024.157101147793;7067.89398159028;7077.3984211341585;7082.504224704221;1057.4237040812775;1111.366521082975;1129.6294458065693;1139.7606502634374;1174.36584244507;5416.702081385482;5436.184572314105;5452.154915988028;5474.39781624021;5489.039418101896;8196.221358970888;8374.748757537283;8412.621432035574;8429.536375499283;8526.062133165347;8575.442596231225;8601.182887625791;8641.30869530436;8648.1784230498;8667.913320866837;6719;6776.796696099125;6857;6884.277150899184;6887.414569761526;6823.863522729617;6892.551984121016;6901.689423975833;6908.205556361083;6922;7470.103587569526;7679.808004799925;7812.453128280966;7868.173841746763;7879.448438609243;7821.452498325063;7941.682332706627;7981.840363192588;7991.120976692676;8031.156728543652;6540.182477190351;6591.274959754327;6623.039659249478;6636.469082473294;6640.933590664032;6464;6673.9332606673315;6683.9331606685255;6697.2633010367845;6737.393634572912;6414.069959855701;6504;6558.737650494118;6653.63405012729;6670.39966403026;6196.628202307876;6275.811725648238;6339.397757213057;6340.270868850142;6650;6577.276499585138;6578.671066446563;6607.438367738796;6609.041688954979;6610.140681711347;5966.671833049224;6039.547033972557;6117.1741814856205;6158.32258451561;6168.907466388097;6234.563580549318;6241.563090583615;6254.562180647311;6259.655718935503;6260.968695156495 20:04:00 INFO - 2015-12-17 20:04:00,323 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.80687911330097;342.7241070937895;346.9739769517284;348.76109864742654;351.4359453077811;6205.844853878655;6236.68816559172;6350.396712312328;6402.839929001777;6411.326810684881;6138.202033735608;6224.097505861648;6271.404216599416;6277.68611569422;6292.119103325538;4766.070616229819;4819.493953134923;4824.5657890789735;4835.540623640749;4837.201861692816;4838.153323168449;4842.709437433748;4843.58829499493;4845.297431872376;4848.030393921213;4674.813007479696;4820.301056346828;4822.734749588772;4823.300621409893;4824.951750482503;4808.807647694106;4809.038192361507;4809.086273608021;4814.518548145193;4817.542333478314;4236.872893813191;4238.215930052919;4244.575542445731;4245.426867372896;4248.745075295492;6005.429484198994;6012.188354572164;6026.608270462406;6027.246594175728;6031.396860313977;5415.9458405415835;5581.0512212923495;5587.413321601214;5588.804391846266;5598.608097433182;6689;6697.062411262427;6699.296573859772;6703.329667033307;6705.798826035227;4597.264437689953;4599.885002874921;4602.585767280961;4609.930851037204;4617.284320930261;6691.297413771581;6874.450043996469;6944.4444444444325;6961.129858767654;6962.547434416747;4661.300804879295;4683.672142949961;4710.717356958594;4714.528547145258;4726.1492931272705;4764.49972752856;4768.165571025057;4770.045990801854;4770.045990801854;4793.18515852306;5544.168374743821;5544.1960915667005;5550.7779688812;5552.805651802168;5571.526420254324;6534;6707.865842683119;6739.494537909578;6743.426808721314;6748.662566871637;1630.6331075507917;1669.4908053043696;1676.5305714399988;1683.166832417961;1685.587031177345;1105.4914739219887;1113.8997490225918;1115.2750712037077;1127.1715289262386;1135.744457497073;6321.652309123042;6409.262934762562;6415.390537898892;6428.260750013715;6440.54916155874;6837.213720422215;6840.008198811144;6863.004864294649;6863.588184708933;6891.27641597635;6366.840828979312;6374.553781235269;6379.330170332141;6415.967920160463;6423.100765892778;3780.773153610792;3807.809609519513;3822.675072618803;3826.215625796705;3829.5787463379006;7129.429645628441;7195.712171513185;7202.783916482514;7205;7217.206107328189;7004.824879378057;7160.785176444715;7167.462440316997;7196;7210.60341681202;7194.38847697941;7209.0988626421695;7212.206657267697;7221.277872212737;7239.20368759436;7018.473614479037;7026.402755765817;7041.823954401181;7042.929570704432;7043.36609705129;6730.293319201413;6898.517103802686;6925.134358205224;6940.722371105099;6945.756898508528;7181.784546463615;7188.820279493055;7211.062561866924;7218.422526197996;7219.494635375683;4682.2040253156365;4735.218688916428;4735.313379559876;4743.383360163157;4756.143894099096;6823.863522729418;6887.586744795329;6996.685149168401;7005.404540614105;7032.964835175791;6775.085363475868;6808.421284190701;6813.693383797642;6814.693338799865;6825.146856642919;6765.627890466071;6771.356721111487;6782.118324617768;6791.117154769849;6807.183138023469;6475.805725828232;6634.270230274569;6649.2685804562425;6657.234418041987;6666.100076489805;6797.150356205474;6803.421709154777;6806.149231346082;6809.89785153233;6837.487188460786;6629;6629.237637671729;6668.533202675766;6673.899891501728;6677.3656502632175 20:04:00 INFO - 2015-12-17 20:04:00,324 DEBUG : BROWSER_OUTPUT: |5;yui.html;805.1666525146472;817.4155478832636;848.4230723108284;857.1171693156048;888.8933328000641;12966.546170884021;13236.404361803707;13268.867311326883;13307.268100254481;13314.933425332873;11865.822012669816;11922.165448418615;11931.463084161212;11948.820767688492;11964.581239656614;650.7299470719657;663.0551464163548;799.1169757418028;812.4150611559668;816.873384625381;805.556943680976;805.7985503624094;809.951402915827;811.3630799822141;814.7922279818638;837.5770236030796;841.3899922556159;842.8314337132567;846.2510678049908;847.3898792869124;830.489249111795;831.7005877883987;834.8497270491309;837.3594200436671;838.76933843193;622.2719418280623;622.498888394842;623.1276213301369;623.9001759718469;626.573929727785;13310.267935263557;13314.467421303136;13359.532416365479;13477.528286509925;13492.527761528398;10904.182186336056;12201.450934707871;12357.814632780515;12543.184692994926;12681.936590317082;10612.575496980111;10633.149348052137;10669.253152279343;10922.508487118099;10940.890591094067;3636.5272514573203;3672.1003354178397;3694.4273637586216;3785.734998550103;3794.7723136611617;43842;43947.78026109849;44063.77968110139;44256;44461.55538444639;9504.667336643184;9558.713238602853;9610.327277090537;9682.322237443452;9733.707988760349;17474.388396406066;17632.55918602045;17748;17757;17861.017644029704;7170.139583250043;7349.70601175947;7490.625468726542;7569.621518924032;7758.534487930742;4397.890052748643;4445.2887537993765;4463.263561512379;4536.79584418702;4690.085433340534;2815.0850973433717;2855.4146399987953;2860.785441091885;2865.068852622906;2873.1524200360946;544.6459801129298;552.9308836395451;565.4317411001999;578.6672663218666;580.3007376111775;548.9862753431196;652.644308851677;672.2101530701407;697.3026973026973;723.8914162875611;8848.705115983405;8867.645294188289;8951.641934322553;9178.724638260863;9213.216876565433;521.6843809495276;651.0917270407755;656.678227668439;665.3280187011154;671.0772687554612;3850.730448868608;4187.898089171962;4209.6000879916355;4266.807993640294;4427.712198707074;53743;54921;56013.71993140008;58039;58127.41872581305;49160.26259606109;49880.501194987584;50058.99882002339;53091.46908530865;53598.46401535935;48715.05139794439;49228.50771492311;49642.50357496451;50944.490555094715;51214.23178652323;9081.68214112503;9120.361574689709;9247.676331328372;9293.907060929305;9327.113924177193;34093;34583.82708086444;34713.479297810045;34974;34999.4750078744;39289.60710392974;42614.78692606641;42878.35682464703;42963.570364295956;43202.567974319856;10603.41681207541;10861.891381086089;10913.56345746193;11011.403346514871;11690.357030363071;11453.312801231952;11750.941245294061;11906.583269585522;12011.219270747373;12222.830141755781;10653;10681;10707.785844282915;10823.134149267882;11419.714507137389;10859.891401085888;10994.505247263733;11037.834432483358;11060.723481913017;11070.501827417947;10680.732981675521;10698.62554810578;10749.785004299714;11015.83476247841;11518.596849110241;9214.677486287948;9281.72154835356;9367.250619950524;9836.21310295189;10432.321899076536;9483.620655173992;9946.900530994597;9998.600055997678;10017.599296028076;10027.54876030595 20:04:00 INFO - 2015-12-17 20:04:00,325 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:04:00 INFO - 2015-12-17 20:04:00,325 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:04:00 INFO - 2015-12-17 20:04:00,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,320 20:04:00 INFO - 2015-12-17 20:04:00,325 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:04:00 INFO - 2015-12-17 20:04:00,325 DEBUG : BROWSER_OUTPUT: __startTimestamp1450411440315__endTimestamp 20:04:00 INFO - 2015-12-17 20:04:00,325 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,326 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:04:00 INFO - 2015-12-17 20:04:00,327 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:04:00 INFO - 2015-12-17 20:04:00,327 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,327 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5267.28 Median:5457.21 stddev:577.32 (10.6%) stddev-sans-first:554.64 20:04:00 INFO - 2015-12-17 20:04:00,327 DEBUG : BROWSER_OUTPUT: Values: 3148.0 3175.4 3205.8 3224.5 3236.2 5108.2 5270.7 5312.2 5319.6 5322.3 5253.2 5270.9 5319.0 5332.3 5351.7 4792.7 4837.8 4883.0 4918.0 4960.6 4818.9 4862.2 4870.3 4875.3 4954.5 4659.6 4736.0 4740.9 4862.8 4867.5 4808.3 4826.5 4857.6 4868.9 4892.5 4773.6 4798.7 4834.8 4848.4 4867.2 4976.5 5021.9 5080.0 5080.0 5128.4 5687.2 5701.3 5704.9 5720.4 5726.2 5751.0 5751.1 5754.3 5754.4 5761.7 5151.8 5205.8 5216.1 5286.2 5336.8 5800.8 5805.1 5814.0 5820.8 5825.7 5397.3 5630.3 5645.8 5650.0 5661.7 5538.8 5630.9 5729.3 5742.3 5794.7 5572.2 5583.1 5587.3 5588.2 5595.2 5515.1 5550.5 5571.6 5633.2 5643.7 4362.5 4428.3 4437.5 4449.1 4472.3 3955.5 3958.8 3967.5 3975.6 3997.4 5213.0 5277.7 5369.1 5426.8 5472.0 5742.4 5744.3 5762.8 5768.0 5778.0 5406.3 5451.6 5452.0 5454.4 5463.4 4589.5 4640.2 4694.9 4777.6 4849.7 5801.7 5842.3 5852.4 5864.8 5868.4 5673.7 5735.8 5741.1 5758.6 5767.6 5619.3 5648.0 5725.4 5728.5 5735.1 5486.6 5554.6 5560.5 5562.5 5610.1 5731.3 5775.5 5787.3 5797.3 5802.4 5382.0 5611.5 5617.9 5621.6 5647.7 5439.7 5499.7 5554.8 5572.7 5610.6 5409.9 5427.2 5447.1 5460.3 5474.8 5430.8 5515.2 5620.7 5640.3 5673.1 5312.3 5350.3 5457.2 5464.9 5500.0 20:04:00 INFO - 2015-12-17 20:04:00,328 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,328 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46450.60 Median:37701.03 stddev:76101.14 (201.9%) stddev-sans-first:76236.66 20:04:00 INFO - 2015-12-17 20:04:00,329 DEBUG : BROWSER_OUTPUT: Values: 571.0 577.1 577.4 598.5 602.0 34856.5 35690.8 35769.1 35792.1 35915.1 41507.6 41816.8 42077.8 42105.8 42195.6 8619.9 8821.3 8830.5 8836.6 8837.9 8672.9 8688.7 8765.4 8769.3 8773.9 8717.9 8719.7 8754.5 8802.6 8832.0 8719.0 8744.7 8791.1 8805.8 8818.3 8643.2 8692.9 8721.8 8738.7 8751.3 38481.0 38772.8 38996.6 39038.4 39047.0 3191.9 3382.4 3700.6 3738.9 4064.6 29073.6 29245.4 29338.9 29458.1 30322.0 3786.9 3868.3 3879.7 3929.5 3988.4 251192.0 251447.0 251448.0 252015.0 253408.0 57846.4 57847.4 57985.7 58358.4 58365.4 68067.7 68777.3 68892.7 68900.7 69026.7 13688.0 13892.4 13965.2 14057.2 14098.4 9644.6 9759.1 9787.7 9840.0 9980.3 19801.0 19916.5 19928.8 20058.5 20079.5 7884.5 8147.9 8209.5 8243.3 8253.4 941.8 974.5 1014.7 1116.7 1136.3 27962.7 27981.9 28180.6 28197.6 28519.3 995.4 1018.7 1024.8 1107.4 1146.2 14420.1 14622.9 14816.0 14928.9 15074.8 321824.0 322314.0 325810.0 325986.0 329088.0 51190.5 51351.2 51614.2 51632.5 51833.5 1310.2 1310.7 1321.0 1336.5 1337.4 26735.7 27654.9 28000.4 28219.9 28336.6 47446.3 47645.5 47854.5 47894.0 48006.5 287876.0 291224.0 292493.0 292610.0 294151.0 32663.0 44524.3 44828.8 45181.0 45436.0 42791.4 42830.4 43071.4 43149.0 43393.8 36445.8 36506.0 36544.8 37181.4 37398.8 35385.6 36309.0 36559.0 36591.1 36603.5 35539.6 36887.3 37354.0 37551.8 37850.2 30524.4 32751.0 33152.0 33276.7 33361.0 25100.5 25277.2 25495.4 25617.2 25744.0 20:04:00 INFO - 2015-12-17 20:04:00,329 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,329 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28261.26 Median:37303.81 stddev:85797.32 (230.0%) stddev-sans-first:86012.42 20:04:00 INFO - 2015-12-17 20:04:00,329 DEBUG : BROWSER_OUTPUT: Values: 354.9 359.1 361.7 363.1 364.5 13565.3 13639.7 16420.3 16811.9 17401.2 14171.9 14204.9 14631.6 14658.3 14665.3 5262.8 5307.8 5329.9 5354.9 5357.4 5037.2 5208.6 5222.2 5251.8 5296.2 5163.0 5191.7 5248.1 5331.3 5996.2 5912.1 5912.6 5917.8 5935.3 5969.2 4899.8 5076.1 5267.6 5280.0 5290.8 12838.0 12901.4 13037.8 18640.3 20024.6 2088.5 2151.5 2174.5 2205.0 2227.0 9382.1 9571.5 9603.1 9723.7 12591.6 1760.8 1794.2 1816.0 1849.0 1879.8 58249.7 58571.0 58893.0 61220.7 61220.7 9991.7 10125.9 10188.2 10189.2 10256.8 13141.9 13266.7 13267.6 13303.5 13307.8 6978.8 7010.0 7094.7 7214.7 7260.7 6818.0 6842.0 6869.3 6869.6 6919.9 4275.0 4332.4 4400.0 4439.6 4443.7 1815.3 1829.5 1834.1 1848.0 1856.9 889.9 904.1 925.9 927.4 975.1 16038.3 16434.0 16628.0 16823.2 16920.8 941.2 947.5 963.8 982.4 1009.1 9415.5 9646.0 9877.2 10332.8 10405.9 499593.0 506293.1 531605.0 541892.0 542860.0 79024.6 79926.2 80029.0 80889.2 81983.0 1088.9 1101.2 1107.4 1115.7 1143.4 15043.6 15098.5 15167.0 15199.6 15340.5 35477.0 36333.5 36840.8 37766.8 38030.6 45044.8 47001.0 47008.3 47831.8 51346.2 9417.3 9431.4 9616.8 9674.2 9678.7 12471.9 16940.0 17076.2 17194.3 17545.7 14186.4 14239.0 14491.3 14521.2 14667.3 11957.5 13597.9 14071.2 14488.8 14578.1 14944.9 14968.9 15138.2 15144.5 15172.8 9547.5 9623.2 9703.4 9715.9 9741.3 12559.5 14610.9 14760.9 14941.7 15038.4 20:04:00 INFO - 2015-12-17 20:04:00,329 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,329 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5080.28 Median:6248.06 stddev:2568.66 (41.1%) stddev-sans-first:2561.44 20:04:00 INFO - 2015-12-17 20:04:00,331 DEBUG : BROWSER_OUTPUT: Values: 1458.4 1466.1 1618.8 1764.7 1765.8 7160.1 7179.1 7312.4 7329.9 7396.0 7304.3 7348.3 7378.3 7419.9 7425.6 2136.7 2175.2 2175.5 2176.0 2177.3 2076.7 2079.3 2134.5 2135.9 2137.8 1893.0 1935.6 2125.0 2176.7 2204.2 2105.8 2126.1 2141.3 2144.4 2148.3 2102.3 2135.0 2152.0 2163.2 2166.7 7168.9 7194.7 7242.4 7272.8 7310.2 4282.5 4427.9 4434.8 4435.7 4446.8 2849.9 2862.3 2978.5 2979.0 2979.7 995.2 1009.0 1009.2 1011.5 1018.3 9186.3 9397.2 9502.4 9528.4 9545.0 3839.2 3847.5 3896.4 3934.1 3941.4 8012.6 8025.5 8038.0 8045.4 8053.6 4368.2 4377.7 4388.5 4395.5 4402.5 4015.6 4038.1 4061.2 4065.2 4066.3 3270.9 3274.7 3285.9 3296.2 3313.4 990.8 1011.2 1019.1 1019.8 1020.8 1066.8 1072.9 1130.7 1247.8 1269.6 6994.8 7024.2 7067.9 7077.4 7082.5 1057.4 1111.4 1129.6 1139.8 1174.4 5416.7 5436.2 5452.2 5474.4 5489.0 8196.2 8374.7 8412.6 8429.5 8526.1 8575.4 8601.2 8641.3 8648.2 8667.9 6719.0 6776.8 6857.0 6884.3 6887.4 6823.9 6892.6 6901.7 6908.2 6922.0 7470.1 7679.8 7812.5 7868.2 7879.4 7821.5 7941.7 7981.8 7991.1 8031.2 6540.2 6591.3 6623.0 6636.5 6640.9 6464.0 6673.9 6683.9 6697.3 6737.4 6414.1 6504.0 6558.7 6653.6 6670.4 6196.6 6275.8 6339.4 6340.3 6650.0 6577.3 6578.7 6607.4 6609.0 6610.1 5966.7 6039.5 6117.2 6158.3 6168.9 6234.6 6241.6 6254.6 6259.7 6261.0 20:04:00 INFO - 2015-12-17 20:04:00,331 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,331 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5616.43 Median:6376.94 stddev:1704.95 (26.7%) stddev-sans-first:1663.13 20:04:00 INFO - 2015-12-17 20:04:00,332 DEBUG : BROWSER_OUTPUT: Values: 341.8 342.7 347.0 348.8 351.4 6205.8 6236.7 6350.4 6402.8 6411.3 6138.2 6224.1 6271.4 6277.7 6292.1 4766.1 4819.5 4824.6 4835.5 4837.2 4838.2 4842.7 4843.6 4845.3 4848.0 4674.8 4820.3 4822.7 4823.3 4825.0 4808.8 4809.0 4809.1 4814.5 4817.5 4236.9 4238.2 4244.6 4245.4 4248.7 6005.4 6012.2 6026.6 6027.2 6031.4 5415.9 5581.1 5587.4 5588.8 5598.6 6689.0 6697.1 6699.3 6703.3 6705.8 4597.3 4599.9 4602.6 4609.9 4617.3 6691.3 6874.5 6944.4 6961.1 6962.5 4661.3 4683.7 4710.7 4714.5 4726.1 4764.5 4768.2 4770.0 4770.0 4793.2 5544.2 5544.2 5550.8 5552.8 5571.5 6534.0 6707.9 6739.5 6743.4 6748.7 1630.6 1669.5 1676.5 1683.2 1685.6 1105.5 1113.9 1115.3 1127.2 1135.7 6321.7 6409.3 6415.4 6428.3 6440.5 6837.2 6840.0 6863.0 6863.6 6891.3 6366.8 6374.6 6379.3 6416.0 6423.1 3780.8 3807.8 3822.7 3826.2 3829.6 7129.4 7195.7 7202.8 7205.0 7217.2 7004.8 7160.8 7167.5 7196.0 7210.6 7194.4 7209.1 7212.2 7221.3 7239.2 7018.5 7026.4 7041.8 7042.9 7043.4 6730.3 6898.5 6925.1 6940.7 6945.8 7181.8 7188.8 7211.1 7218.4 7219.5 4682.2 4735.2 4735.3 4743.4 4756.1 6823.9 6887.6 6996.7 7005.4 7033.0 6775.1 6808.4 6813.7 6814.7 6825.1 6765.6 6771.4 6782.1 6791.1 6807.2 6475.8 6634.3 6649.3 6657.2 6666.1 6797.2 6803.4 6806.1 6809.9 6837.5 6629.0 6629.2 6668.5 6673.9 6677.4 20:04:00 INFO - 2015-12-17 20:04:00,332 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,332 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13603.18 Median:4500.03 stddev:15684.64 (348.5%) stddev-sans-first:15699.19 20:04:00 INFO - 2015-12-17 20:04:00,333 DEBUG : BROWSER_OUTPUT: Values: 805.2 817.4 848.4 857.1 888.9 12966.5 13236.4 13268.9 13307.3 13314.9 11865.8 11922.2 11931.5 11948.8 11964.6 650.7 663.1 799.1 812.4 816.9 805.6 805.8 810.0 811.4 814.8 837.6 841.4 842.8 846.3 847.4 830.5 831.7 834.8 837.4 838.8 622.3 622.5 623.1 623.9 626.6 13310.3 13314.5 13359.5 13477.5 13492.5 10904.2 12201.5 12357.8 12543.2 12681.9 10612.6 10633.1 10669.3 10922.5 10940.9 3636.5 3672.1 3694.4 3785.7 3794.8 43842.0 43947.8 44063.8 44256.0 44461.6 9504.7 9558.7 9610.3 9682.3 9733.7 17474.4 17632.6 17748.0 17757.0 17861.0 7170.1 7349.7 7490.6 7569.6 7758.5 4397.9 4445.3 4463.3 4536.8 4690.1 2815.1 2855.4 2860.8 2865.1 2873.2 544.6 552.9 565.4 578.7 580.3 549.0 652.6 672.2 697.3 723.9 8848.7 8867.6 8951.6 9178.7 9213.2 521.7 651.1 656.7 665.3 671.1 3850.7 4187.9 4209.6 4266.8 4427.7 53743.0 54921.0 56013.7 58039.0 58127.4 49160.3 49880.5 50059.0 53091.5 53598.5 48715.1 49228.5 49642.5 50944.5 51214.2 9081.7 9120.4 9247.7 9293.9 9327.1 34093.0 34583.8 34713.5 34974.0 34999.5 39289.6 42614.8 42878.4 42963.6 43202.6 10603.4 10861.9 10913.6 11011.4 11690.4 11453.3 11750.9 11906.6 12011.2 12222.8 10653.0 10681.0 10707.8 10823.1 11419.7 10859.9 10994.5 11037.8 11060.7 11070.5 10680.7 10698.6 10749.8 11015.8 11518.6 9214.7 9281.7 9367.3 9836.2 10432.3 9483.6 9946.9 9998.6 10017.6 10027.5 20:04:00 INFO - 2015-12-17 20:04:00,333 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:04:00 INFO - 2015-12-17 20:04:00,333 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2015-12-17 20:04:00,956 INFO : Browser exited with error code: 0 20:04:00 INFO - 2015-12-17 20:04:00,973 INFO : Completed test dromaeo_css (00:18:30) 20:04:00 INFO - 2015-12-17 20:04:00,973 INFO : Starting test kraken 20:04:00 INFO - 2015-12-17 20:04:00,973 DEBUG : operating with platform_type : linux_ 20:04:00 INFO - 2015-12-17 20:04:00,973 INFO : Initialising browser for kraken test... 20:04:00 INFO - 2015-12-17 20:04:00,979 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp02Mqvy/profile http://localhost:59747/getInfo.html 20:04:05 INFO - 2015-12-17 20:04:05,237 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:04:05 INFO - 2015-12-17 20:04:05,237 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:04:05 INFO - 2015-12-17 20:04:05,237 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:04:05 INFO - 2015-12-17 20:04:05,237 DEBUG : BROWSER_OUTPUT: __metrics 20:04:05 INFO - 2015-12-17 20:04:05,333 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:04:06 INFO - 2015-12-17 20:04:06,232 INFO : Browser initialized. 20:04:06 INFO - 2015-12-17 20:04:06,233 INFO : Running cycle 1/1 for kraken test... 20:04:06 INFO - 2015-12-17 20:04:06,233 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp02Mqvy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:04:18 INFO - 2015-12-17 20:04:18,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 151048192 20:04:18 INFO - 2015-12-17 20:04:18,054 DEBUG : BROWSER_OUTPUT: 20:04:20 INFO - 2015-12-17 20:04:20,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59747/tests/kraken/driver.html?testName=audio-beat-detection) 20:04:21 INFO - 2015-12-17 20:04:21,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 152539136 20:04:21 INFO - 2015-12-17 20:04:21,158 DEBUG : BROWSER_OUTPUT: 20:04:23 INFO - 2015-12-17 20:04:23,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59747/tests/kraken/driver.html?testName=audio-dft) 20:04:24 INFO - 2015-12-17 20:04:24,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 151908352 20:04:24 INFO - 2015-12-17 20:04:24,391 DEBUG : BROWSER_OUTPUT: 20:04:27 INFO - 2015-12-17 20:04:27,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59747/tests/kraken/driver.html?testName=audio-fft) 20:04:27 INFO - 2015-12-17 20:04:27,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 146534400 20:04:27 INFO - 2015-12-17 20:04:27,812 DEBUG : BROWSER_OUTPUT: 20:04:29 INFO - 2015-12-17 20:04:29,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59747/tests/kraken/driver.html?testName=audio-oscillator) 20:04:30 INFO - 2015-12-17 20:04:30,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 146780160 20:04:30 INFO - 2015-12-17 20:04:30,442 DEBUG : BROWSER_OUTPUT: 20:04:32 INFO - 2015-12-17 20:04:32,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:04:33 INFO - 2015-12-17 20:04:33,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 147050496 20:04:33 INFO - 2015-12-17 20:04:33,257 DEBUG : BROWSER_OUTPUT: 20:04:36 INFO - 2015-12-17 20:04:36,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59747/tests/kraken/driver.html?testName=imaging-darkroom) 20:04:36 INFO - 2015-12-17 20:04:36,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 146821120 20:04:36 INFO - 2015-12-17 20:04:36,797 DEBUG : BROWSER_OUTPUT: 20:04:40 INFO - 2015-12-17 20:04:40,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59747/tests/kraken/driver.html?testName=imaging-desaturate) 20:04:40 INFO - 2015-12-17 20:04:40,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 147980288 20:04:40 INFO - 2015-12-17 20:04:40,741 DEBUG : BROWSER_OUTPUT: 20:04:43 INFO - 2015-12-17 20:04:43,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59747/tests/kraken/driver.html?testName=json-parse-financial) 20:04:44 INFO - 2015-12-17 20:04:44,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 148467712 20:04:44 INFO - 2015-12-17 20:04:44,140 DEBUG : BROWSER_OUTPUT: 20:04:45 INFO - 2015-12-17 20:04:45,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:04:46 INFO - 2015-12-17 20:04:46,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 149024768 20:04:46 INFO - 2015-12-17 20:04:46,302 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2015-12-17 20:04:48,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:04:48 INFO - 2015-12-17 20:04:48,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 148873216 20:04:48 INFO - 2015-12-17 20:04:48,727 DEBUG : BROWSER_OUTPUT: 20:04:50 INFO - 2015-12-17 20:04:50,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:04:51 INFO - 2015-12-17 20:04:51,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 148574208 20:04:51 INFO - 2015-12-17 20:04:51,421 DEBUG : BROWSER_OUTPUT: 20:04:53 INFO - 2015-12-17 20:04:53,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:04:54 INFO - 2015-12-17 20:04:54,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 148619264 20:04:54 INFO - 2015-12-17 20:04:54,445 DEBUG : BROWSER_OUTPUT: 20:04:57 INFO - 2015-12-17 20:04:57,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:04:57 INFO - 2015-12-17 20:04:57,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 148287488 20:04:57 INFO - 2015-12-17 20:04:57,647 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59747/tests/kraken/driver.html?testName=ai-astar) 20:04:59 INFO - 2015-12-17 20:04:59,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 148979712 20:04:59 INFO - 2015-12-17 20:04:59,582 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,583 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:04:59 INFO - 2015-12-17 20:04:59,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:04:59 INFO - 2015-12-17 20:04:59,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:04:59 INFO - 2015-12-17 20:04:59,584 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:04:59 INFO - 2015-12-17 20:04:59,585 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;112;112;113;124;114;112;112;112 20:04:59 INFO - 2015-12-17 20:04:59,585 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;145;167;122;155;161;135;171;123 20:04:59 INFO - 2015-12-17 20:04:59,585 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;161;164;160;161;161;168;162 20:04:59 INFO - 2015-12-17 20:04:59,585 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;72;73;72;72;158;71;71;72 20:04:59 INFO - 2015-12-17 20:04:59,585 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;141;93;94;92;142;93;94;134 20:04:59 INFO - 2015-12-17 20:04:59,586 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;110;110;111;110;110 20:04:59 INFO - 2015-12-17 20:04:59,586 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;146;147;146;146;147 20:04:59 INFO - 2015-12-17 20:04:59,586 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;97;98;96;96;96;96 20:04:59 INFO - 2015-12-17 20:04:59,586 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;62;61;61;64;63;60;58;58 20:04:59 INFO - 2015-12-17 20:04:59,587 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;77;68;67;68;68;68;68;67;68 20:04:59 INFO - 2015-12-17 20:04:59,588 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;92;91;84;84;86;84;93;85;86 20:04:59 INFO - 2015-12-17 20:04:59,588 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;115;122;114;139;124;119;116;116;120 20:04:59 INFO - 2015-12-17 20:04:59,588 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;162;143;142;153;157;152;155;163;140 20:04:59 INFO - 2015-12-17 20:04:59,588 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;68;72;66;68;66;67;68;68 20:04:59 INFO - 2015-12-17 20:04:59,589 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:04:59 INFO - 2015-12-17 20:04:59,589 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:04:59 INFO - 2015-12-17 20:04:59,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,730 20:04:59 INFO - 2015-12-17 20:04:59,589 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:04:59 INFO - 2015-12-17 20:04:59,589 DEBUG : BROWSER_OUTPUT: __startTimestamp1450411499583__endTimestamp 20:04:59 INFO - 2015-12-17 20:04:59,589 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,593 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:04:59 INFO - 2015-12-17 20:04:59,593 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:04:59 INFO - 2015-12-17 20:04:59,593 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,593 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:112.50 stddev:4.25 (3.8%) stddev-sans-first:4.51 20:04:59 INFO - 2015-12-17 20:04:59,594 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 112.0 112.0 113.0 124.0 114.0 112.0 112.0 112.0 20:04:59 INFO - 2015-12-17 20:04:59,594 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,594 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:152.50 stddev:18.54 (12.2%) stddev-sans-first:19.59 20:04:59 INFO - 2015-12-17 20:04:59,594 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 145.0 167.0 122.0 155.0 161.0 135.0 171.0 123.0 20:04:59 INFO - 2015-12-17 20:04:59,594 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,595 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.30 (1.4%) stddev-sans-first:2.40 20:04:59 INFO - 2015-12-17 20:04:59,595 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 161.0 164.0 160.0 161.0 161.0 168.0 162.0 20:04:59 INFO - 2015-12-17 20:04:59,595 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,595 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:72.00 stddev:27.06 (37.6%) stddev-sans-first:28.68 20:04:59 INFO - 2015-12-17 20:04:59,595 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 72.0 73.0 72.0 72.0 158.0 71.0 71.0 72.0 20:04:59 INFO - 2015-12-17 20:04:59,596 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,596 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:93.50 stddev:22.12 (23.7%) stddev-sans-first:22.95 20:04:59 INFO - 2015-12-17 20:04:59,596 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 141.0 93.0 94.0 92.0 142.0 93.0 94.0 134.0 20:04:59 INFO - 2015-12-17 20:04:59,596 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,596 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 20:04:59 INFO - 2015-12-17 20:04:59,596 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 97.0 98.0 96.0 96.0 96.0 96.0 20:04:59 INFO - 2015-12-17 20:04:59,597 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.91 (3.1%) stddev-sans-first:2.03 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 62.0 61.0 61.0 64.0 63.0 60.0 58.0 58.0 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:2.95 (4.3%) stddev-sans-first:3.11 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: Values: 68.0 77.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.50 stddev:3.69 (4.2%) stddev-sans-first:3.70 20:04:59 INFO - 2015-12-17 20:04:59,598 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 91.0 84.0 84.0 86.0 84.0 93.0 85.0 86.0 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.00 stddev:7.25 (6.0%) stddev-sans-first:7.68 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 122.0 114.0 139.0 124.0 119.0 116.0 116.0 120.0 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:154.00 stddev:8.62 (5.6%) stddev-sans-first:8.52 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: Values: 142.0 162.0 143.0 142.0 153.0 157.0 152.0 155.0 163.0 140.0 20:04:59 INFO - 2015-12-17 20:04:59,599 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,600 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.79 20:04:59 INFO - 2015-12-17 20:04:59,600 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 68.0 72.0 66.0 68.0 66.0 67.0 68.0 68.0 20:04:59 INFO - 2015-12-17 20:04:59,600 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:04:59 INFO - 2015-12-17 20:04:59,600 DEBUG : BROWSER_OUTPUT: 20:05:00 INFO - 2015-12-17 20:05:00,460 INFO : Browser exited with error code: 0 20:05:00 INFO - 2015-12-17 20:05:00,511 INFO : Completed test kraken (00:00:59) 20:05:00 INFO - 2015-12-17 20:05:00,511 INFO : Starting test v8_7 20:05:00 INFO - 2015-12-17 20:05:00,511 DEBUG : operating with platform_type : linux_ 20:05:00 INFO - 2015-12-17 20:05:00,511 INFO : Initialising browser for v8_7 test... 20:05:00 INFO - 2015-12-17 20:05:00,517 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcP4wGM/profile http://localhost:59747/getInfo.html 20:05:04 INFO - 2015-12-17 20:05:04,734 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:04 INFO - 2015-12-17 20:05:04,734 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:04 INFO - 2015-12-17 20:05:04,735 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:05:04 INFO - 2015-12-17 20:05:04,735 DEBUG : BROWSER_OUTPUT: __metrics 20:05:04 INFO - 2015-12-17 20:05:04,823 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:05:05 INFO - 2015-12-17 20:05:05,656 INFO : Browser initialized. 20:05:05 INFO - 2015-12-17 20:05:05,657 INFO : Running cycle 1/1 for v8_7 test... 20:05:05 INFO - 2015-12-17 20:05:05,657 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcP4wGM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:05:17 INFO - 2015-12-17 20:05:17,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 150941696 20:05:17 INFO - 2015-12-17 20:05:17,447 DEBUG : BROWSER_OUTPUT: 20:05:38 INFO - 2015-12-17 20:05:38,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59747/tests/v8_7/run.html (next: http://localhost:59747/tests/v8_7/run.html) 20:05:39 INFO - 2015-12-17 20:05:39,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 146415616 20:05:39 INFO - 2015-12-17 20:05:39,074 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,075 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:39 INFO - 2015-12-17 20:05:39,076 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:39 INFO - 2015-12-17 20:05:39,076 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:39 INFO - 2015-12-17 20:05:39,076 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:39 INFO - 2015-12-17 20:05:39,076 DEBUG : BROWSER_OUTPUT: |0;Richards;165.26194017517767 20:05:39 INFO - 2015-12-17 20:05:39,077 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.5014137606032 20:05:39 INFO - 2015-12-17 20:05:39,077 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 20:05:39 INFO - 2015-12-17 20:05:39,077 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 20:05:39 INFO - 2015-12-17 20:05:39,077 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1057.0824524312895 20:05:39 INFO - 2015-12-17 20:05:39,077 DEBUG : BROWSER_OUTPUT: |5;Earley;701.2622720897616 20:05:39 INFO - 2015-12-17 20:05:39,077 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 20:05:39 INFO - 2015-12-17 20:05:39,078 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 20:05:39 INFO - 2015-12-17 20:05:39,078 DEBUG : BROWSER_OUTPUT: |8;Splay;692.2015182884749 20:05:39 INFO - 2015-12-17 20:05:39,078 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 20:05:39 INFO - 2015-12-17 20:05:39,078 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:39 INFO - 2015-12-17 20:05:39,078 DEBUG : BROWSER_OUTPUT: __startTimestamp1450411539074__endTimestamp 20:05:39 INFO - 2015-12-17 20:05:39,078 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,079 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:39 INFO - 2015-12-17 20:05:39,079 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:05:39 INFO - 2015-12-17 20:05:39,079 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,079 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.26 Median:165.26 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,079 DEBUG : BROWSER_OUTPUT: Values: 165.3 20:05:39 INFO - 2015-12-17 20:05:39,079 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,080 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,080 DEBUG : BROWSER_OUTPUT: Values: 188.5 20:05:39 INFO - 2015-12-17 20:05:39,080 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,080 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,081 DEBUG : BROWSER_OUTPUT: Values: 279.9 20:05:39 INFO - 2015-12-17 20:05:39,081 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,081 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,081 DEBUG : BROWSER_OUTPUT: Values: 5191.7 20:05:39 INFO - 2015-12-17 20:05:39,081 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,081 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,082 DEBUG : BROWSER_OUTPUT: Values: 1057.1 20:05:39 INFO - 2015-12-17 20:05:39,082 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,082 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:701.26 Median:701.26 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,082 DEBUG : BROWSER_OUTPUT: Values: 701.3 20:05:39 INFO - 2015-12-17 20:05:39,082 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,082 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: Values: 12180.7 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: Values: 25350.0 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:692.20 Median:692.20 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,083 DEBUG : BROWSER_OUTPUT: Values: 692.2 20:05:39 INFO - 2015-12-17 20:05:39,084 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,084 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:05:39 INFO - 2015-12-17 20:05:39,084 DEBUG : BROWSER_OUTPUT: Values: 4830.9 20:05:39 INFO - 2015-12-17 20:05:39,084 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:39 INFO - 2015-12-17 20:05:39,084 DEBUG : BROWSER_OUTPUT: 20:05:39 INFO - 2015-12-17 20:05:39,904 INFO : Browser exited with error code: 0 20:05:39 INFO - 2015-12-17 20:05:39,919 INFO : Completed test v8_7 (00:00:39) 20:05:40 INFO - 2015-12-17 20:05:40,099 INFO : Completed test suite (00:20:09) 20:05:40 INFO - 2015-12-17 20:05:40,099 DEBUG : Working with test: dromaeo_css 20:05:40 INFO - 2015-12-17 20:05:40,100 DEBUG : Generating results file: dromaeo_css 20:05:40 INFO - 2015-12-17 20:05:40,101 DEBUG : Working with test: kraken 20:05:40 INFO - 2015-12-17 20:05:40,101 DEBUG : Generating results file: kraken 20:05:40 INFO - 2015-12-17 20:05:40,101 INFO : javascript benchmark 20:05:40 INFO - 2015-12-17 20:05:40,102 DEBUG : Working with test: v8_7 20:05:40 INFO - 2015-12-17 20:05:40,102 DEBUG : Generating results file: v8_7 20:05:40 INFO - 2015-12-17 20:05:40,102 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:40 INFO - 2015-12-17 20:05:40,160 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:05:40 INFO - 2015-12-17 20:05:40,160 DEBUG : process_Request line: dromaeo_css 6957.66 graph.html#tests=[[72,64,43]] 20:05:40 INFO - 2015-12-17 20:05:40,161 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:40 INFO - 2015-12-17 20:05:40,198 DEBUG : process_Request line: kraken 1517.60 graph.html#tests=[[232,64,43]] 20:05:40 INFO - 2015-12-17 20:05:40,198 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:40 INFO - 2015-12-17 20:05:40,231 DEBUG : process_Request line: v8_7 21160.31 graph.html#tests=[[230,64,43]] 20:05:40 INFO - 2015-12-17 20:05:40,233 INFO : javascript benchmark 20:05:40 INFO - 2015-12-17 20:05:40,236 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.95278070829, 3175.380800743856, 3205.8236796976184, 3224.484082546793, 3236.2233064064617, 5108.157154069583, 5270.7364631768405, 5312.150055991042, 5319.574434045272, 5322.33470816148, 5253.185756207794, 5270.92093618595, 5319.0, 5332.253484512162, 5351.652142610737, 4792.688475249098, 4837.830675926343, 4883.047805677894, 4918.016396720653, 4960.553550180483, 4818.927716084244, 4862.2220444728855, 4870.269459581055, 4875.268709693557, 4954.479779623141, 4659.62722982164, 4735.952640473585, 4740.881477963044, 4862.805487780484, 4867.488913664068, 4808.2547205183255, 4826.541478559567, 4857.587105096071, 4868.9269660955115, 4892.486288939645, 4773.570378665902, 4798.736069516175, 4834.830780922686, 4848.442429120661, 4867.2212446008825, 4976.477469865685, 5021.874453138665, 5079.974600127012, 5080.0, 5128.358955130609, 5687.175359572881, 5701.344345400249, 5704.8859022819315, 5720.399358067426, 5726.226959360475, 5750.971245143789, 5751.1085781703905, 5754.3094828620415, 5754.395788442237, 5761.654300741927, 5151.7681704323395, 5205.843824685266, 5216.087184742655, 5286.20706893969, 5336.759845806987, 5800.767969281182, 5805.10020946754, 5814.011618024946, 5820.767169313265, 5825.650460972355, 5397.325334333208, 5630.324361076697, 5645.774169033275, 5650.0, 5661.745221465044, 5538.833834984957, 5630.859228519238, 5729.341125770507, 5742.339630942495, 5794.710264486843, 5572.219889215513, 5583.05088135018, 5587.273654424899, 5588.161775733591, 5595.244641973281, 5515.062439385314, 5550.5282051026115, 5571.609987300931, 5633.239512665819, 5643.661380317194, 4362.498312694017, 4428.291473364311, 4437.534058923831, 4449.065696203834, 4472.284434490466, 3955.5253369595257, 3958.782266975344, 3967.4643923070016, 3975.582563830756, 3997.420374045747, 5213.0, 5277.709725965032, 5369.087255166631, 5426.810061647823, 5471.972640136773, 5742.368339482654, 5744.281964754406, 5762.769489220468, 5767.971160144172, 5778.0, 5406.324209473816, 5451.618386712892, 5451.972740136274, 5454.400015998237, 5463.399026107125, 4589.495155532889, 4640.234361330343, 4694.882627934329, 4777.641676874248, 4849.733264670406, 5801.6809075500405, 5842.298924129132, 5852.4440178183, 5864.794732184353, 5868.4424979626865, 5673.716314184357, 5735.827925162252, 5741.1388291756575, 5758.596898217253, 5767.5674324425, 5619.269494965628, 5648.0, 5725.370209277059, 5728.484436400744, 5735.11105778605, 5486.588505861996, 5554.611177217556, 5560.527355174855, 5562.527185189142, 5610.102383618601, 5731.283589551306, 5775.451332123442, 5787.305523337226, 5797.333306669787, 5802.448767367094, 5382.031234377693, 5611.466910643482, 5617.943820561905, 5621.578381621313, 5647.745851436613, 5439.700816455133, 5499.7250137492165, 5554.750036248298, 5572.665640061609, 5610.635308705085, 5409.864753381197, 5427.158790387496, 5447.101228297287, 5460.290162279037, 5474.808381706621, 5430.809921652881, 5515.172724091419, 5620.690862002629, 5640.294963129609, 5673.120666296731, 5312.309399778004, 5350.250964865, 5457.20870473787, 5464.863378415572, 5500.0], "unit": "score", "name": "dojo.html", "value": 5230.637183186717}, {"lowerIsBetter": false, "replicates": [570.9657420554767, 577.068035123276, 577.376433451872, 598.4703537369429, 601.9909701354478, 34856.47715284269, 35690.8215458923, 35769.1057723557, 35792.105197370045, 35915.10212244695, 41507.58492415075, 41816.79091604545, 42077.7896110519, 42105.78947105268, 42195.57804421955, 8619.87070193946, 8821.2942964563, 8830.514321712304, 8836.646534138627, 8837.911620883806, 8672.913270867273, 8688.695895643654, 8765.386422950396, 8769.298456123495, 8773.868391974125, 8717.912820871774, 8719.651213951434, 8754.474731516098, 8802.559872006406, 8832.0, 8719.04090550039, 8744.693935712283, 8791.076936921596, 8805.823883522293, 8818.250448711835, 8643.17889800468, 8692.913070869274, 8721.825563488757, 8738.737837864874, 8751.256143227833, 38481.0, 38772.80613596942, 38996.61003389958, 39038.414423783666, 39047.0, 3191.872325106993, 3382.374260761767, 3700.6299370063048, 3738.934403694961, 4064.5935406459116, 29073.563896541567, 29245.415091698258, 29338.853305733333, 29458.116256512338, 30322.0, 3786.8863934082024, 3868.303705333039, 3879.72841901067, 3929.5088113985753, 3988.3618621020787, 251192.0, 251447.0, 251447.99999999817, 252015.0, 253408.0, 57846.421535784946, 57847.421525785045, 57985.71007144937, 58358.416415836145, 58365.416345836, 68067.65966170236, 68777.31222687809, 68892.655536722, 68900.65549672219, 69026.65486672636, 13688.041837071509, 13892.444302227797, 13965.162090274616, 14057.22685252321, 14098.365573549216, 9644.565994530263, 9759.072888075621, 9787.706368808947, 9840.0, 9980.251481138943, 19801.0, 19916.50208744793, 19928.800711992695, 20058.498537536678, 20079.49801254951, 7884.476967370387, 8147.877781833277, 8209.466384684976, 8243.340532757486, 8253.380996425292, 941.7551436626527, 974.5224839828433, 1014.7058095619894, 1116.6705821782593, 1136.2671077155353, 27962.72037279642, 27981.860090699418, 28180.577291340647, 28197.57703634447, 28519.28701782472, 995.4176806568094, 1018.6791160784329, 1024.8257796174669, 1107.385401102396, 1146.2091157101572, 14420.134791912518, 14622.926885365505, 14816.0, 14928.925355373154, 15074.849251507345, 321824.0, 322314.0, 325810.0, 325986.0, 329088.0, 51190.48809511932, 51351.229731554056, 51614.22578661323, 51632.483675163516, 51833.481665182866, 1310.2138716769862, 1310.724747802953, 1321.0, 1336.5322137251885, 1337.3580681273043, 26735.732642673323, 27654.861725691244, 28000.43999120047, 28219.858900706186, 28336.57495137616, 47446.28830567475, 47645.52354476411, 47854.521454785005, 47894.0, 48006.519934800206, 287876.0, 291224.0, 292493.0, 292610.0, 294151.0, 32663.0, 44524.33213501735, 44828.77585612051, 45181.0, 45436.0, 42791.3581296287, 42830.35754463623, 43071.35392969046, 43149.0, 43393.78303108464, 36445.81777091097, 36506.0, 36544.81727591345, 37181.442278365306, 37398.8130059348, 35385.64614353824, 36309.0, 36559.0, 36591.08522286964, 36603.45094823633, 35539.644603553636, 36887.26225475422, 37354.0, 37551.81224093971, 37850.24299514049, 30524.389512210077, 32751.0, 33152.0, 33276.66723332736, 33361.0, 25100.49799003973, 25277.241682749547, 25495.36261593475, 25617.193441123043, 25744.0], "unit": "score", "name": "ext.html", "value": 18573.59509112143}, {"lowerIsBetter": false, "replicates": [354.9467579863021, 359.0538929919661, 361.7449697962936, 363.1447940101062, 364.4824349423818, 13565.32173391329, 13639.727205455885, 16420.34318627255, 16811.915940420295, 17401.216945237462, 14171.929140354283, 14204.857951420483, 14631.561053168396, 14658.340374683139, 14665.340059697313, 5262.842114736545, 5307.761150748206, 5329.880725047745, 5354.892902141954, 5357.357117145948, 5037.168867136918, 5208.609354298424, 5222.242774797652, 5251.842444726664, 5296.179092240709, 5162.974185129069, 5191.740412979355, 5248.0553500369915, 5331.253624492574, 5996.19051428056, 5912.054071348585, 5912.615679980788, 5917.763289468416, 5935.317438494585, 5969.164316995624, 4899.7550122494085, 5076.13705670037, 5267.55225805807, 5280.0, 5290.761915713802, 12838.0, 12901.354932253444, 13037.804432933513, 18640.25438982439, 20024.599508009906, 2088.5196404826825, 2151.4728891421546, 2174.510735084609, 2204.9669254961186, 2226.9665955010687, 9382.10869967352, 9571.473568953705, 9603.087706667926, 9723.693459128279, 12591.622251332476, 1760.7887053553527, 1794.2195145111918, 1815.9909200454044, 1849.0, 1879.7650293713286, 58249.7087514564, 58571.0, 58893.0, 61220.69389653023, 61220.69389653023, 9991.700248992542, 10125.886152523217, 10188.184945204366, 10189.184865210766, 10256.794864102676, 13141.868581314257, 13266.734665306833, 13267.601971940858, 13303.46786128544, 13307.800382994263, 6978.825529361705, 7009.9649501752165, 7094.68073936674, 7214.67533960973, 7260.709571617182, 6818.0, 6842.0, 6869.278725733826, 6869.553479023847, 6919.861602767916, 4275.0, 4332.371806088163, 4399.978000109979, 4439.556044395535, 4443.6667249955735, 1815.337401848316, 1829.4603092087866, 1834.0737927346604, 1847.9722804157948, 1856.9071546422624, 889.9377043606885, 904.0778406025948, 925.8518637018045, 927.3693888155984, 975.0882924465648, 16038.278277477542, 16434.0, 16628.0, 16823.15884205785, 16920.830791692173, 941.1717688434271, 947.5215016416665, 963.8409662405764, 982.4498280962541, 1009.1239966096566, 9415.529223538795, 9646.0, 9877.209823214269, 10332.845007324897, 10405.947970260251, 499593.0, 506293.0909490871, 531605.0, 541892.0, 542860.0, 79024.60487697525, 79926.20073799304, 80029.0, 80889.19110808935, 81983.0, 1088.8638920134983, 1101.2016288190998, 1107.3909349857547, 1115.70991542198, 1143.445428966967, 15043.623909402353, 15098.54704358871, 15167.0, 15199.620009499851, 15340.539783806504, 35477.0, 36333.45499817452, 36840.81579592085, 37766.811165944, 38030.619693802706, 45044.77477612591, 47001.0, 47008.29487557621, 47831.76084119557, 51346.22980655368, 9417.340786144903, 9431.386959847589, 9616.75958101053, 9674.177694896012, 9678.70963871085, 12471.875281247072, 16939.983600983982, 17076.23156957915, 17194.31222751076, 17545.736813947547, 14186.3616137272, 14239.0, 14491.275436227936, 14521.201333926736, 14667.266636667911, 11957.521699132285, 13597.932010339884, 14071.226082565558, 14488.840892728345, 14578.125312481285, 14944.925275373553, 14968.85031149718, 15138.167400793061, 15144.54566363011, 15172.772408413663, 9547.474888881177, 9623.230141588796, 9703.417794932328, 9715.9028409715, 9741.295273326998, 12559.497620095093, 14610.92694536563, 14760.852391475948, 14941.701165976838, 15038.398464061314], "unit": "score", "name": "jquery.html", "value": 8764.868119535604}, {"lowerIsBetter": false, "replicates": [1458.4166333466615, 1466.1423067505511, 1618.8219295877452, 1764.664713704396, 1765.7704498415203, 7160.069191005168, 7179.138503379601, 7312.37844783194, 7329.890051649216, 7395.999999999994, 7304.269573042693, 7348.2651734826495, 7378.33594976452, 7419.851602967938, 7425.591592462412, 2136.700861879338, 2175.2060497918305, 2175.4996350839315, 2175.9564808703817, 2177.2706143441965, 2076.678114892194, 2079.324219628627, 2134.5410736691606, 2135.9252426165085, 2137.7969092936146, 1892.9716054259197, 1935.6225536020481, 2124.968125478119, 2176.6952626632283, 2204.195468653938, 2105.842061845368, 2126.1282874021654, 2141.2612648636195, 2144.378130342199, 2148.3340164548963, 2102.3167470572125, 2134.957300853974, 2151.9892400537897, 2163.1888041984257, 2166.73999120105, 7168.9283107168785, 7194.748183813594, 7242.384397326234, 7272.818179545501, 7310.195878453366, 4282.486101667789, 4427.867163985085, 4434.800433980478, 4435.667324950609, 4446.799894004777, 2849.9430011399863, 2862.3416614178855, 2978.4936560784718, 2979.016924414938, 2979.657339405974, 995.213591603067, 1009.0464511037073, 1009.1926458832904, 1011.549860312154, 1018.332991890313, 9186.26509879208, 9397.248220142372, 9502.382345147613, 9528.380655257455, 9544.95227523865, 3839.212961342918, 3847.5382954045695, 3896.3960586109197, 3934.1148241645974, 3941.4087886817206, 8012.639431225492, 8025.518468891885, 8038.035435747748, 8045.396595255379, 8053.6375863086305, 4368.235558777201, 4377.715448495837, 4388.4953230378915, 4395.450568678915, 4402.537733537996, 4015.6185162409524, 4038.1116154445976, 4061.2283666103344, 4065.166640838621, 4066.268071747114, 3270.8528116234825, 3274.6561611030497, 3285.868565257411, 3296.225387034045, 3313.436715758327, 990.7721224118493, 1011.1506334678905, 1019.0930072235716, 1019.8266294729914, 1020.7754294055296, 1066.8399740039056, 1072.855164552791, 1130.728625129963, 1247.812828075796, 1269.57469247803, 6994.755183568551, 7024.157101147793, 7067.89398159028, 7077.3984211341585, 7082.504224704221, 1057.4237040812775, 1111.366521082975, 1129.6294458065693, 1139.7606502634374, 1174.36584244507, 5416.702081385482, 5436.184572314105, 5452.154915988028, 5474.39781624021, 5489.039418101896, 8196.221358970888, 8374.748757537283, 8412.621432035574, 8429.536375499283, 8526.062133165347, 8575.442596231225, 8601.182887625791, 8641.30869530436, 8648.1784230498, 8667.913320866837, 6719.0, 6776.796696099125, 6857.0, 6884.277150899184, 6887.414569761526, 6823.863522729617, 6892.551984121016, 6901.689423975833, 6908.205556361083, 6922.0, 7470.103587569526, 7679.808004799925, 7812.453128280966, 7868.173841746763, 7879.448438609243, 7821.452498325063, 7941.682332706627, 7981.840363192588, 7991.120976692676, 8031.156728543652, 6540.182477190351, 6591.274959754327, 6623.039659249478, 6636.469082473294, 6640.933590664032, 6464.0, 6673.9332606673315, 6683.9331606685255, 6697.2633010367845, 6737.393634572912, 6414.069959855701, 6504.0, 6558.737650494118, 6653.63405012729, 6670.39966403026, 6196.628202307876, 6275.811725648238, 6339.397757213057, 6340.270868850142, 6650.0, 6577.276499585138, 6578.671066446563, 6607.438367738796, 6609.041688954979, 6610.140681711347, 5966.671833049224, 6039.547033972557, 6117.1741814856205, 6158.32258451561, 6168.907466388097, 6234.563580549318, 6241.563090583615, 6254.562180647311, 6259.655718935503, 6260.968695156495], "unit": "score", "name": "mootools.html", "value": 4209.947496238295}, {"lowerIsBetter": false, "replicates": [341.80687911330097, 342.7241070937895, 346.9739769517284, 348.76109864742654, 351.4359453077811, 6205.844853878655, 6236.68816559172, 6350.396712312328, 6402.839929001777, 6411.326810684881, 6138.202033735608, 6224.097505861648, 6271.404216599416, 6277.68611569422, 6292.119103325538, 4766.070616229819, 4819.493953134923, 4824.5657890789735, 4835.540623640749, 4837.201861692816, 4838.153323168449, 4842.709437433748, 4843.58829499493, 4845.297431872376, 4848.030393921213, 4674.813007479696, 4820.301056346828, 4822.734749588772, 4823.300621409893, 4824.951750482503, 4808.807647694106, 4809.038192361507, 4809.086273608021, 4814.518548145193, 4817.542333478314, 4236.872893813191, 4238.215930052919, 4244.575542445731, 4245.426867372896, 4248.745075295492, 6005.429484198994, 6012.188354572164, 6026.608270462406, 6027.246594175728, 6031.396860313977, 5415.9458405415835, 5581.0512212923495, 5587.413321601214, 5588.804391846266, 5598.608097433182, 6689.0, 6697.062411262427, 6699.296573859772, 6703.329667033307, 6705.798826035227, 4597.264437689953, 4599.885002874921, 4602.585767280961, 4609.930851037204, 4617.284320930261, 6691.297413771581, 6874.450043996469, 6944.4444444444325, 6961.129858767654, 6962.547434416747, 4661.300804879295, 4683.672142949961, 4710.717356958594, 4714.528547145258, 4726.1492931272705, 4764.49972752856, 4768.165571025057, 4770.045990801854, 4770.045990801854, 4793.18515852306, 5544.168374743821, 5544.1960915667005, 5550.7779688812, 5552.805651802168, 5571.526420254324, 6534.0, 6707.865842683119, 6739.494537909578, 6743.426808721314, 6748.662566871637, 1630.6331075507917, 1669.4908053043696, 1676.5305714399988, 1683.166832417961, 1685.587031177345, 1105.4914739219887, 1113.8997490225918, 1115.2750712037077, 1127.1715289262386, 1135.744457497073, 6321.652309123042, 6409.262934762562, 6415.390537898892, 6428.260750013715, 6440.54916155874, 6837.213720422215, 6840.008198811144, 6863.004864294649, 6863.588184708933, 6891.27641597635, 6366.840828979312, 6374.553781235269, 6379.330170332141, 6415.967920160463, 6423.100765892778, 3780.773153610792, 3807.809609519513, 3822.675072618803, 3826.215625796705, 3829.5787463379006, 7129.429645628441, 7195.712171513185, 7202.783916482514, 7205.0, 7217.206107328189, 7004.824879378057, 7160.785176444715, 7167.462440316997, 7196.0, 7210.60341681202, 7194.38847697941, 7209.0988626421695, 7212.206657267697, 7221.277872212737, 7239.20368759436, 7018.473614479037, 7026.402755765817, 7041.823954401181, 7042.929570704432, 7043.36609705129, 6730.293319201413, 6898.517103802686, 6925.134358205224, 6940.722371105099, 6945.756898508528, 7181.784546463615, 7188.820279493055, 7211.062561866924, 7218.422526197996, 7219.494635375683, 4682.2040253156365, 4735.218688916428, 4735.313379559876, 4743.383360163157, 4756.143894099096, 6823.863522729418, 6887.586744795329, 6996.685149168401, 7005.404540614105, 7032.964835175791, 6775.085363475868, 6808.421284190701, 6813.693383797642, 6814.693338799865, 6825.146856642919, 6765.627890466071, 6771.356721111487, 6782.118324617768, 6791.117154769849, 6807.183138023469, 6475.805725828232, 6634.270230274569, 6649.2685804562425, 6657.234418041987, 6666.100076489805, 6797.150356205474, 6803.421709154777, 6806.149231346082, 6809.89785153233, 6837.487188460786, 6629.0, 6629.237637671729, 6668.533202675766, 6673.899891501728, 6677.3656502632175], "unit": "score", "name": "prototype.html", "value": 5056.7588778022555}, {"lowerIsBetter": false, "replicates": [805.1666525146472, 817.4155478832636, 848.4230723108284, 857.1171693156048, 888.8933328000641, 12966.546170884021, 13236.404361803707, 13268.867311326883, 13307.268100254481, 13314.933425332873, 11865.822012669816, 11922.165448418615, 11931.463084161212, 11948.820767688492, 11964.581239656614, 650.7299470719657, 663.0551464163548, 799.1169757418028, 812.4150611559668, 816.873384625381, 805.556943680976, 805.7985503624094, 809.951402915827, 811.3630799822141, 814.7922279818638, 837.5770236030796, 841.3899922556159, 842.8314337132567, 846.2510678049908, 847.3898792869124, 830.489249111795, 831.7005877883987, 834.8497270491309, 837.3594200436671, 838.76933843193, 622.2719418280623, 622.498888394842, 623.1276213301369, 623.9001759718469, 626.573929727785, 13310.267935263557, 13314.467421303136, 13359.532416365479, 13477.528286509925, 13492.527761528398, 10904.182186336056, 12201.450934707871, 12357.814632780515, 12543.184692994926, 12681.936590317082, 10612.575496980111, 10633.149348052137, 10669.253152279343, 10922.508487118099, 10940.890591094067, 3636.5272514573203, 3672.1003354178397, 3694.4273637586216, 3785.734998550103, 3794.7723136611617, 43842.0, 43947.78026109849, 44063.77968110139, 44256.0, 44461.55538444639, 9504.667336643184, 9558.713238602853, 9610.327277090537, 9682.322237443452, 9733.707988760349, 17474.388396406066, 17632.55918602045, 17748.0, 17757.0, 17861.017644029704, 7170.139583250043, 7349.70601175947, 7490.625468726542, 7569.621518924032, 7758.534487930742, 4397.890052748643, 4445.2887537993765, 4463.263561512379, 4536.79584418702, 4690.085433340534, 2815.0850973433717, 2855.4146399987953, 2860.785441091885, 2865.068852622906, 2873.1524200360946, 544.6459801129298, 552.9308836395451, 565.4317411001999, 578.6672663218666, 580.3007376111775, 548.9862753431196, 652.644308851677, 672.2101530701407, 697.3026973026973, 723.8914162875611, 8848.705115983405, 8867.645294188289, 8951.641934322553, 9178.724638260863, 9213.216876565433, 521.6843809495276, 651.0917270407755, 656.678227668439, 665.3280187011154, 671.0772687554612, 3850.730448868608, 4187.898089171962, 4209.6000879916355, 4266.807993640294, 4427.712198707074, 53743.0, 54921.0, 56013.71993140008, 58039.0, 58127.41872581305, 49160.26259606109, 49880.501194987584, 50058.99882002339, 53091.46908530865, 53598.46401535935, 48715.05139794439, 49228.50771492311, 49642.50357496451, 50944.490555094715, 51214.23178652323, 9081.68214112503, 9120.361574689709, 9247.676331328372, 9293.907060929305, 9327.113924177193, 34093.0, 34583.82708086444, 34713.479297810045, 34974.0, 34999.4750078744, 39289.60710392974, 42614.78692606641, 42878.35682464703, 42963.570364295956, 43202.567974319856, 10603.41681207541, 10861.891381086089, 10913.56345746193, 11011.403346514871, 11690.357030363071, 11453.312801231952, 11750.941245294061, 11906.583269585522, 12011.219270747373, 12222.830141755781, 10653.0, 10681.0, 10707.785844282915, 10823.134149267882, 11419.714507137389, 10859.891401085888, 10994.505247263733, 11037.834432483358, 11060.723481913017, 11070.501827417947, 10680.732981675521, 10698.62554810578, 10749.785004299714, 11015.83476247841, 11518.596849110241, 9214.677486287948, 9281.72154835356, 9367.250619950524, 9836.21310295189, 10432.321899076536, 9483.620655173992, 9946.900530994597, 9998.600055997678, 10017.599296028076, 10027.54876030595], "unit": "score", "name": "yui.html", "value": 6257.386382624551}], "name": "dromaeo_css", "value": 6957.656050667939}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 112.0, 112.0, 113.0, 124.0, 114.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 145.0, 167.0, 122.0, 155.0, 161.0, 135.0, 171.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 164.0, 160.0, 161.0, 161.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 72.0, 73.0, 72.0, 72.0, 158.0, 71.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 93.0, 94.0, 92.0, 142.0, 93.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 62.0, 61.0, 61.0, 64.0, 63.0, 60.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [68.0, 77.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 91.0, 84.0, 84.0, 86.0, 84.0, 93.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 122.0, 114.0, 139.0, 124.0, 119.0, 116.0, 116.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [142.0, 162.0, 143.0, 142.0, 153.0, 157.0, 152.0, 155.0, 163.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 72.0, 66.0, 68.0, 66.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1517.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.26194017517767], "unit": "score", "name": "Richards", "value": 213.61240199999997}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1057.0824524312895], "unit": "score", "name": "RayTrace", "value": 700.0295939999999}, {"lowerIsBetter": false, "replicates": [701.2622720897616], "unit": "score", "name": "Earley", "value": 950.3762380000003}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [692.2015182884749], "unit": "score", "name": "Splay", "value": 117.72727716849451}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21160.30789052514}]} 20:05:40 INFO - RETURN: dromaeo_css: 6957.66 20:05:40 INFO - RETURN: kraken: 1517.60 20:05:40 INFO - RETURN: v8_7: 21160.31 20:05:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21160.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6957.66"}}} 20:05:40 INFO - Return code: 0 20:05:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:05:40 INFO - # TBPL SUCCESS # 20:05:40 INFO - Running post-action listener: _resource_record_post_action 20:05:40 INFO - Running post-run listener: _resource_record_post_run 20:05:41 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566616064; Read time: 8; Write time: 737312 20:05:41 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245436416; Read time: 0; Write time: 442636 20:05:41 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321110016; Read time: 8; Write time: 294660 20:05:41 INFO - Running post-run listener: _upload_blobber_files 20:05:41 INFO - Blob upload gear active. 20:05:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:05:41 INFO - Copying logs to upload dir... 20:05:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.096633 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-17 20:05:41.410702) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:41.414498) ========= 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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010213 build_url: 'https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:41.467101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:41.467561) ========= 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=a9e534cca236dfa67d42a089000001c1-1450407874.458793-257340636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:41.519618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 20:05:41.520052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 20:05:41.520462) ========= ========= Total master_lag: 0.24 =========