builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1450616493.4 results: success (0) buildid: 20151220023004 builduid: f4a7217aa13340feac5db05f05c9980a revision: a8e74b6b0511c38b87b6414e99eaa40c75c65205 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.395365) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.395791) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.396072) ========= 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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006037 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.486031) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.486414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.551668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.551920) ========= 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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.047342 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.613857) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.614149) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.614552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.614838) ========= 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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-20 05:01:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.8M=0.001s 2015-12-20 05:01:34 (14.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.778492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:33.778851) ========= 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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.324185 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.116341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.116739) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a8e74b6b0511c38b87b6414e99eaa40c75c65205 --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 a8e74b6b0511c38b87b6414e99eaa40c75c65205 --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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-20 05:01:34,456 truncating revision to first 12 chars 2015-12-20 05:01:34,456 Setting DEBUG logging. 2015-12-20 05:01:34,456 attempt 1/10 2015-12-20 05:01:34,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a8e74b6b0511?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-20 05:01:34,686 unpacking tar archive at: fx-team-a8e74b6b0511/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.680250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.680592) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.694186) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.694517) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 05:01:34.694977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-20 05:01:34.695250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:35 INFO - MultiFileLogger online at 20151220 05:01:35 in /builds/slave/test-pgo 05:01:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 05:01:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:01:35 INFO - {'append_to_log': False, 05:01:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:01:35 INFO - 'blob_upload_branch': 'Fx-Team', 05:01:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:01:35 INFO - 'branch': 'Fx-Team', 05:01:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:35 INFO - 'config_files': ('talos/linux_config.py',), 05:01:35 INFO - 'default_actions': ('clobber', 05:01:35 INFO - 'read-buildbot-config', 05:01:35 INFO - 'download-and-extract', 05:01:35 INFO - 'populate-webroot', 05:01:35 INFO - 'create-virtualenv', 05:01:35 INFO - 'install', 05:01:35 INFO - 'run-tests'), 05:01:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:35 INFO - 'download_minidump_stackwalk': True, 05:01:35 INFO - 'download_symbols': 'ondemand', 05:01:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:35 INFO - 'installer_path': 'installer.exe', 05:01:35 INFO - 'log_level': 'info', 05:01:35 INFO - 'log_name': 'talos', 05:01:35 INFO - 'log_to_console': True, 05:01:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:35 INFO - 'opt_config_files': (), 05:01:35 INFO - 'pip_index': False, 05:01:35 INFO - 'sps_profile': False, 05:01:35 INFO - 'sps_profile_interval': 0, 05:01:35 INFO - 'suite': 'dromaeojs', 05:01:35 INFO - 'system_bits': '64', 05:01:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:35 INFO - 'title': 'talos-linux64-ix-044', 05:01:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:35 INFO - 'use_talos_json': True, 05:01:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:01:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:35 INFO - 'work_dir': 'build'} 05:01:35 INFO - ##### 05:01:35 INFO - ##### Running clobber step. 05:01:35 INFO - ##### 05:01:35 INFO - Running pre-action listener: _resource_record_pre_action 05:01:35 INFO - Running main action method: clobber 05:01:35 INFO - rmtree: /builds/slave/test-pgo/build 05:01:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:01:37 INFO - Running post-action listener: _resource_record_post_action 05:01:37 INFO - ##### 05:01:37 INFO - ##### Running read-buildbot-config step. 05:01:37 INFO - ##### 05:01:37 INFO - Running pre-action listener: _resource_record_pre_action 05:01:37 INFO - Running main action method: read_buildbot_config 05:01:37 INFO - Using buildbot properties: 05:01:37 INFO - { 05:01:37 INFO - "project": "", 05:01:37 INFO - "product": "firefox", 05:01:37 INFO - "script_repo_revision": "production", 05:01:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:01:37 INFO - "repository": "", 05:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:01:37 INFO - "buildid": "20151220023004", 05:01:37 INFO - "pgo_build": "True", 05:01:37 INFO - "basedir": "/builds/slave/test-pgo", 05:01:37 INFO - "buildnumber": 377, 05:01:37 INFO - "slavename": "talos-linux64-ix-044", 05:01:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:01:37 INFO - "platform": "ubuntu64_hw", 05:01:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:01:37 INFO - "branch": "fx-team", 05:01:37 INFO - "repo_path": "integration/fx-team", 05:01:37 INFO - "revision": "a8e74b6b0511c38b87b6414e99eaa40c75c65205", 05:01:37 INFO - "stage_platform": "linux64-pgo", 05:01:37 INFO - "builduid": "f4a7217aa13340feac5db05f05c9980a", 05:01:37 INFO - "slavebuilddir": "test" 05:01:37 INFO - } 05:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:01:37 INFO - Running post-action listener: _resource_record_post_action 05:01:37 INFO - ##### 05:01:37 INFO - ##### Running download-and-extract step. 05:01:37 INFO - ##### 05:01:37 INFO - Running pre-action listener: _resource_record_pre_action 05:01:37 INFO - Running main action method: download_and_extract 05:01:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:37 INFO - https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/test_packages.json 05:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/test_packages.json 05:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:01:39 INFO - Downloaded 1302 bytes. 05:01:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:01:39 INFO - Using the following test package requirements: 05:01:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'jsshell-linux-x86_64.zip'], 05:01:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:39 INFO - https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:42 INFO - Downloaded 23120869 bytes. 05:01:42 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 05:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:42 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 05:01:43 INFO - Return code: 0 05:01:43 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 05:01: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')]} 05:01:43 INFO - https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:45 INFO - Downloaded 23120869 bytes. 05:01:45 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 05:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:45 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 05:01:48 INFO - Return code: 0 05:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:48 INFO - https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:49 INFO - Downloaded 11132039 bytes. 05:01:49 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 05:01:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:49 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 05:01:49 INFO - Return code: 0 05:01: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')]} 05:01:49 INFO - https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jK8elaSDTBOtcVGOJIqDJA/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 05:01:50 INFO - Downloaded 54634413 bytes. 05:01:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:50 INFO - mkdir: /builds/slave/test-pgo/properties 05:01:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:01:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:01:50 INFO - Contents: 05:01:50 INFO - build_url:https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:50 INFO - Running post-action listener: _resource_record_post_action 05:01:50 INFO - Running post-action listener: set_extra_try_arguments 05:01:50 INFO - ##### 05:01:50 INFO - ##### Running populate-webroot step. 05:01:50 INFO - ##### 05:01:50 INFO - Running pre-action listener: _resource_record_pre_action 05:01:50 INFO - Running main action method: populate_webroot 05:01:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:50 INFO - '--tppagecycles', 05:01:50 INFO - '7'], 05:01:50 INFO - 'tests': ['tsvgm']}}, 05:01:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:01:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:01:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:01:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'tests': ['damp', 'tps']}, 05:01:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['damp', 'tps']}, 05:01:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:01:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:50 INFO - 'other': {'tests': ['a11yr', 05:01:50 INFO - 'ts_paint', 05:01:50 INFO - 'tpaint', 05:01:50 INFO - 'sessionrestore', 05:01:50 INFO - 'sessionrestore_no_auto_restore']}, 05:01:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['a11yr', 05:01:50 INFO - 'ts_paint', 05:01:50 INFO - 'tpaint', 05:01:50 INFO - 'sessionrestore', 05:01:50 INFO - 'sessionrestore_no_auto_restore']}, 05:01:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['a11yr', 05:01:50 INFO - 'ts_paint', 05:01:50 INFO - 'tpaint', 05:01:50 INFO - 'sessionrestore', 05:01:50 INFO - 'sessionrestore_no_auto_restore']}, 05:01:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['a11yr', 05:01:50 INFO - 'ts_paint', 05:01:50 INFO - 'tpaint', 05:01:50 INFO - 'sessionrestore', 05:01:50 INFO - 'sessionrestore_no_auto_restore']}, 05:01:50 INFO - 'other_l64': {'tests': ['a11yr', 05:01:50 INFO - 'ts_paint', 05:01:50 INFO - 'tpaint', 05:01:50 INFO - 'sessionrestore', 05:01:50 INFO - 'sessionrestore_no_auto_restore']}, 05:01:50 INFO - 'other_nol64': {'tests': ['a11yr', 05:01:50 INFO - 'ts_paint', 05:01:50 INFO - 'tpaint', 05:01:50 INFO - 'sessionrestore', 05:01:50 INFO - 'sessionrestore_no_auto_restore']}, 05:01:50 INFO - 'svgr': {'tests': ['tsvgx', 05:01:50 INFO - 'tsvgr_opacity', 05:01:50 INFO - 'tart', 05:01:50 INFO - 'tscrollx', 05:01:50 INFO - 'cart']}, 05:01:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['tsvgx', 05:01:50 INFO - 'tsvgr_opacity', 05:01:50 INFO - 'tart', 05:01:50 INFO - 'tscrollx', 05:01:50 INFO - 'cart']}, 05:01:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'tests': ['tp5o']}, 05:01:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'talos_options': ['--e10s'], 05:01:50 INFO - 'tests': ['tp5o']}, 05:01:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'talos_options': ['--xperf_path', 05:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:50 INFO - 'tests': ['tp5n']}, 05:01:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:50 INFO - 'talos_options': ['--e10s', 05:01:50 INFO - '--xperf_path', 05:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:50 INFO - 'tests': ['tp5n']}}, 05:01:50 INFO - 'talos.zip': {'path': '', 05:01:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:50 INFO - Running post-action listener: _resource_record_post_action 05:01:50 INFO - ##### 05:01:50 INFO - ##### Running create-virtualenv step. 05:01:50 INFO - ##### 05:01:50 INFO - Running pre-action listener: _resource_record_pre_action 05:01:50 INFO - Running main action method: create_virtualenv 05:01:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:01: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 05:01:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:01:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:50 INFO - Using real prefix '/usr' 05:01:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:01:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:54 INFO - Installing pip.................done. 05:01:54 INFO - Return code: 0 05:01:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:54 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:01:54 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 05:01:54 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 05:01:54 INFO - Using env: {'DISPLAY': ':0', 05:01:54 INFO - 'HOME': '/home/cltbld', 05:01:54 INFO - 'LANG': 'en_US.UTF-8', 05:01:54 INFO - 'LANGUAGE': 'en_US:en', 05:01:54 INFO - 'LOGNAME': 'cltbld', 05:01:54 INFO - 'MAIL': '/var/mail/cltbld', 05:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:54 INFO - 'MOZ_NO_REMOTE': '1', 05:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:54 INFO - 'NO_EM_RESTART': '1', 05:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:54 INFO - 'SHELL': '/bin/bash', 05:01:54 INFO - 'SHLVL': '1', 05:01:54 INFO - 'TERM': 'linux', 05:01:54 INFO - 'TMOUT': '86400', 05:01:54 INFO - 'USER': 'cltbld', 05:01:54 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:54 INFO - '_': '/tools/buildbot/bin/python'} 05:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:56 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 05:01:56 INFO - Cleaning up... 05:01:56 INFO - Return code: 0 05:01:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:01:56 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 05:01:56 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 05:01:56 INFO - Using env: {'DISPLAY': ':0', 05:01:56 INFO - 'HOME': '/home/cltbld', 05:01:56 INFO - 'LANG': 'en_US.UTF-8', 05:01:56 INFO - 'LANGUAGE': 'en_US:en', 05:01:56 INFO - 'LOGNAME': 'cltbld', 05:01:56 INFO - 'MAIL': '/var/mail/cltbld', 05:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:56 INFO - 'MOZ_NO_REMOTE': '1', 05:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:56 INFO - 'NO_EM_RESTART': '1', 05:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:56 INFO - 'SHELL': '/bin/bash', 05:01:56 INFO - 'SHLVL': '1', 05:01:56 INFO - 'TERM': 'linux', 05:01:56 INFO - 'TMOUT': '86400', 05:01:56 INFO - 'USER': 'cltbld', 05:01:56 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:56 INFO - '_': '/tools/buildbot/bin/python'} 05:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:56 INFO - Downloading/unpacking psutil>=0.7.1 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:58 INFO - Installing collected packages: psutil 05:01:58 INFO - Running setup.py install for psutil 05:01:58 INFO - building 'psutil._psutil_linux' extension 05:01:58 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 05:01:59 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 05:01:59 INFO - building 'psutil._psutil_posix' extension 05:01:59 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 05:01:59 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 05:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:01 INFO - Successfully installed psutil 05:02:01 INFO - Cleaning up... 05:02:01 INFO - Return code: 0 05:02:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:02: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')]} 05:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:01 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 05:02:01 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 05:02:01 INFO - Using env: {'DISPLAY': ':0', 05:02:01 INFO - 'HOME': '/home/cltbld', 05:02:01 INFO - 'LANG': 'en_US.UTF-8', 05:02:01 INFO - 'LANGUAGE': 'en_US:en', 05:02:01 INFO - 'LOGNAME': 'cltbld', 05:02:01 INFO - 'MAIL': '/var/mail/cltbld', 05:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:01 INFO - 'MOZ_NO_REMOTE': '1', 05:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:01 INFO - 'NO_EM_RESTART': '1', 05:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:01 INFO - 'SHELL': '/bin/bash', 05:02:01 INFO - 'SHLVL': '1', 05:02:01 INFO - 'TERM': 'linux', 05:02:01 INFO - 'TMOUT': '86400', 05:02:01 INFO - 'USER': 'cltbld', 05:02:01 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:01 INFO - '_': '/tools/buildbot/bin/python'} 05:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:02:03 INFO - Installing collected packages: mozsystemmonitor 05:02:03 INFO - Running setup.py install for mozsystemmonitor 05:02:03 INFO - Successfully installed mozsystemmonitor 05:02:03 INFO - Cleaning up... 05:02:03 INFO - Return code: 0 05:02:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:03 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:03 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 05:02:03 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 05:02:03 INFO - Using env: {'DISPLAY': ':0', 05:02:03 INFO - 'HOME': '/home/cltbld', 05:02:03 INFO - 'LANG': 'en_US.UTF-8', 05:02:03 INFO - 'LANGUAGE': 'en_US:en', 05:02:03 INFO - 'LOGNAME': 'cltbld', 05:02:03 INFO - 'MAIL': '/var/mail/cltbld', 05:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:03 INFO - 'MOZ_NO_REMOTE': '1', 05:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:03 INFO - 'NO_EM_RESTART': '1', 05:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:03 INFO - 'SHELL': '/bin/bash', 05:02:03 INFO - 'SHLVL': '1', 05:02:03 INFO - 'TERM': 'linux', 05:02:03 INFO - 'TMOUT': '86400', 05:02:03 INFO - 'USER': 'cltbld', 05:02:03 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:03 INFO - '_': '/tools/buildbot/bin/python'} 05:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:03 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 05:02:03 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 05:02:03 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 05:02:03 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 05:02:03 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 05:02:03 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 05:02:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:02:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:05 INFO - Downloading docopt-0.6.1.tar.gz 05:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:06 INFO - Running setup.py install for blobuploader 05:02:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:02:06 INFO - Running setup.py install for requests 05:02:06 INFO - Running setup.py install for docopt 05:02:06 INFO - Successfully installed blobuploader requests docopt 05:02:06 INFO - Cleaning up... 05:02:06 INFO - Return code: 0 05:02:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:06 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:06 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 05:02:06 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 05:02:06 INFO - Using env: {'DISPLAY': ':0', 05:02:06 INFO - 'HOME': '/home/cltbld', 05:02:06 INFO - 'LANG': 'en_US.UTF-8', 05:02:06 INFO - 'LANGUAGE': 'en_US:en', 05:02:06 INFO - 'LOGNAME': 'cltbld', 05:02:06 INFO - 'MAIL': '/var/mail/cltbld', 05:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:06 INFO - 'MOZ_NO_REMOTE': '1', 05:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:06 INFO - 'NO_EM_RESTART': '1', 05:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:06 INFO - 'SHELL': '/bin/bash', 05:02:06 INFO - 'SHLVL': '1', 05:02:06 INFO - 'TERM': 'linux', 05:02:06 INFO - 'TMOUT': '86400', 05:02:06 INFO - 'USER': 'cltbld', 05:02:06 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:06 INFO - '_': '/tools/buildbot/bin/python'} 05:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:06 INFO - Running setup.py (path:/tmp/pip-J7Es_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:06 INFO - Running setup.py (path:/tmp/pip-ux_Mo4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:06 INFO - Running setup.py (path:/tmp/pip-3Ii_Iz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:07 INFO - Running setup.py (path:/tmp/pip-ruETB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:07 INFO - Running setup.py (path:/tmp/pip-eXOxOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:07 INFO - Running setup.py (path:/tmp/pip-3ArGhU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:07 INFO - Running setup.py (path:/tmp/pip-BbbYrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:07 INFO - Running setup.py (path:/tmp/pip-Pivs5D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:07 INFO - Running setup.py (path:/tmp/pip-ChtMBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:07 INFO - Running setup.py (path:/tmp/pip-eBvxjk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:07 INFO - Running setup.py (path:/tmp/pip-NyuuTO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:07 INFO - Running setup.py (path:/tmp/pip-385tEo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:07 INFO - Running setup.py (path:/tmp/pip-cbzCk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:07 INFO - Running setup.py (path:/tmp/pip-yTAqz0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:07 INFO - Running setup.py (path:/tmp/pip-JIsPOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:07 INFO - Running setup.py (path:/tmp/pip-9kYy1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:07 INFO - Running setup.py (path:/tmp/pip-gVjsMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:08 INFO - Running setup.py install for manifestparser 05:02:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Running setup.py install for mozcrash 05:02:08 INFO - Running setup.py install for mozdebug 05:02:08 INFO - Running setup.py install for mozdevice 05:02:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Running setup.py install for mozfile 05:02:08 INFO - Running setup.py install for mozhttpd 05:02:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Running setup.py install for mozinfo 05:02:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Running setup.py install for mozInstall 05:02:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:02:08 INFO - Running setup.py install for mozleak 05:02:08 INFO - Running setup.py install for mozlog 05:02:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Running setup.py install for moznetwork 05:02:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Running setup.py install for mozprocess 05:02:09 INFO - Running setup.py install for mozprofile 05:02:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Running setup.py install for mozrunner 05:02:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Running setup.py install for mozscreenshot 05:02:09 INFO - Running setup.py install for moztest 05:02:09 INFO - Running setup.py install for mozversion 05:02:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:02:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:09 INFO - Cleaning up... 05:02:09 INFO - Return code: 0 05:02:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:09 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:09 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 05:02:09 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 05:02:09 INFO - Using env: {'DISPLAY': ':0', 05:02:09 INFO - 'HOME': '/home/cltbld', 05:02:09 INFO - 'LANG': 'en_US.UTF-8', 05:02:09 INFO - 'LANGUAGE': 'en_US:en', 05:02:09 INFO - 'LOGNAME': 'cltbld', 05:02:09 INFO - 'MAIL': '/var/mail/cltbld', 05:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:09 INFO - 'MOZ_NO_REMOTE': '1', 05:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:09 INFO - 'NO_EM_RESTART': '1', 05:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:09 INFO - 'SHELL': '/bin/bash', 05:02:09 INFO - 'SHLVL': '1', 05:02:09 INFO - 'TERM': 'linux', 05:02:09 INFO - 'TMOUT': '86400', 05:02:09 INFO - 'USER': 'cltbld', 05:02:09 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:09 INFO - '_': '/tools/buildbot/bin/python'} 05:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:10 INFO - Running setup.py (path:/tmp/pip-4AklKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:10 INFO - Running setup.py (path:/tmp/pip-XuJ6qr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:10 INFO - Running setup.py (path:/tmp/pip-ItzIv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:10 INFO - Running setup.py (path:/tmp/pip-reab1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:10 INFO - Running setup.py (path:/tmp/pip-sjOaoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:10 INFO - Running setup.py (path:/tmp/pip-3TW4Bq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:10 INFO - Running setup.py (path:/tmp/pip-GfYIM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:10 INFO - Running setup.py (path:/tmp/pip-LLbZIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:10 INFO - Running setup.py (path:/tmp/pip-OiyV8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:10 INFO - Running setup.py (path:/tmp/pip-j2j8H3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:10 INFO - Running setup.py (path:/tmp/pip-5dzuw7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:10 INFO - Running setup.py (path:/tmp/pip-B_4c65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:10 INFO - Running setup.py (path:/tmp/pip-waBWuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:10 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)) 05:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:10 INFO - Running setup.py (path:/tmp/pip-gV2yej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:11 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)) 05:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:11 INFO - Running setup.py (path:/tmp/pip-6nZUXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:11 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)) 05:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:11 INFO - Running setup.py (path:/tmp/pip-_yZ8yj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:11 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)) 05:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:11 INFO - Running setup.py (path:/tmp/pip-aLU_ZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:11 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)) 05:02:11 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)) 05:02:11 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)) 05:02:11 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)) 05:02:11 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)) 05:02:11 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)) 05:02:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:11 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 05:02:11 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 05:02:11 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 05:02:11 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 05:02:11 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 05:02:11 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 05:02:12 INFO - Downloading blessings-1.5.1.tar.gz 05:02:12 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 05:02:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:13 INFO - Installing collected packages: blessings 05:02:13 INFO - Running setup.py install for blessings 05:02:13 INFO - Successfully installed blessings 05:02:13 INFO - Cleaning up... 05:02:13 INFO - Return code: 0 05:02:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:02:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:02:13 INFO - Reading from file tmpfile_stdout 05:02:13 INFO - Current package versions: 05:02:13 INFO - argparse == 1.2.1 05:02:13 INFO - blessings == 1.5.1 05:02:13 INFO - blobuploader == 1.2.4 05:02:13 INFO - docopt == 0.6.1 05:02:13 INFO - manifestparser == 1.1 05:02:13 INFO - mozInstall == 1.12 05:02:13 INFO - mozcrash == 0.16 05:02:13 INFO - mozdebug == 0.1 05:02:13 INFO - mozdevice == 0.47 05:02:13 INFO - mozfile == 1.2 05:02:13 INFO - mozhttpd == 0.7 05:02:13 INFO - mozinfo == 0.9 05:02:13 INFO - mozleak == 0.1 05:02:13 INFO - mozlog == 3.1 05:02:13 INFO - moznetwork == 0.27 05:02:13 INFO - mozprocess == 0.22 05:02:13 INFO - mozprofile == 0.27 05:02:13 INFO - mozrunner == 6.11 05:02:13 INFO - mozscreenshot == 0.1 05:02:13 INFO - mozsystemmonitor == 0.0 05:02:13 INFO - moztest == 0.7 05:02:13 INFO - mozversion == 1.4 05:02:13 INFO - psutil == 3.1.1 05:02:13 INFO - requests == 1.2.3 05:02:13 INFO - wsgiref == 0.1.2 05:02:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:13 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 05:02:13 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 05:02:13 INFO - Using env: {'DISPLAY': ':0', 05:02:13 INFO - 'HOME': '/home/cltbld', 05:02:13 INFO - 'LANG': 'en_US.UTF-8', 05:02:13 INFO - 'LANGUAGE': 'en_US:en', 05:02:13 INFO - 'LOGNAME': 'cltbld', 05:02:13 INFO - 'MAIL': '/var/mail/cltbld', 05:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:13 INFO - 'MOZ_NO_REMOTE': '1', 05:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:13 INFO - 'NO_EM_RESTART': '1', 05:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:13 INFO - 'SHELL': '/bin/bash', 05:02:13 INFO - 'SHLVL': '1', 05:02:13 INFO - 'TERM': 'linux', 05:02:13 INFO - 'TMOUT': '86400', 05:02:13 INFO - 'USER': 'cltbld', 05:02:13 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:13 INFO - '_': '/tools/buildbot/bin/python'} 05:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 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)) 05:02:13 INFO - Cleaning up... 05:02:13 INFO - Return code: 0 05:02:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:13 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 05:02:13 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 05:02:13 INFO - Using env: {'DISPLAY': ':0', 05:02:13 INFO - 'HOME': '/home/cltbld', 05:02:13 INFO - 'LANG': 'en_US.UTF-8', 05:02:13 INFO - 'LANGUAGE': 'en_US:en', 05:02:13 INFO - 'LOGNAME': 'cltbld', 05:02:13 INFO - 'MAIL': '/var/mail/cltbld', 05:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:13 INFO - 'MOZ_NO_REMOTE': '1', 05:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:13 INFO - 'NO_EM_RESTART': '1', 05:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:13 INFO - 'SHELL': '/bin/bash', 05:02:13 INFO - 'SHLVL': '1', 05:02:13 INFO - 'TERM': 'linux', 05:02:13 INFO - 'TMOUT': '86400', 05:02:13 INFO - 'USER': 'cltbld', 05:02:13 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:13 INFO - '_': '/tools/buildbot/bin/python'} 05:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:13 INFO - Downloading/unpacking jsonschema 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:15 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 05:02:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:02:15 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 05:02:15 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 05:02:15 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 05:02:15 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 05:02:15 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 05:02:15 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 05:02:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:02:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:15 INFO - warning: no files found matching '*.txt' 05:02:15 INFO - no previously-included directories found matching 'build' 05:02:15 INFO - no previously-included directories found matching 'dist' 05:02:15 INFO - no previously-included directories found matching '.git*' 05:02:15 INFO - Installing collected packages: jsonschema, functools32 05:02:15 INFO - Running setup.py install for functools32 05:02:15 INFO - warning: no files found matching '*.txt' 05:02:15 INFO - no previously-included directories found matching 'build' 05:02:15 INFO - no previously-included directories found matching 'dist' 05:02:15 INFO - no previously-included directories found matching '.git*' 05:02:16 INFO - Successfully installed jsonschema functools32 05:02:16 INFO - Cleaning up... 05:02:16 INFO - Return code: 0 05:02:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:16 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 0x7eff96164f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, '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': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', '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 05:02:16 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 05:02:16 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 05:02:16 INFO - Using env: {'DISPLAY': ':0', 05:02:16 INFO - 'HOME': '/home/cltbld', 05:02:16 INFO - 'LANG': 'en_US.UTF-8', 05:02:16 INFO - 'LANGUAGE': 'en_US:en', 05:02:16 INFO - 'LOGNAME': 'cltbld', 05:02:16 INFO - 'MAIL': '/var/mail/cltbld', 05:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:16 INFO - 'MOZ_NO_REMOTE': '1', 05:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:16 INFO - 'NO_EM_RESTART': '1', 05:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:16 INFO - 'SHELL': '/bin/bash', 05:02:16 INFO - 'SHLVL': '1', 05:02:16 INFO - 'TERM': 'linux', 05:02:16 INFO - 'TMOUT': '86400', 05:02:16 INFO - 'USER': 'cltbld', 05:02:16 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:16 INFO - '_': '/tools/buildbot/bin/python'} 05:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:16 INFO - Downloading/unpacking flake8 05:02:16 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 05:02:16 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 05:02:16 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 05:02:16 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 05:02:16 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 05:02:16 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 05:02:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:02:17 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 05:02:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:02:17 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 05:02:17 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 05:02:17 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 05:02:17 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 05:02:17 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 05:02:17 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 05:02:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:02:18 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 05:02:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 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 05:02:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:02:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:18 INFO - no previously-included directories found matching 'docs/_build' 05:02:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:02:18 INFO - Running setup.py install for pep8 05:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:18 INFO - no previously-included directories found matching 'docs/_build' 05:02:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:02:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:02:18 INFO - Cleaning up... 05:02:18 INFO - Return code: 0 05:02:18 INFO - Running post-action listener: _resource_record_post_action 05:02:18 INFO - Running post-action listener: _start_resource_monitoring 05:02:18 INFO - Starting resource monitoring. 05:02:18 INFO - ##### 05:02:18 INFO - ##### Running install step. 05:02:18 INFO - ##### 05:02:18 INFO - Running pre-action listener: _resource_record_pre_action 05:02:18 INFO - Running main action method: install 05:02:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:02:19 INFO - Reading from file tmpfile_stdout 05:02:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:02:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:02:19 INFO - Reading from file tmpfile_stdout 05:02:19 INFO - Output received: 05:02:19 INFO - Usage: mozinstall [options] installer 05:02:19 INFO - Options: 05:02:19 INFO - -h, --help show this help message and exit 05:02:19 INFO - -d DEST, --destination=DEST 05:02:19 INFO - Directory to install application into. [default: 05:02:19 INFO - "/builds/slave/test-pgo"] 05:02:19 INFO - --app=APP Application being installed. [default: firefox] 05:02:19 INFO - mkdir: /builds/slave/test-pgo/build/application 05:02:19 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'] 05:02:19 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 05:02:34 INFO - Reading from file tmpfile_stdout 05:02:34 INFO - Output received: 05:02:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:02:34 INFO - Running post-action listener: _resource_record_post_action 05:02:34 INFO - ##### 05:02:34 INFO - ##### Running run-tests step. 05:02:34 INFO - ##### 05:02:34 INFO - Running pre-action listener: _resource_record_pre_action 05:02:34 INFO - Running main action method: run_tests 05:02:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:02:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:02:34 INFO - Python 2.7.3 05:02:34 INFO - Return code: 0 05:02:34 INFO - grabbing minidump binary from tooltool 05:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:34 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 0x14ca350>, '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 0x14cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:02:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:02:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:02:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:35 INFO - Return code: 0 05:02:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:02:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:02:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:02:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:02:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:02:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:02:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:02:36 INFO - Return code: 0 05:02:36 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:02:36 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 05:02:36 INFO - Using env: {'DISPLAY': ':0', 05:02:36 INFO - 'HOME': '/home/cltbld', 05:02:36 INFO - 'LANG': 'en_US.UTF-8', 05:02:36 INFO - 'LANGUAGE': 'en_US:en', 05:02:36 INFO - 'LOGNAME': 'cltbld', 05:02:36 INFO - 'MAIL': '/var/mail/cltbld', 05:02:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:02:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:36 INFO - 'MOZ_NO_REMOTE': '1', 05:02:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:36 INFO - 'NO_EM_RESTART': '1', 05:02:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:02:36 INFO - 'SHELL': '/bin/bash', 05:02:36 INFO - 'SHLVL': '1', 05:02:36 INFO - 'TERM': 'linux', 05:02:36 INFO - 'TMOUT': '86400', 05:02:36 INFO - 'USER': 'cltbld', 05:02:36 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778', 05:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:36 INFO - '_': '/tools/buildbot/bin/python'} 05:02:36 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 05:02:36 INFO - mozversion INFO | application_buildid: 20151220023004 05:02:36 INFO - mozversion INFO | application_changeset: a8e74b6b0511c38b87b6414e99eaa40c75c65205 05:02:36 INFO - mozversion INFO | application_display_name: Nightly 05:02:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:36 INFO - mozversion INFO | application_name: Firefox 05:02:36 INFO - mozversion INFO | application_remotingname: firefox 05:02:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:02:36 INFO - mozversion INFO | application_vendor: Mozilla 05:02:36 INFO - mozversion INFO | application_version: 46.0a1 05:02:36 INFO - mozversion INFO | platform_buildid: 20151220023004 05:02:36 INFO - mozversion INFO | platform_changeset: a8e74b6b0511c38b87b6414e99eaa40c75c65205 05:02:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:02:36 INFO - mozversion INFO | platform_version: 46.0a1 05:02:36 INFO - 2015-12-20 05:02:36,929 DEBUG : using testdate: 1450616556 05:02:36 INFO - 2015-12-20 05:02:36,929 DEBUG : actual date: 1450616556 05:02:36 INFO - 2015-12-20 05:02:36,937 INFO : starting webserver on 'localhost:34247' 05:02:36 INFO - 2015-12-20 05:02:36,938 INFO : Starting test suite talos-linux64-ix-044 05:02:36 INFO - 2015-12-20 05:02:36,938 INFO : Starting test dromaeo_css 05:02:36 INFO - 2015-12-20 05:02:36,938 DEBUG : operating with platform_type : linux_ 05:02:36 INFO - 2015-12-20 05:02:36,938 INFO : Initialising browser for dromaeo_css test... 05:02:36 INFO - 2015-12-20 05:02:36,994 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptJ2Vfj/profile http://localhost:34247/getInfo.html 05:02:44 INFO - 2015-12-20 05:02:44,293 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:02:44 INFO - 2015-12-20 05:02:44,309 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:02:44 INFO - 2015-12-20 05:02:44,310 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:02:44 INFO - 2015-12-20 05:02:44,310 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:02:44 INFO - 2015-12-20 05:02:44,310 DEBUG : BROWSER_OUTPUT: __metrics 05:02:44 INFO - 2015-12-20 05:02:44,467 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] 05:02:44 INFO - 2015-12-20 05:02:44,672 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:44 ERROR - 2015-12-20 05:02:44,680 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:02:45 INFO - 2015-12-20 05:02:45,664 INFO : Browser initialized. 05:02:45 INFO - 2015-12-20 05:02:45,664 INFO : Running cycle 1/1 for dromaeo_css test... 05:02:45 INFO - 2015-12-20 05:02:45,665 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptJ2Vfj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:02:57 INFO - 2015-12-20 05:02:57,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 149671936 05:02:57 INFO - 2015-12-20 05:02:57,430 DEBUG : BROWSER_OUTPUT: 05:03:49 INFO - 2015-12-20 05:03:49,109 DEBUG : BROWSER_OUTPUT: 1450616629104 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:05:58 INFO - 2015-12-20 05:05:58,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34247/tests/dromaeo/cssquery-ext.html) 05:05:59 INFO - 2015-12-20 05:05:59,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 284098560 05:05:59 INFO - 2015-12-20 05:05:59,622 DEBUG : BROWSER_OUTPUT: 05:09:02 INFO - 2015-12-20 05:09:02,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/dromaeo/cssquery-ext.html (next: http://localhost:34247/tests/dromaeo/cssquery-jquery.html) 05:09:02 INFO - 2015-12-20 05:09:02,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 232321024 05:09:02 INFO - 2015-12-20 05:09:02,616 DEBUG : BROWSER_OUTPUT: 05:12:04 INFO - 2015-12-20 05:12:04,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34247/tests/dromaeo/cssquery-mootools.html) 05:12:05 INFO - 2015-12-20 05:12:05,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 231186432 05:12:05 INFO - 2015-12-20 05:12:05,014 DEBUG : BROWSER_OUTPUT: 05:15:06 INFO - 2015-12-20 05:15:06,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34247/tests/dromaeo/cssquery-prototype.html) 05:15:07 INFO - 2015-12-20 05:15:07,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 211378176 05:15:07 INFO - 2015-12-20 05:15:07,439 DEBUG : BROWSER_OUTPUT: 05:18:09 INFO - 2015-12-20 05:18:09,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34247/tests/dromaeo/cssquery-yui.html) 05:18:10 INFO - 2015-12-20 05:18:10,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 215797760 05:18:10 INFO - 2015-12-20 05:18:10,503 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/dromaeo/cssquery-yui.html (next: http://localhost:34247/tests/dromaeo/cssquery-dojo.html) 05:21:13 INFO - 2015-12-20 05:21:13,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 235171840 05:21:13 INFO - 2015-12-20 05:21:13,322 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,322 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:21:13 INFO - 2015-12-20 05:21:13,322 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:21:13 INFO - 2015-12-20 05:21:13,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:21:13 INFO - 2015-12-20 05:21:13,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:21:13 INFO - 2015-12-20 05:21:13,324 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3164.4620414529536;3206.9518957215632;3258.9837050814726;3261.6575259597744;3278.3443311337737;5326.280952071469;5422.078246698061;5455.481729235721;5520.089185284428;5521.558275337973;5417.59368047396;5485.149801780721;5495.505404513593;5597.076482380402;5600.6079574429705;4998.450170481253;5017.724025178632;5039.798408063673;5054.064997975368;5112.335396398463;5084.084864724348;5092.236164575306;5152.510511501401;5162.457941916101;5164.896702065957;4879.341288925985;4937.506249375069;4990.87522811929;5040.596752259847;5049.091163590552;5004.624653151028;5026.949730502684;5030.170021946375;5045.722485263309;5067.746612669352;4972.428170760337;4986.87532811679;5005.624578156617;5023.070731914608;5059.924101138486;5278.788848446057;5372.113601255788;5378.354597448292;5382.0312343778105;5403.972980135074;5908.261467316585;5920.733566989453;5943.791967281124;6041.365656606037;6041.939580604226;6069.271687397496;6093.69531523422;6097.359777223416;6100.847478813021;6101.603395779304;5604.495595396393;5622.409646987089;5633.126865335879;5642.548596112301;5674.829755107312;5876.382979787147;6011.428914253139;6015.248093988252;6016.639001659914;6023.307319658208;5924.822255332347;5930.406959304035;5943.10853371989;5967.6121052131475;5976.252968378953;5998.280206375263;6017.247844019497;6017.638941663514;6030.30651475086;6031.9396806032255;5846.181534585162;5922.940770592325;5963.747613001318;5965.3139888912465;5979.431953964367;5939.821805345847;5941.524678025748;5947.732352044169;5966.970165149233;6001.279846418458;4469.597736203757;4484.035932274576;4488.842890498817;4490.842820501267;4520.141173177086;3933.193695292458;4012.9598704012587;4022.3162062449455;4052.8378864845668;4096.221717873595;5561.833145005657;5578;5615.129654903497;5623.690697011703;5674.489295963301;5973.01445261527;5997.100434934708;6025.427584379477;6033.7586496540525;6047.9395206047375;5411.540019098342;5463;5537;5657.745401456944;5673;5124.256982737556;5169.689818610896;5262.815801446931;5276.314079169683;5291.470852914677;6126;6137.7851775187655;6139.785107521216;6145.539084568675;6147.692615369214;5995.820125396245;6002.429769171922;6009.849753756191;6019.849503762441;6054.394560544087;5939.46544810969;6043.969780151071;6094.537231721354;6129.632222066691;6135.53983451234;5928.288605367384;5947.256592925884;5957.434043765836;5969.850753731192;5977.372375900468;6049.122877182872;6051.334353221054;6066;6066.059760737093;6070.119832624333;5640.576956728344;5761.366249712612;5836.591438599427;5846.766129354948;5972.104184372379;5819.127130930225;5842.620229685057;5862.618929769551;5892.204552385373;5902.734376952962;5707.543396528351;5715.685637289989;5717.456841600041;5722.055860782924;5730.140478928028;5612.747426365741;5672.404397538199;5730.398308177581;5824.097264923944;5838.503727183237;5776.075827867521;5801.680907550125;5816.70916454184;5817.9127313091185;5832.912506312494 05:21:13 INFO - 2015-12-20 05:21:13,325 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.0967358694946;603.1706403694919;609.8383928259009;611.3763960760025;633.5660072850098;30321.393572128545;31119.688803111963;37993.62006379935;38131.618683813154;38187.61812381882;41682.166356672846;41970.58029419705;42121.57878421215;42169.15661686764;42187.15625687484;7558.35753960914;8605.182507661762;8764.649414023432;8767.912320876805;8778.253848422892;7711.11322197946;7807.219278072204;10095.545700443497;10166.542505587266;10303.27877048607;9983.600655973753;10083.243756718239;10110.342827716211;10122.29143959923;10142.898571014306;7647.311741943252;7882.921170788276;10021.398716077023;10045.598176072948;10101.141402980755;10344.793104137874;10572.78854422915;10581.788364232672;10587.205959553065;10592.15262778976;38919.22161556781;39315;39315.21369572621;39324.803375983225;39340;3113.6263648362115;3189.569408129896;3262.000926308658;3403.3193361327835;3677.4415371506275;30330.84834575835;30487.390252195055;30876.382472350426;30930.381392372026;31286.21784455384;3748.737588368815;3827.1771569112775;3834.6357096075826;3936.055346716796;4012.4382586437923;268123;268275;268790;269438;270136;53131;54116.458835411926;58405.70797145987;62768.686156568925;65932.01101983474;57973.42026579765;58401.123983140285;58722.70638646779;59045.40954590485;59115.70442147762;14843.183624900734;15046.54860354191;15047.322870470854;15058.774118388234;15066.849331506764;10463.267571270091;10722.839157412645;11415.828762568568;11618.6514404568;11619.419029048513;19653.60692786136;19811.900940495205;19895.403137905887;19923.60152796936;20013.699794503093;7402.481826272109;7595.734149304748;7620.5808680522;7653.3494652954005;7672.65473053714;931.6459745296744;935.102301790289;935.8596210568469;948.8244674735196;1070.0797314309686;25390.873045635024;25413.237602871945;25673.229803105936;26325.473490530083;27336.179914602595;1015.2487159502062;1044.7962647283707;1062.0600768319937;1072.6674730833467;1139.783441146196;13495.97948666894;13760.587182384545;13855.23796191199;14013.859861401459;15327.846721532642;327065;327494;328620;331210;332170;52779;53035.46964530383;53390;53394.733026335394;53399.46600533945;1309.6267563744477;1352.3373546961918;1368.609946165338;1370.2532119994628;1373.6291201375573;29097;29586;29682.851585741933;30014.24964375908;30178.69821301759;46257.30614040725;46599;46618.300725489826;46649.53350466452;46711.06577868492;365804;375937;397316;408962;409578;30489;30521;30619.693803062575;30705.846470767505;30799.384012320075;42323.7883810579;42549.36175957301;42923;43331.566684332756;43950;35620;36366.09084772796;36655.81672091623;36709.81645091758;36939.81530092332;32184;32661.510077348383;33003;33033.17417064593;33288.50067248945;31933.84033079913;32067.839660801546;32251.838740806146;32320.83839580787;32806.67193328036;30787.53818692766;31220.53169202509;31929.8403507981;31957.520637189995;31980.52029219517;24436.755632443448;25083.372915676526;25344.493110138064;25380.619290710285;25793.484130317665 05:21:13 INFO - 2015-12-20 05:21:13,327 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.9427291633339;359.9622039685835;361.3712140874878;363.34235034587397;364.305997075571;13991.30043497826;14416.35126419311;16668.416605418814;16913.66172676546;17518.12409379529;14380.280985950712;14593.854061459382;16693.582660433494;16965.660686786257;17153.228104735284;5392.757325920324;5531;5533.335999680044;5533.612647114704;5534.972325138368;4047;4179.101493178966;4682.8126874924965;5938.910916336258;6037.637741735488;5895.734691938852;6028.517718582503;6089;6089.208402907616;6097.5426842986735;5093.821716239951;5235.319408476912;5283.1546952487415;6046.3372572542685;6056.21269235001;5016.949830501721;5049.040682270357;5063.670861393997;5066.949330506722;5078.974605126988;12753.489860405572;13013.674658133528;13022.739545209042;13042.413091410814;18576.907115464335;2075.8858262795693;2096.4758810297426;2101.054525463532;2102.5374417628095;2292.701948746669;8992.910070899337;9040.728778136601;9070.410423322528;9203.171714545722;9407.388519746262;1802.2396572074797;1904.1526520698294;1974.6149500847341;2011.6580181369202;2135.3807395855183;68258.65870670664;73723.26276737271;75250.62374688091;76551;77620;15645.843541564438;15662;15775.842241577437;15835.208239587975;16111.436099736453;24641.63037554438;24649.383765405648;24853;24858.5028299433;24988.12541561073;8843.778905527413;8917.55412229386;8982.505962172143;8998.055204203596;9036.322275829207;7513.39892808574;7581.848363032708;7585.810354741066;7586.127595326608;7666.846663066707;7907.367410607138;7916.366690664733;7929.1277959424415;7978.760637180894;8095.757127286191;1837.7059670452663;1846.7045272756295;2216.1135545781494;2960.312621805593;3035.119815253596;427.2373812744237;963.8795150606175;1044.6054517219445;1053.2364036073939;1076.3972175581544;10387.68836934893;10425.061744443037;10544.841827372595;10809.67570972872;10862.45687715611;880.4321212817697;904.371461834019;919.2737737187547;925.0656836595087;1006.7684432580547;8996.550172491348;9064.274858011475;9080.31897607682;9233.399829011092;9455.479948602893;530506;533179;541139;544556;547620;62069;65006;74201.6289918547;74927.62536187284;84882.57558712167;1107.9224454288283;1130.5647325779635;1133.5352505472717;1151.8790526994712;1166.2011522107214;14584.854151458774;14723.852761472248;15389.923050385125;15532.68934621324;16090.356385744439;37169.07077323089;37208.44187337138;37589.4361584571;38073.23853522969;38718;45404.318935215335;45555.54444455513;45935.08129837451;46737.76631116823;46770.53229467798;9182.724518264462;9222.754928084623;9353.158215760614;9402.059794020543;9774.804503910023;11205.831912521482;17945.551361216076;18018.2792688291;18098.81901180971;18165.36421225251;14036.157830530201;14056;14512.637184070483;14666;14778.33497492594;14369.497067602584;14464.566063018126;14545.709085818437;15031.323590438675;15161.924190379419;14430.494932677306;14744.705105898036;14860.851391485947;15071.54785356441;15182.696346073237;9778.41329520231;9898.10917017472;9975.800483990135;10018.899811001796;10021.799564008825;14411.92794036065;14923.179225142721;14943.925280373529;15295.082295062331;15442.382304707686 05:21:13 INFO - 2015-12-20 05:21:13,328 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1361.8161548190992;1697.338038165116;1740.3734655524008;1744.9738253926184;1787.42802303263;6726.293739157391;7627.466077374586;7781.066272047348;7792.220777922205;7797.766067017984;7712.922870771291;7736.690532378712;7808.882866757003;7813.3749300056;7838;1973.802619738029;2010.8089731475486;2218.4010317214343;2252.076648574085;2257.1874125314876;2241.069955968271;2286.8399212055165;2288.233441797;2289.072925465189;2289.6565515172692;2164.145162660748;2176.945576360588;2225.098834971831;2225.432514708747;2227.187076716995;2251.313349428424;2267.557826223887;2271.7273927128767;2273.920412785553;2314.525522267931;2260.42359198405;2278.669592909019;2302.2057390200353;2303.37808791627;2303.4011157099108;7770.883436748453;7782.727604533814;7828.178041305695;7842.647080881374;7845;4520.2315606347;4546.249868771649;4577.038821847416;4583.885402864922;4608.331791890158;3045.2234680156416;3070.263136847163;3093.3349329893954;3131.295458521837;3180.220845892771;977.9070988256176;990.9108180263739;1013.2451323763843;1029;1047.0994944347856;10567.471626418648;10660.093892019187;10666.839997400046;10670.413127277996;10682.412467314294;3963.9801800991386;3974.6025397460603;4051.1290072633938;4168.228877657582;4171.520275168395;8772;8785.692500762443;8794.824103518022;8796.648134074565;8808.691695790616;4647.651426143053;4679.719216846932;4682.344471773954;4691.085238378483;4692.366530518405;4272.46594175728;4330.025744207591;4330.2205602991135;4330.696851220384;4331.220380331571;3227.9838600806847;3260.494623333387;3346.330733853239;3404.42124838778;3473.14907847579;1074.0762943868267;1087.6138970665459;1088.8023174508137;1093.6828319787173;1100.6808025672626;1069.390447444949;1070.4166229404993;1123.3316176874746;1266.2276011632896;1391.7981892625512;7023.964880175567;7057.329553692391;7071.186813516511;7117.0747802786345;7409.333160015624;640.5644161969905;648.1282674802384;651;652.9738810447624;786.4337676872642;5677.347105082886;5874.148248504029;5889.4993925515955;5890.764369425261;5895.793647222326;8741.082186370466;8836.293096552261;8887.15572020657;8915.821683566423;9034.186923176945;8796.384253102222;8871.157240062184;8972.641094356282;8996.145366190201;8999.775005624912;6942.965285173643;7036.401905838061;7089.113860767404;7131.465140114512;7137.10786151731;6801.353871382211;6811.931880681328;6845.760398386232;6847.657617119224;6855.965720171566;7886.645100970355;7942.324902383362;7954.64204110828;8013.358931285366;8101.513909165469;8110.229528194812;8119.83760324802;8156.632951517077;8172.6730930762105;8298.08721040673;6593.670316484253;6625;6691.631960242234;6695.832604184934;6702.162229721285;6507.739690412331;6674.16572928384;7100.751473698396;7271.563706177646;7518.812029699301;6883.449324054164;6945.756898508528;7028.262032486719;7147.1780745214965;7196.856062878818;6915.792526224222;6943.340382663639;7008.088948436671;7122.323379278961;7135.179454362815;7079.9646001771725;7118.359347658736;7119.216886142417;7120.715171393086;7121.9643901780155;6320.051992201206;6487.513436492376;6539.378759017885;6583.177102862142;6595.670216489252;6578.177727784027;6601.075849380994;6632.403083722488;6646.202455705346;6652 05:21:13 INFO - 2015-12-20 05:21:13,329 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.2903006963706;321.5241442664856;322.1029433029014;322.8740791091473;323.0566745104297;5829.912551311733;5875.324337701166;5939.584229103964;5952.672603006833;5975.731092100855;5693.146028095788;5849.883002339961;5853.531717462603;5863.941360586393;5903.675297858626;4305.870823875289;4402.053558484925;4507.09858028394;4512.458504979399;4515.6613254005915;4412.3602077698715;4492.842750503733;4501.7524036178;4503.729776213421;4521.751303678297;4470.307102399117;4491.1691337102575;4494.97752511237;4499.032707967786;4508.571685689871;4487.304467807495;4494.8202071917085;4495.123450927038;4503.076869241814;4507.639388848901;3871.0709429736944;3909.3940439231965;3935.153941902505;3940.5862384449506;3948.072203032285;5641.52047075995;5646.717664116778;5688.260526131618;5688.4311568843195;5691.4593113654555;5227.26818245446;5230.110881150175;5230.895382092337;5232.215167724834;5235.1623740201385;6010.669413182273;6133.723982420802;6138.754449822001;6243.406876346739;6249.2813326467585;4357.803898824561;4366.650667946588;4367.759773212472;4379.0366119453665;4393.6704747144095;6453.935460645427;6464.612123272619;6482.060101285334;6489.935100648981;6511.93488065118;4467.262901621261;4470.5976462117915;4475.776211189427;4476.149531588988;4477.664175186874;4303.440552728125;4428.844990425319;4437.245668236343;4440.956375251813;4453.55464453552;5170.508801663836;5173.32746742921;5178.844634660966;5180.326557547494;5186.118359878754;6327.4938004959495;6330.873382532415;6335.651539165298;6336.936630633634;6338.841528961812;1552.2626752292797;1571.5363967629576;1572.3867691600285;1574.5197714696899;1574.9921250393675;1016.1058268723476;1034.2656713733184;1044.3733759744093;1047.460557812727;1053.199568328076;5965.075413310944;5966.19456373384;5973.133895585116;5977.252843394575;5985.25184351956;6450.096986421905;6451.645159516178;6457.61254324742;6458.935410645928;6460.838479037968;5956.791512297049;6008.399160084044;6015.759369625166;6015.909761353583;6017.338092809788;3389.1357703785375;3486.6164721880573;3493.7903725776537;3500.64993500653;3506.5967413747744;6563.212414510289;6608.240052394036;6611.842927487671;6613.371729685672;6634.535582509275;6577.835554111186;6587.571807832475;6593;6596.8350791230605;6598.109255250576;6442.710078046499;6594.307597702268;6606.735730570724;6606.768763093269;6614.173228346457;6290.748370065146;6401.719656068898;6453.225612926479;6546.509011824228;6551.246606640107;6434.195725534309;6459.386358295955;6473.838154046187;6475.740970361321;6480.287168411565;6610.107635469342;6721.663916804238;6725.562838415487;6728.798136055926;6732.798016059526;4407;4450.688451808472;4456.955430445783;4457.7771111444945;4459.933101003552;6531.934680653133;6536;6540.411362977355;6544;6547.934520654732;6328.841778955563;6329.082283069021;6332.366763323631;6333.714982825692;6336.429721325103;6170.413810687977;6335.524835637253;6342.23893132827;6343.90484142729;6395.616263024047;6222.844428889133;6236.781712640036;6238.4073513018;6238.875222495434;6242.219722534684;6340.207474065742;6352.174217351715;6367.458766004941;6369.426751592379;6370.617762934239;6102.633841969496;6190.690465476799;6200.906986395117;6212.689365531795;6226.719797609027 05:21:13 INFO - 2015-12-20 05:21:13,329 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.5774219983609;692.4252870117799;723.02030748336;751.7594369801662;762.6491813765667;12753.426095825687;12904.548340808074;12944.093913426064;12962.740745185114;13146.342682865854;15075.396984120622;15194.924025379858;15301.69396612067;15358.923205383986;15365.615859603515;683.4054372695737;691.4986634689835;801.807566184116;817.158326923267;818.9017317921857;801.7995501124719;817.1909809288791;821.7904434369258;821.9589020548979;824.3281725393815;860.5181098584782;865.8095219051798;866.6360128745911;866.7269810009858;867.037588277012;707.8690442268171;718.7915504503713;831.8003679116969;849.0829903703985;859.9656013759442;615.3139249736512;615.4706952021259;617.3394467919328;618.8916939535608;619.2507066449601;13579.117357371839;13671.521496747666;13708.17750934947;13730.588082357544;13759.931200344034;11865.644030679094;11958.521659133625;12311.630651080482;12337.444814983348;12636.873631263661;9838.704838854846;9841.803163936753;10102.747431314203;10211.540480678388;10526.736831579272;3580.5524309461316;3587.677109060171;3727.5340582427198;3746.1571146492092;3758.9436158457647;48365.75817120927;48366.5163348369;49024.264636030486;49138;49199.50800491985;9981.500924953723;10059.849102263472;10070.446125463024;10139.340942838691;10180.694579162637;17916.731249031276;18133.637327253382;18133.637327253644;18142;18145;7316.414686825041;7352.558846469229;7449.292317229854;7504.924950750532;7556.6977320907645;4361.698432468129;4393.121375724868;4410.823567057282;4500.077484115748;4516.187086324428;3002.1443888492113;3052.374263276023;3056.113727019184;3056.847157642109;3057.143999680093;528.8598521391834;545.5935328180531;548.3419896124666;553.8504603757044;556;527.5094162428901;548.6845064088166;555.6166245290817;629.2009148381529;639.8336432527576;8378.958105209435;8471.49171049739;8492.320614350838;8576.785580360542;8741.562921854009;490.5781028315646;517.1957605922826;519.870032491877;554.0774610273849;555.6443875919415;3718.3492888744363;3738.626137386294;3790.65884070435;3862.9613703863165;4048.3320252158064;58650.12024819631;63762.0435693465;63830;63959.36040639534;64056.35943640504;52536;52731.73634131805;53169.202461963105;54821.1776823348;55093.72453137708;46603;49498.50501495011;49819.25271120936;49949.0010199794;50230.995380092194;9097.454152750855;9247.260219182315;9423.38747981379;9462.57418416159;9510.714678559654;36274.4558831623;37049.44425833668;37315.25369492649;38188;38414.615853841104;44488;44612.55387446084;46262;46715.29927051165;48488;9818.705438836847;10224.437655928996;10827.945860270964;10969;10976.945115274373;11273.210875238654;11583.594574189863;11588.072954163477;12244.142909996572;12737.80893286583;11115.666530004113;11259.774804504028;11486.426036561714;11750.647480575597;12078.396080196131;10797.838032429363;10878.45607719595;11135.610253641084;11522.078233741113;11850.703732406413;11365.147613929154;11378.31730096197;11403.617843518754;11750.764984700087;11916.16586838913;9992.200623950212;10014;10036.397816131055;10349.327293725884;10385.169186464913;9298.256139508689;9460.195883349717;9725.6596019139;9797.608095676092;10387.844182337421 05:21:13 INFO - 2015-12-20 05:21:13,329 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:21:13 INFO - 2015-12-20 05:21:13,329 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:21:13 INFO - 2015-12-20 05:21:13,329 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1148 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: __startTimestamp1450617673320__endTimestamp 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5527.54 Median:5730.14 stddev:641.26 (11.2%) stddev-sans-first:615.85 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: Values: 3164.5 3207.0 3259.0 3261.7 3278.3 5326.3 5422.1 5455.5 5520.1 5521.6 5417.6 5485.1 5495.5 5597.1 5600.6 4998.5 5017.7 5039.8 5054.1 5112.3 5084.1 5092.2 5152.5 5162.5 5164.9 4879.3 4937.5 4990.9 5040.6 5049.1 5004.6 5026.9 5030.2 5045.7 5067.7 4972.4 4986.9 5005.6 5023.1 5059.9 5278.8 5372.1 5378.4 5382.0 5404.0 5908.3 5920.7 5943.8 6041.4 6041.9 6069.3 6093.7 6097.4 6100.8 6101.6 5604.5 5622.4 5633.1 5642.5 5674.8 5876.4 6011.4 6015.2 6016.6 6023.3 5924.8 5930.4 5943.1 5967.6 5976.3 5998.3 6017.2 6017.6 6030.3 6031.9 5846.2 5922.9 5963.7 5965.3 5979.4 5939.8 5941.5 5947.7 5967.0 6001.3 4469.6 4484.0 4488.8 4490.8 4520.1 3933.2 4013.0 4022.3 4052.8 4096.2 5561.8 5578.0 5615.1 5623.7 5674.5 5973.0 5997.1 6025.4 6033.8 6047.9 5411.5 5463.0 5537.0 5657.7 5673.0 5124.3 5169.7 5262.8 5276.3 5291.5 6126.0 6137.8 6139.8 6145.5 6147.7 5995.8 6002.4 6009.8 6019.8 6054.4 5939.5 6044.0 6094.5 6129.6 6135.5 5928.3 5947.3 5957.4 5969.9 5977.4 6049.1 6051.3 6066.0 6066.1 6070.1 5640.6 5761.4 5836.6 5846.8 5972.1 5819.1 5842.6 5862.6 5892.2 5902.7 5707.5 5715.7 5717.5 5722.1 5730.1 5612.7 5672.4 5730.4 5824.1 5838.5 5776.1 5801.7 5816.7 5817.9 5832.9 05:21:13 INFO - 2015-12-20 05:21:13,330 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,331 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49122.01 Median:17961.76 stddev:87783.38 (488.7%) stddev-sans-first:87953.88 05:21:13 INFO - 2015-12-20 05:21:13,332 DEBUG : BROWSER_OUTPUT: Values: 549.1 603.2 609.8 611.4 633.6 30321.4 31119.7 37993.6 38131.6 38187.6 41682.2 41970.6 42121.6 42169.2 42187.2 7558.4 8605.2 8764.6 8767.9 8778.3 7711.1 7807.2 10095.5 10166.5 10303.3 9983.6 10083.2 10110.3 10122.3 10142.9 7647.3 7882.9 10021.4 10045.6 10101.1 10344.8 10572.8 10581.8 10587.2 10592.2 38919.2 39315.0 39315.2 39324.8 39340.0 3113.6 3189.6 3262.0 3403.3 3677.4 30330.8 30487.4 30876.4 30930.4 31286.2 3748.7 3827.2 3834.6 3936.1 4012.4 268123.0 268275.0 268790.0 269438.0 270136.0 53131.0 54116.5 58405.7 62768.7 65932.0 57973.4 58401.1 58722.7 59045.4 59115.7 14843.2 15046.5 15047.3 15058.8 15066.8 10463.3 10722.8 11415.8 11618.7 11619.4 19653.6 19811.9 19895.4 19923.6 20013.7 7402.5 7595.7 7620.6 7653.3 7672.7 931.6 935.1 935.9 948.8 1070.1 25390.9 25413.2 25673.2 26325.5 27336.2 1015.2 1044.8 1062.1 1072.7 1139.8 13496.0 13760.6 13855.2 14013.9 15327.8 327065.0 327494.0 328620.0 331210.0 332170.0 52779.0 53035.5 53390.0 53394.7 53399.5 1309.6 1352.3 1368.6 1370.3 1373.6 29097.0 29586.0 29682.9 30014.2 30178.7 46257.3 46599.0 46618.3 46649.5 46711.1 365804.0 375937.0 397316.0 408962.0 409578.0 30489.0 30521.0 30619.7 30705.8 30799.4 42323.8 42549.4 42923.0 43331.6 43950.0 35620.0 36366.1 36655.8 36709.8 36939.8 32184.0 32661.5 33003.0 33033.2 33288.5 31933.8 32067.8 32251.8 32320.8 32806.7 30787.5 31220.5 31929.8 31957.5 31980.5 24436.8 25083.4 25344.5 25380.6 25793.5 05:21:13 INFO - 2015-12-20 05:21:13,332 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,332 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29358.31 Median:18766.69 stddev:88141.65 (469.7%) stddev-sans-first:88362.01 05:21:13 INFO - 2015-12-20 05:21:13,333 DEBUG : BROWSER_OUTPUT: Values: 357.9 360.0 361.4 363.3 364.3 13991.3 14416.4 16668.4 16913.7 17518.1 14380.3 14593.9 16693.6 16965.7 17153.2 5392.8 5531.0 5533.3 5533.6 5535.0 4047.0 4179.1 4682.8 5938.9 6037.6 5895.7 6028.5 6089.0 6089.2 6097.5 5093.8 5235.3 5283.2 6046.3 6056.2 5016.9 5049.0 5063.7 5066.9 5079.0 12753.5 13013.7 13022.7 13042.4 18576.9 2075.9 2096.5 2101.1 2102.5 2292.7 8992.9 9040.7 9070.4 9203.2 9407.4 1802.2 1904.2 1974.6 2011.7 2135.4 68258.7 73723.3 75250.6 76551.0 77620.0 15645.8 15662.0 15775.8 15835.2 16111.4 24641.6 24649.4 24853.0 24858.5 24988.1 8843.8 8917.6 8982.5 8998.1 9036.3 7513.4 7581.8 7585.8 7586.1 7666.8 7907.4 7916.4 7929.1 7978.8 8095.8 1837.7 1846.7 2216.1 2960.3 3035.1 427.2 963.9 1044.6 1053.2 1076.4 10387.7 10425.1 10544.8 10809.7 10862.5 880.4 904.4 919.3 925.1 1006.8 8996.6 9064.3 9080.3 9233.4 9455.5 530506.0 533179.0 541139.0 544556.0 547620.0 62069.0 65006.0 74201.6 74927.6 84882.6 1107.9 1130.6 1133.5 1151.9 1166.2 14584.9 14723.9 15389.9 15532.7 16090.4 37169.1 37208.4 37589.4 38073.2 38718.0 45404.3 45555.5 45935.1 46737.8 46770.5 9182.7 9222.8 9353.2 9402.1 9774.8 11205.8 17945.6 18018.3 18098.8 18165.4 14036.2 14056.0 14512.6 14666.0 14778.3 14369.5 14464.6 14545.7 15031.3 15161.9 14430.5 14744.7 14860.9 15071.5 15182.7 9778.4 9898.1 9975.8 10018.9 10021.8 14411.9 14923.2 14943.9 15295.1 15442.4 05:21:13 INFO - 2015-12-20 05:21:13,333 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,333 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5341.66 Median:6558.78 stddev:2762.48 (42.1%) stddev-sans-first:2754.03 05:21:13 INFO - 2015-12-20 05:21:13,333 DEBUG : BROWSER_OUTPUT: Values: 1361.8 1697.3 1740.4 1745.0 1787.4 6726.3 7627.5 7781.1 7792.2 7797.8 7712.9 7736.7 7808.9 7813.4 7838.0 1973.8 2010.8 2218.4 2252.1 2257.2 2241.1 2286.8 2288.2 2289.1 2289.7 2164.1 2176.9 2225.1 2225.4 2227.2 2251.3 2267.6 2271.7 2273.9 2314.5 2260.4 2278.7 2302.2 2303.4 2303.4 7770.9 7782.7 7828.2 7842.6 7845.0 4520.2 4546.2 4577.0 4583.9 4608.3 3045.2 3070.3 3093.3 3131.3 3180.2 977.9 990.9 1013.2 1029.0 1047.1 10567.5 10660.1 10666.8 10670.4 10682.4 3964.0 3974.6 4051.1 4168.2 4171.5 8772.0 8785.7 8794.8 8796.6 8808.7 4647.7 4679.7 4682.3 4691.1 4692.4 4272.5 4330.0 4330.2 4330.7 4331.2 3228.0 3260.5 3346.3 3404.4 3473.1 1074.1 1087.6 1088.8 1093.7 1100.7 1069.4 1070.4 1123.3 1266.2 1391.8 7024.0 7057.3 7071.2 7117.1 7409.3 640.6 648.1 651.0 653.0 786.4 5677.3 5874.1 5889.5 5890.8 5895.8 8741.1 8836.3 8887.2 8915.8 9034.2 8796.4 8871.2 8972.6 8996.1 8999.8 6943.0 7036.4 7089.1 7131.5 7137.1 6801.4 6811.9 6845.8 6847.7 6856.0 7886.6 7942.3 7954.6 8013.4 8101.5 8110.2 8119.8 8156.6 8172.7 8298.1 6593.7 6625.0 6691.6 6695.8 6702.2 6507.7 6674.2 7100.8 7271.6 7518.8 6883.4 6945.8 7028.3 7147.2 7196.9 6915.8 6943.3 7008.1 7122.3 7135.2 7080.0 7118.4 7119.2 7120.7 7122.0 6320.1 6487.5 6539.4 6583.2 6595.7 6578.2 6601.1 6632.4 6646.2 6652.0 05:21:13 INFO - 2015-12-20 05:21:13,333 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,333 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5237.30 Median:5965.63 stddev:1586.75 (26.6%) stddev-sans-first:1547.38 05:21:13 INFO - 2015-12-20 05:21:13,335 DEBUG : BROWSER_OUTPUT: Values: 303.3 321.5 322.1 322.9 323.1 5829.9 5875.3 5939.6 5952.7 5975.7 5693.1 5849.9 5853.5 5863.9 5903.7 4305.9 4402.1 4507.1 4512.5 4515.7 4412.4 4492.8 4501.8 4503.7 4521.8 4470.3 4491.2 4495.0 4499.0 4508.6 4487.3 4494.8 4495.1 4503.1 4507.6 3871.1 3909.4 3935.2 3940.6 3948.1 5641.5 5646.7 5688.3 5688.4 5691.5 5227.3 5230.1 5230.9 5232.2 5235.2 6010.7 6133.7 6138.8 6243.4 6249.3 4357.8 4366.7 4367.8 4379.0 4393.7 6453.9 6464.6 6482.1 6489.9 6511.9 4467.3 4470.6 4475.8 4476.1 4477.7 4303.4 4428.8 4437.2 4441.0 4453.6 5170.5 5173.3 5178.8 5180.3 5186.1 6327.5 6330.9 6335.7 6336.9 6338.8 1552.3 1571.5 1572.4 1574.5 1575.0 1016.1 1034.3 1044.4 1047.5 1053.2 5965.1 5966.2 5973.1 5977.3 5985.3 6450.1 6451.6 6457.6 6458.9 6460.8 5956.8 6008.4 6015.8 6015.9 6017.3 3389.1 3486.6 3493.8 3500.6 3506.6 6563.2 6608.2 6611.8 6613.4 6634.5 6577.8 6587.6 6593.0 6596.8 6598.1 6442.7 6594.3 6606.7 6606.8 6614.2 6290.7 6401.7 6453.2 6546.5 6551.2 6434.2 6459.4 6473.8 6475.7 6480.3 6610.1 6721.7 6725.6 6728.8 6732.8 4407.0 4450.7 4457.0 4457.8 4459.9 6531.9 6536.0 6540.4 6544.0 6547.9 6328.8 6329.1 6332.4 6333.7 6336.4 6170.4 6335.5 6342.2 6343.9 6395.6 6222.8 6236.8 6238.4 6238.9 6242.2 6340.2 6352.2 6367.5 6369.4 6370.6 6102.6 6190.7 6200.9 6212.7 6226.7 05:21:13 INFO - 2015-12-20 05:21:13,335 DEBUG : BROWSER_OUTPUT: 05:21:13 INFO - 2015-12-20 05:21:13,335 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14270.53 Median:47540.53 stddev:16908.44 (35.6%) stddev-sans-first:16925.08 05:21:13 INFO - 2015-12-20 05:21:13,335 DEBUG : BROWSER_OUTPUT: Values: 681.6 692.4 723.0 751.8 762.6 12753.4 12904.5 12944.1 12962.7 13146.3 15075.4 15194.9 15301.7 15358.9 15365.6 683.4 691.5 801.8 817.2 818.9 801.8 817.2 821.8 822.0 824.3 860.5 865.8 866.6 866.7 867.0 707.9 718.8 831.8 849.1 860.0 615.3 615.5 617.3 618.9 619.3 13579.1 13671.5 13708.2 13730.6 13759.9 11865.6 11958.5 12311.6 12337.4 12636.9 9838.7 9841.8 10102.7 10211.5 10526.7 3580.6 3587.7 3727.5 3746.2 3758.9 48365.8 48366.5 49024.3 49138.0 49199.5 9981.5 10059.8 10070.4 10139.3 10180.7 17916.7 18133.6 18133.6 18142.0 18145.0 7316.4 7352.6 7449.3 7504.9 7556.7 4361.7 4393.1 4410.8 4500.1 4516.2 3002.1 3052.4 3056.1 3056.8 3057.1 528.9 545.6 548.3 553.9 556.0 527.5 548.7 555.6 629.2 639.8 8379.0 8471.5 8492.3 8576.8 8741.6 490.6 517.2 519.9 554.1 555.6 3718.3 3738.6 3790.7 3863.0 4048.3 58650.1 63762.0 63830.0 63959.4 64056.4 52536.0 52731.7 53169.2 54821.2 55093.7 46603.0 49498.5 49819.3 49949.0 50231.0 9097.5 9247.3 9423.4 9462.6 9510.7 36274.5 37049.4 37315.3 38188.0 38414.6 44488.0 44612.6 46262.0 46715.3 48488.0 9818.7 10224.4 10827.9 10969.0 10976.9 11273.2 11583.6 11588.1 12244.1 12737.8 11115.7 11259.8 11486.4 11750.6 12078.4 10797.8 10878.5 11135.6 11522.1 11850.7 11365.1 11378.3 11403.6 11750.8 11916.2 9992.2 10014.0 10036.4 10349.3 10385.2 9298.3 9460.2 9725.7 9797.6 10387.8 05:21:13 INFO - 2015-12-20 05:21:13,335 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:21:13 INFO - 2015-12-20 05:21:13,335 DEBUG : BROWSER_OUTPUT: 05:21:14 INFO - 2015-12-20 05:21:14,001 INFO : Browser exited with error code: 0 05:21:14 INFO - 2015-12-20 05:21:14,020 INFO : Completed test dromaeo_css (00:18:37) 05:21:14 INFO - 2015-12-20 05:21:14,020 INFO : Starting test kraken 05:21:14 INFO - 2015-12-20 05:21:14,020 DEBUG : operating with platform_type : linux_ 05:21:14 INFO - 2015-12-20 05:21:14,020 INFO : Initialising browser for kraken test... 05:21:14 INFO - 2015-12-20 05:21:14,026 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4bfRZ7/profile http://localhost:34247/getInfo.html 05:21:18 INFO - 2015-12-20 05:21:18,155 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:21:18 INFO - 2015-12-20 05:21:18,162 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:21:18 INFO - 2015-12-20 05:21:18,162 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:21:18 INFO - 2015-12-20 05:21:18,162 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:21:18 INFO - 2015-12-20 05:21:18,163 DEBUG : BROWSER_OUTPUT: __metrics 05:21:18 INFO - 2015-12-20 05:21:18,304 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] 05:21:18 INFO - 2015-12-20 05:21:18,360 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:19 INFO - 2015-12-20 05:21:19,597 INFO : Browser initialized. 05:21:19 INFO - 2015-12-20 05:21:19,597 INFO : Running cycle 1/1 for kraken test... 05:21:19 INFO - 2015-12-20 05:21:19,597 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4bfRZ7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:21:31 INFO - 2015-12-20 05:21:31,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 149590016 05:21:31 INFO - 2015-12-20 05:21:31,374 DEBUG : BROWSER_OUTPUT: 05:21:33 INFO - 2015-12-20 05:21:33,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34247/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:34 INFO - 2015-12-20 05:21:34,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 183767040 05:21:34 INFO - 2015-12-20 05:21:34,442 DEBUG : BROWSER_OUTPUT: 05:21:37 INFO - 2015-12-20 05:21:37,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34247/tests/kraken/driver.html?testName=audio-dft) 05:21:37 INFO - 2015-12-20 05:21:37,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 175161344 05:21:37 INFO - 2015-12-20 05:21:37,579 DEBUG : BROWSER_OUTPUT: 05:21:40 INFO - 2015-12-20 05:21:40,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34247/tests/kraken/driver.html?testName=audio-fft) 05:21:41 INFO - 2015-12-20 05:21:41,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 159621120 05:21:41 INFO - 2015-12-20 05:21:41,030 DEBUG : BROWSER_OUTPUT: 05:21:42 INFO - 2015-12-20 05:21:42,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34247/tests/kraken/driver.html?testName=audio-oscillator) 05:21:43 INFO - 2015-12-20 05:21:43,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 162611200 05:21:43 INFO - 2015-12-20 05:21:43,560 DEBUG : BROWSER_OUTPUT: 05:21:45 INFO - 2015-12-20 05:21:45,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:46 INFO - 2015-12-20 05:21:46,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 163708928 05:21:46 INFO - 2015-12-20 05:21:46,296 DEBUG : BROWSER_OUTPUT: 05:21:49 INFO - 2015-12-20 05:21:49,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34247/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:49 INFO - 2015-12-20 05:21:49,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 165646336 05:21:49 INFO - 2015-12-20 05:21:49,742 DEBUG : BROWSER_OUTPUT: 05:21:53 INFO - 2015-12-20 05:21:53,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34247/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:53 INFO - 2015-12-20 05:21:53,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 166957056 05:21:53 INFO - 2015-12-20 05:21:53,709 DEBUG : BROWSER_OUTPUT: 05:21:56 INFO - 2015-12-20 05:21:56,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34247/tests/kraken/driver.html?testName=json-parse-financial) 05:21:56 INFO - 2015-12-20 05:21:56,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 166064128 05:21:56 INFO - 2015-12-20 05:21:56,977 DEBUG : BROWSER_OUTPUT: 05:21:58 INFO - 2015-12-20 05:21:58,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:59 INFO - 2015-12-20 05:21:59,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 177016832 05:21:59 INFO - 2015-12-20 05:21:59,093 DEBUG : BROWSER_OUTPUT: 05:22:00 INFO - 2015-12-20 05:22:00,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:01 INFO - 2015-12-20 05:22:01,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 175779840 05:22:01 INFO - 2015-12-20 05:22:01,522 DEBUG : BROWSER_OUTPUT: 05:22:03 INFO - 2015-12-20 05:22:03,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:04 INFO - 2015-12-20 05:22:04,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 182968320 05:22:04 INFO - 2015-12-20 05:22:04,175 DEBUG : BROWSER_OUTPUT: 05:22:06 INFO - 2015-12-20 05:22:06,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:07 INFO - 2015-12-20 05:22:07,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 192409600 05:22:07 INFO - 2015-12-20 05:22:07,193 DEBUG : BROWSER_OUTPUT: 05:22:09 INFO - 2015-12-20 05:22:09,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:10 INFO - 2015-12-20 05:22:10,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 189263872 05:22:10 INFO - 2015-12-20 05:22:10,360 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34247/tests/kraken/driver.html?testName=ai-astar) 05:22:12 INFO - 2015-12-20 05:22:12,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 247209984 05:22:12 INFO - 2015-12-20 05:22:12,274 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,277 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:22:12 INFO - 2015-12-20 05:22:12,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:22:12 INFO - 2015-12-20 05:22:12,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:22:12 INFO - 2015-12-20 05:22:12,277 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;110;111;111;102;112;112;103 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;121;146;165;124;153;150;123;163;125 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;163;159;162;161;160;159;162;161 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;80;92;73;72;71;95;92;72 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;92;133;93;93;92;137;93;94;133 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;110;109 05:22:12 INFO - 2015-12-20 05:22:12,278 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;146;145;146;145;146;147 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;57;57;57;58;57;67;55;58 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;67;68;68;67;80;67;68 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;91;85;86;85;85;85;84;84 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;118;118;120;127;122;120;117;136;116 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;154;161;165;153;140;150;158;149;142 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;67;68;67;66;67;69;68;65 05:22:12 INFO - 2015-12-20 05:22:12,279 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:22:12 INFO - 2015-12-20 05:22:12,280 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:22:12 INFO - 2015-12-20 05:22:12,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,943 05:22:12 INFO - 2015-12-20 05:22:12,280 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:22:12 INFO - 2015-12-20 05:22:12,280 DEBUG : BROWSER_OUTPUT: __startTimestamp1450617732275__endTimestamp 05:22:12 INFO - 2015-12-20 05:22:12,280 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:3.75 (3.4%) stddev-sans-first:3.97 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 110.0 111.0 111.0 102.0 112.0 112.0 103.0 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:151.50 stddev:17.75 (11.7%) stddev-sans-first:17.95 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: Values: 158.0 121.0 146.0 165.0 124.0 153.0 150.0 123.0 163.0 125.0 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 163.0 159.0 162.0 161.0 160.0 159.0 162.0 161.0 05:22:12 INFO - 2015-12-20 05:22:12,284 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:76.50 stddev:9.95 (13.0%) stddev-sans-first:10.22 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 80.0 92.0 73.0 72.0 71.0 95.0 92.0 72.0 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:93.00 stddev:20.01 (21.5%) stddev-sans-first:20.79 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: Values: 94.0 92.0 133.0 93.0 93.0 92.0 137.0 93.0 94.0 133.0 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 147.0 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,285 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:3.23 (5.6%) stddev-sans-first:3.43 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 57.0 57.0 57.0 58.0 57.0 67.0 55.0 58.0 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:3.97 (5.8%) stddev-sans-first:4.15 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 67.0 68.0 68.0 67.0 80.0 67.0 68.0 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.17 (2.6%) stddev-sans-first:2.12 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 91.0 85.0 86.0 85.0 85.0 85.0 84.0 84.0 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.00 stddev:5.98 (4.9%) stddev-sans-first:6.33 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: Values: 123.0 118.0 118.0 120.0 127.0 122.0 120.0 117.0 136.0 116.0 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:153.50 stddev:7.79 (5.1%) stddev-sans-first:8.26 05:22:12 INFO - 2015-12-20 05:22:12,286 DEBUG : BROWSER_OUTPUT: Values: 152.0 154.0 161.0 165.0 153.0 140.0 150.0 158.0 149.0 142.0 05:22:12 INFO - 2015-12-20 05:22:12,287 DEBUG : BROWSER_OUTPUT: 05:22:12 INFO - 2015-12-20 05:22:12,287 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 05:22:12 INFO - 2015-12-20 05:22:12,287 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 67.0 68.0 67.0 66.0 67.0 69.0 68.0 65.0 05:22:12 INFO - 2015-12-20 05:22:12,287 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:22:12 INFO - 2015-12-20 05:22:12,287 DEBUG : BROWSER_OUTPUT: 05:22:13 INFO - 2015-12-20 05:22:13,090 INFO : Browser exited with error code: 0 05:22:13 INFO - 2015-12-20 05:22:13,136 INFO : Completed test kraken (00:00:59) 05:22:13 INFO - 2015-12-20 05:22:13,136 INFO : Starting test v8_7 05:22:13 INFO - 2015-12-20 05:22:13,136 DEBUG : operating with platform_type : linux_ 05:22:13 INFO - 2015-12-20 05:22:13,136 INFO : Initialising browser for v8_7 test... 05:22:13 INFO - 2015-12-20 05:22:13,142 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvaC9or/profile http://localhost:34247/getInfo.html 05:22:17 INFO - 2015-12-20 05:22:17,227 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:22:17 INFO - 2015-12-20 05:22:17,230 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:22:17 INFO - 2015-12-20 05:22:17,231 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:22:17 INFO - 2015-12-20 05:22:17,231 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:22:17 INFO - 2015-12-20 05:22:17,231 DEBUG : BROWSER_OUTPUT: __metrics 05:22:17 INFO - 2015-12-20 05:22:17,368 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] 05:22:17 INFO - 2015-12-20 05:22:17,409 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:18 INFO - 2015-12-20 05:22:18,662 INFO : Browser initialized. 05:22:18 INFO - 2015-12-20 05:22:18,662 INFO : Running cycle 1/1 for v8_7 test... 05:22:18 INFO - 2015-12-20 05:22:18,662 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvaC9or/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:22:30 INFO - 2015-12-20 05:22:30,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 150147072 05:22:30 INFO - 2015-12-20 05:22:30,408 DEBUG : BROWSER_OUTPUT: 05:22:51 INFO - 2015-12-20 05:22:51,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34247/tests/v8_7/run.html (next: http://localhost:34247/tests/v8_7/run.html) 05:22:52 INFO - 2015-12-20 05:22:52,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 585293824 05:22:52 INFO - 2015-12-20 05:22:52,094 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,094 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: |0;Richards;165.53550736633008 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.7504718761797 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 05:22:52 INFO - 2015-12-20 05:22:52,096 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1953.125 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: |5;Earley;754.7169811320755 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: |8;Splay;568.1818181818181 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: __startTimestamp1450617772093__endTimestamp 05:22:52 INFO - 2015-12-20 05:22:52,097 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,098 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:22:52 INFO - 2015-12-20 05:22:52,098 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:22:52 INFO - 2015-12-20 05:22:52,098 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,098 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,099 DEBUG : BROWSER_OUTPUT: Values: 165.5 05:22:52 INFO - 2015-12-20 05:22:52,099 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,099 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,099 DEBUG : BROWSER_OUTPUT: Values: 188.8 05:22:52 INFO - 2015-12-20 05:22:52,099 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,099 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: Values: 279.1 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: Values: 5191.7 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1953.13 Median:1953.13 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,100 DEBUG : BROWSER_OUTPUT: Values: 1953.1 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:754.72 Median:754.72 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: Values: 754.7 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: Values: 12195.1 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: Values: 25250.0 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:568.18 Median:568.18 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: Values: 568.2 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: Values: 4840.6 05:22:52 INFO - 2015-12-20 05:22:52,101 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:22:52 INFO - 2015-12-20 05:22:52,102 DEBUG : BROWSER_OUTPUT: 05:22:52 INFO - 2015-12-20 05:22:52,937 INFO : Browser exited with error code: 0 05:22:52 INFO - 2015-12-20 05:22:52,952 INFO : Completed test v8_7 (00:00:39) 05:22:53 INFO - 2015-12-20 05:22:53,102 INFO : Completed test suite (00:20:16) 05:22:53 INFO - 2015-12-20 05:22:53,102 DEBUG : Working with test: dromaeo_css 05:22:53 INFO - 2015-12-20 05:22:53,102 DEBUG : Generating results file: dromaeo_css 05:22:53 INFO - 2015-12-20 05:22:53,103 DEBUG : Working with test: kraken 05:22:53 INFO - 2015-12-20 05:22:53,103 DEBUG : Generating results file: kraken 05:22:53 INFO - 2015-12-20 05:22:53,103 INFO : javascript benchmark 05:22:53 INFO - 2015-12-20 05:22:53,104 DEBUG : Working with test: v8_7 05:22:53 INFO - 2015-12-20 05:22:53,104 DEBUG : Generating results file: v8_7 05:22:53 INFO - 2015-12-20 05:22:53,104 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:53 INFO - 2015-12-20 05:22:53,160 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:22:53 INFO - 2015-12-20 05:22:53,160 DEBUG : process_Request line: dromaeo_css 7041.76 graph.html#tests=[[72,64,35]] 05:22:53 INFO - 2015-12-20 05:22:53,160 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:53 INFO - 2015-12-20 05:22:53,186 DEBUG : process_Request line: kraken 1501.10 graph.html#tests=[[232,64,35]] 05:22:53 INFO - 2015-12-20 05:22:53,186 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:53 INFO - 2015-12-20 05:22:53,221 DEBUG : process_Request line: v8_7 20144.39 graph.html#tests=[[230,64,35]] 05:22:53 INFO - 2015-12-20 05:22:53,222 INFO : javascript benchmark 05:22:53 INFO - 2015-12-20 05:22:53,225 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3164.4620414529536, 3206.9518957215632, 3258.9837050814726, 3261.6575259597744, 3278.3443311337737, 5326.280952071469, 5422.078246698061, 5455.481729235721, 5520.089185284428, 5521.558275337973, 5417.59368047396, 5485.149801780721, 5495.505404513593, 5597.076482380402, 5600.6079574429705, 4998.450170481253, 5017.724025178632, 5039.798408063673, 5054.064997975368, 5112.335396398463, 5084.084864724348, 5092.236164575306, 5152.510511501401, 5162.457941916101, 5164.896702065957, 4879.341288925985, 4937.506249375069, 4990.87522811929, 5040.596752259847, 5049.091163590552, 5004.624653151028, 5026.949730502684, 5030.170021946375, 5045.722485263309, 5067.746612669352, 4972.428170760337, 4986.87532811679, 5005.624578156617, 5023.070731914608, 5059.924101138486, 5278.788848446057, 5372.113601255788, 5378.354597448292, 5382.0312343778105, 5403.972980135074, 5908.261467316585, 5920.733566989453, 5943.791967281124, 6041.365656606037, 6041.939580604226, 6069.271687397496, 6093.69531523422, 6097.359777223416, 6100.847478813021, 6101.603395779304, 5604.495595396393, 5622.409646987089, 5633.126865335879, 5642.548596112301, 5674.829755107312, 5876.382979787147, 6011.428914253139, 6015.248093988252, 6016.639001659914, 6023.307319658208, 5924.822255332347, 5930.406959304035, 5943.10853371989, 5967.6121052131475, 5976.252968378953, 5998.280206375263, 6017.247844019497, 6017.638941663514, 6030.30651475086, 6031.9396806032255, 5846.181534585162, 5922.940770592325, 5963.747613001318, 5965.3139888912465, 5979.431953964367, 5939.821805345847, 5941.524678025748, 5947.732352044169, 5966.970165149233, 6001.279846418458, 4469.597736203757, 4484.035932274576, 4488.842890498817, 4490.842820501267, 4520.141173177086, 3933.193695292458, 4012.9598704012587, 4022.3162062449455, 4052.8378864845668, 4096.221717873595, 5561.833145005657, 5578.0, 5615.129654903497, 5623.690697011703, 5674.489295963301, 5973.01445261527, 5997.100434934708, 6025.427584379477, 6033.7586496540525, 6047.9395206047375, 5411.540019098342, 5463.0, 5537.0, 5657.745401456944, 5673.0, 5124.256982737556, 5169.689818610896, 5262.815801446931, 5276.314079169683, 5291.470852914677, 6126.0, 6137.7851775187655, 6139.785107521216, 6145.539084568675, 6147.692615369214, 5995.820125396245, 6002.429769171922, 6009.849753756191, 6019.849503762441, 6054.394560544087, 5939.46544810969, 6043.969780151071, 6094.537231721354, 6129.632222066691, 6135.53983451234, 5928.288605367384, 5947.256592925884, 5957.434043765836, 5969.850753731192, 5977.372375900468, 6049.122877182872, 6051.334353221054, 6066.0, 6066.059760737093, 6070.119832624333, 5640.576956728344, 5761.366249712612, 5836.591438599427, 5846.766129354948, 5972.104184372379, 5819.127130930225, 5842.620229685057, 5862.618929769551, 5892.204552385373, 5902.734376952962, 5707.543396528351, 5715.685637289989, 5717.456841600041, 5722.055860782924, 5730.140478928028, 5612.747426365741, 5672.404397538199, 5730.398308177581, 5824.097264923944, 5838.503727183237, 5776.075827867521, 5801.680907550125, 5816.70916454184, 5817.9127313091185, 5832.912506312494], "unit": "score", "name": "dojo.html", "value": 5483.554367186797}, {"lowerIsBetter": false, "replicates": [549.0967358694946, 603.1706403694919, 609.8383928259009, 611.3763960760025, 633.5660072850098, 30321.393572128545, 31119.688803111963, 37993.62006379935, 38131.618683813154, 38187.61812381882, 41682.166356672846, 41970.58029419705, 42121.57878421215, 42169.15661686764, 42187.15625687484, 7558.35753960914, 8605.182507661762, 8764.649414023432, 8767.912320876805, 8778.253848422892, 7711.11322197946, 7807.219278072204, 10095.545700443497, 10166.542505587266, 10303.27877048607, 9983.600655973753, 10083.243756718239, 10110.342827716211, 10122.29143959923, 10142.898571014306, 7647.311741943252, 7882.921170788276, 10021.398716077023, 10045.598176072948, 10101.141402980755, 10344.793104137874, 10572.78854422915, 10581.788364232672, 10587.205959553065, 10592.15262778976, 38919.22161556781, 39315.0, 39315.21369572621, 39324.803375983225, 39340.0, 3113.6263648362115, 3189.569408129896, 3262.000926308658, 3403.3193361327835, 3677.4415371506275, 30330.84834575835, 30487.390252195055, 30876.382472350426, 30930.381392372026, 31286.21784455384, 3748.737588368815, 3827.1771569112775, 3834.6357096075826, 3936.055346716796, 4012.4382586437923, 268123.0, 268275.0, 268790.0, 269438.0, 270136.0, 53131.0, 54116.458835411926, 58405.70797145987, 62768.686156568925, 65932.01101983474, 57973.42026579765, 58401.123983140285, 58722.70638646779, 59045.40954590485, 59115.70442147762, 14843.183624900734, 15046.54860354191, 15047.322870470854, 15058.774118388234, 15066.849331506764, 10463.267571270091, 10722.839157412645, 11415.828762568568, 11618.6514404568, 11619.419029048513, 19653.60692786136, 19811.900940495205, 19895.403137905887, 19923.60152796936, 20013.699794503093, 7402.481826272109, 7595.734149304748, 7620.5808680522, 7653.3494652954005, 7672.65473053714, 931.6459745296744, 935.102301790289, 935.8596210568469, 948.8244674735196, 1070.0797314309686, 25390.873045635024, 25413.237602871945, 25673.229803105936, 26325.473490530083, 27336.179914602595, 1015.2487159502062, 1044.7962647283707, 1062.0600768319937, 1072.6674730833467, 1139.783441146196, 13495.97948666894, 13760.587182384545, 13855.23796191199, 14013.859861401459, 15327.846721532642, 327065.0, 327494.0, 328620.0, 331210.0, 332170.0, 52779.0, 53035.46964530383, 53390.0, 53394.733026335394, 53399.46600533945, 1309.6267563744477, 1352.3373546961918, 1368.609946165338, 1370.2532119994628, 1373.6291201375573, 29097.0, 29586.0, 29682.851585741933, 30014.24964375908, 30178.69821301759, 46257.30614040725, 46599.0, 46618.300725489826, 46649.53350466452, 46711.06577868492, 365804.0, 375937.0, 397316.0, 408962.0, 409578.0, 30489.0, 30521.0, 30619.693803062575, 30705.846470767505, 30799.384012320075, 42323.7883810579, 42549.36175957301, 42923.0, 43331.566684332756, 43950.0, 35620.0, 36366.09084772796, 36655.81672091623, 36709.81645091758, 36939.81530092332, 32184.0, 32661.510077348383, 33003.0, 33033.17417064593, 33288.50067248945, 31933.84033079913, 32067.839660801546, 32251.838740806146, 32320.83839580787, 32806.67193328036, 30787.53818692766, 31220.53169202509, 31929.8403507981, 31957.520637189995, 31980.52029219517, 24436.755632443448, 25083.372915676526, 25344.493110138064, 25380.619290710285, 25793.484130317665], "unit": "score", "name": "ext.html", "value": 18582.745953973008}, {"lowerIsBetter": false, "replicates": [357.9427291633339, 359.9622039685835, 361.3712140874878, 363.34235034587397, 364.305997075571, 13991.30043497826, 14416.35126419311, 16668.416605418814, 16913.66172676546, 17518.12409379529, 14380.280985950712, 14593.854061459382, 16693.582660433494, 16965.660686786257, 17153.228104735284, 5392.757325920324, 5531.0, 5533.335999680044, 5533.612647114704, 5534.972325138368, 4047.0, 4179.101493178966, 4682.8126874924965, 5938.910916336258, 6037.637741735488, 5895.734691938852, 6028.517718582503, 6089.0, 6089.208402907616, 6097.5426842986735, 5093.821716239951, 5235.319408476912, 5283.1546952487415, 6046.3372572542685, 6056.21269235001, 5016.949830501721, 5049.040682270357, 5063.670861393997, 5066.949330506722, 5078.974605126988, 12753.489860405572, 13013.674658133528, 13022.739545209042, 13042.413091410814, 18576.907115464335, 2075.8858262795693, 2096.4758810297426, 2101.054525463532, 2102.5374417628095, 2292.701948746669, 8992.910070899337, 9040.728778136601, 9070.410423322528, 9203.171714545722, 9407.388519746262, 1802.2396572074797, 1904.1526520698294, 1974.6149500847341, 2011.6580181369202, 2135.3807395855183, 68258.65870670664, 73723.26276737271, 75250.62374688091, 76551.0, 77620.0, 15645.843541564438, 15662.0, 15775.842241577437, 15835.208239587975, 16111.436099736453, 24641.63037554438, 24649.383765405648, 24853.0, 24858.5028299433, 24988.12541561073, 8843.778905527413, 8917.55412229386, 8982.505962172143, 8998.055204203596, 9036.322275829207, 7513.39892808574, 7581.848363032708, 7585.810354741066, 7586.127595326608, 7666.846663066707, 7907.367410607138, 7916.366690664733, 7929.1277959424415, 7978.760637180894, 8095.757127286191, 1837.7059670452663, 1846.7045272756295, 2216.1135545781494, 2960.312621805593, 3035.119815253596, 427.2373812744237, 963.8795150606175, 1044.6054517219445, 1053.2364036073939, 1076.3972175581544, 10387.68836934893, 10425.061744443037, 10544.841827372595, 10809.67570972872, 10862.45687715611, 880.4321212817697, 904.371461834019, 919.2737737187547, 925.0656836595087, 1006.7684432580547, 8996.550172491348, 9064.274858011475, 9080.31897607682, 9233.399829011092, 9455.479948602893, 530506.0, 533179.0, 541139.0, 544556.0, 547620.0, 62069.0, 65006.0, 74201.6289918547, 74927.62536187284, 84882.57558712167, 1107.9224454288283, 1130.5647325779635, 1133.5352505472717, 1151.8790526994712, 1166.2011522107214, 14584.854151458774, 14723.852761472248, 15389.923050385125, 15532.68934621324, 16090.356385744439, 37169.07077323089, 37208.44187337138, 37589.4361584571, 38073.23853522969, 38718.0, 45404.318935215335, 45555.54444455513, 45935.08129837451, 46737.76631116823, 46770.53229467798, 9182.724518264462, 9222.754928084623, 9353.158215760614, 9402.059794020543, 9774.804503910023, 11205.831912521482, 17945.551361216076, 18018.2792688291, 18098.81901180971, 18165.36421225251, 14036.157830530201, 14056.0, 14512.637184070483, 14666.0, 14778.33497492594, 14369.497067602584, 14464.566063018126, 14545.709085818437, 15031.323590438675, 15161.924190379419, 14430.494932677306, 14744.705105898036, 14860.851391485947, 15071.54785356441, 15182.696346073237, 9778.41329520231, 9898.10917017472, 9975.800483990135, 10018.899811001796, 10021.799564008825, 14411.92794036065, 14923.179225142721, 14943.925280373529, 15295.082295062331, 15442.382304707686], "unit": "score", "name": "jquery.html", "value": 9255.566588164484}, {"lowerIsBetter": false, "replicates": [1361.8161548190992, 1697.338038165116, 1740.3734655524008, 1744.9738253926184, 1787.42802303263, 6726.293739157391, 7627.466077374586, 7781.066272047348, 7792.220777922205, 7797.766067017984, 7712.922870771291, 7736.690532378712, 7808.882866757003, 7813.3749300056, 7838.0, 1973.802619738029, 2010.8089731475486, 2218.4010317214343, 2252.076648574085, 2257.1874125314876, 2241.069955968271, 2286.8399212055165, 2288.233441797, 2289.072925465189, 2289.6565515172692, 2164.145162660748, 2176.945576360588, 2225.098834971831, 2225.432514708747, 2227.187076716995, 2251.313349428424, 2267.557826223887, 2271.7273927128767, 2273.920412785553, 2314.525522267931, 2260.42359198405, 2278.669592909019, 2302.2057390200353, 2303.37808791627, 2303.4011157099108, 7770.883436748453, 7782.727604533814, 7828.178041305695, 7842.647080881374, 7845.0, 4520.2315606347, 4546.249868771649, 4577.038821847416, 4583.885402864922, 4608.331791890158, 3045.2234680156416, 3070.263136847163, 3093.3349329893954, 3131.295458521837, 3180.220845892771, 977.9070988256176, 990.9108180263739, 1013.2451323763843, 1029.0, 1047.0994944347856, 10567.471626418648, 10660.093892019187, 10666.839997400046, 10670.413127277996, 10682.412467314294, 3963.9801800991386, 3974.6025397460603, 4051.1290072633938, 4168.228877657582, 4171.520275168395, 8772.0, 8785.692500762443, 8794.824103518022, 8796.648134074565, 8808.691695790616, 4647.651426143053, 4679.719216846932, 4682.344471773954, 4691.085238378483, 4692.366530518405, 4272.46594175728, 4330.025744207591, 4330.2205602991135, 4330.696851220384, 4331.220380331571, 3227.9838600806847, 3260.494623333387, 3346.330733853239, 3404.42124838778, 3473.14907847579, 1074.0762943868267, 1087.6138970665459, 1088.8023174508137, 1093.6828319787173, 1100.6808025672626, 1069.390447444949, 1070.4166229404993, 1123.3316176874746, 1266.2276011632896, 1391.7981892625512, 7023.964880175567, 7057.329553692391, 7071.186813516511, 7117.0747802786345, 7409.333160015624, 640.5644161969905, 648.1282674802384, 651.0, 652.9738810447624, 786.4337676872642, 5677.347105082886, 5874.148248504029, 5889.4993925515955, 5890.764369425261, 5895.793647222326, 8741.082186370466, 8836.293096552261, 8887.15572020657, 8915.821683566423, 9034.186923176945, 8796.384253102222, 8871.157240062184, 8972.641094356282, 8996.145366190201, 8999.775005624912, 6942.965285173643, 7036.401905838061, 7089.113860767404, 7131.465140114512, 7137.10786151731, 6801.353871382211, 6811.931880681328, 6845.760398386232, 6847.657617119224, 6855.965720171566, 7886.645100970355, 7942.324902383362, 7954.64204110828, 8013.358931285366, 8101.513909165469, 8110.229528194812, 8119.83760324802, 8156.632951517077, 8172.6730930762105, 8298.08721040673, 6593.670316484253, 6625.0, 6691.631960242234, 6695.832604184934, 6702.162229721285, 6507.739690412331, 6674.16572928384, 7100.751473698396, 7271.563706177646, 7518.812029699301, 6883.449324054164, 6945.756898508528, 7028.262032486719, 7147.1780745214965, 7196.856062878818, 6915.792526224222, 6943.340382663639, 7008.088948436671, 7122.323379278961, 7135.179454362815, 7079.9646001771725, 7118.359347658736, 7119.216886142417, 7120.715171393086, 7121.9643901780155, 6320.051992201206, 6487.513436492376, 6539.378759017885, 6583.177102862142, 6595.670216489252, 6578.177727784027, 6601.075849380994, 6632.403083722488, 6646.202455705346, 6652.0], "unit": "score", "name": "mootools.html", "value": 4356.2712602589845}, {"lowerIsBetter": false, "replicates": [303.2903006963706, 321.5241442664856, 322.1029433029014, 322.8740791091473, 323.0566745104297, 5829.912551311733, 5875.324337701166, 5939.584229103964, 5952.672603006833, 5975.731092100855, 5693.146028095788, 5849.883002339961, 5853.531717462603, 5863.941360586393, 5903.675297858626, 4305.870823875289, 4402.053558484925, 4507.09858028394, 4512.458504979399, 4515.6613254005915, 4412.3602077698715, 4492.842750503733, 4501.7524036178, 4503.729776213421, 4521.751303678297, 4470.307102399117, 4491.1691337102575, 4494.97752511237, 4499.032707967786, 4508.571685689871, 4487.304467807495, 4494.8202071917085, 4495.123450927038, 4503.076869241814, 4507.639388848901, 3871.0709429736944, 3909.3940439231965, 3935.153941902505, 3940.5862384449506, 3948.072203032285, 5641.52047075995, 5646.717664116778, 5688.260526131618, 5688.4311568843195, 5691.4593113654555, 5227.26818245446, 5230.110881150175, 5230.895382092337, 5232.215167724834, 5235.1623740201385, 6010.669413182273, 6133.723982420802, 6138.754449822001, 6243.406876346739, 6249.2813326467585, 4357.803898824561, 4366.650667946588, 4367.759773212472, 4379.0366119453665, 4393.6704747144095, 6453.935460645427, 6464.612123272619, 6482.060101285334, 6489.935100648981, 6511.93488065118, 4467.262901621261, 4470.5976462117915, 4475.776211189427, 4476.149531588988, 4477.664175186874, 4303.440552728125, 4428.844990425319, 4437.245668236343, 4440.956375251813, 4453.55464453552, 5170.508801663836, 5173.32746742921, 5178.844634660966, 5180.326557547494, 5186.118359878754, 6327.4938004959495, 6330.873382532415, 6335.651539165298, 6336.936630633634, 6338.841528961812, 1552.2626752292797, 1571.5363967629576, 1572.3867691600285, 1574.5197714696899, 1574.9921250393675, 1016.1058268723476, 1034.2656713733184, 1044.3733759744093, 1047.460557812727, 1053.199568328076, 5965.075413310944, 5966.19456373384, 5973.133895585116, 5977.252843394575, 5985.25184351956, 6450.096986421905, 6451.645159516178, 6457.61254324742, 6458.935410645928, 6460.838479037968, 5956.791512297049, 6008.399160084044, 6015.759369625166, 6015.909761353583, 6017.338092809788, 3389.1357703785375, 3486.6164721880573, 3493.7903725776537, 3500.64993500653, 3506.5967413747744, 6563.212414510289, 6608.240052394036, 6611.842927487671, 6613.371729685672, 6634.535582509275, 6577.835554111186, 6587.571807832475, 6593.0, 6596.8350791230605, 6598.109255250576, 6442.710078046499, 6594.307597702268, 6606.735730570724, 6606.768763093269, 6614.173228346457, 6290.748370065146, 6401.719656068898, 6453.225612926479, 6546.509011824228, 6551.246606640107, 6434.195725534309, 6459.386358295955, 6473.838154046187, 6475.740970361321, 6480.287168411565, 6610.107635469342, 6721.663916804238, 6725.562838415487, 6728.798136055926, 6732.798016059526, 4407.0, 4450.688451808472, 4456.955430445783, 4457.7771111444945, 4459.933101003552, 6531.934680653133, 6536.0, 6540.411362977355, 6544.0, 6547.934520654732, 6328.841778955563, 6329.082283069021, 6332.366763323631, 6333.714982825692, 6336.429721325103, 6170.413810687977, 6335.524835637253, 6342.23893132827, 6343.90484142729, 6395.616263024047, 6222.844428889133, 6236.781712640036, 6238.4073513018, 6238.875222495434, 6242.219722534684, 6340.207474065742, 6352.174217351715, 6367.458766004941, 6369.426751592379, 6370.617762934239, 6102.633841969496, 6190.690465476799, 6200.906986395117, 6212.689365531795, 6226.719797609027], "unit": "score", "name": "prototype.html", "value": 4714.236603552358}, {"lowerIsBetter": false, "replicates": [681.5774219983609, 692.4252870117799, 723.02030748336, 751.7594369801662, 762.6491813765667, 12753.426095825687, 12904.548340808074, 12944.093913426064, 12962.740745185114, 13146.342682865854, 15075.396984120622, 15194.924025379858, 15301.69396612067, 15358.923205383986, 15365.615859603515, 683.4054372695737, 691.4986634689835, 801.807566184116, 817.158326923267, 818.9017317921857, 801.7995501124719, 817.1909809288791, 821.7904434369258, 821.9589020548979, 824.3281725393815, 860.5181098584782, 865.8095219051798, 866.6360128745911, 866.7269810009858, 867.037588277012, 707.8690442268171, 718.7915504503713, 831.8003679116969, 849.0829903703985, 859.9656013759442, 615.3139249736512, 615.4706952021259, 617.3394467919328, 618.8916939535608, 619.2507066449601, 13579.117357371839, 13671.521496747666, 13708.17750934947, 13730.588082357544, 13759.931200344034, 11865.644030679094, 11958.521659133625, 12311.630651080482, 12337.444814983348, 12636.873631263661, 9838.704838854846, 9841.803163936753, 10102.747431314203, 10211.540480678388, 10526.736831579272, 3580.5524309461316, 3587.677109060171, 3727.5340582427198, 3746.1571146492092, 3758.9436158457647, 48365.75817120927, 48366.5163348369, 49024.264636030486, 49138.0, 49199.50800491985, 9981.500924953723, 10059.849102263472, 10070.446125463024, 10139.340942838691, 10180.694579162637, 17916.731249031276, 18133.637327253382, 18133.637327253644, 18142.0, 18145.0, 7316.414686825041, 7352.558846469229, 7449.292317229854, 7504.924950750532, 7556.6977320907645, 4361.698432468129, 4393.121375724868, 4410.823567057282, 4500.077484115748, 4516.187086324428, 3002.1443888492113, 3052.374263276023, 3056.113727019184, 3056.847157642109, 3057.143999680093, 528.8598521391834, 545.5935328180531, 548.3419896124666, 553.8504603757044, 556.0, 527.5094162428901, 548.6845064088166, 555.6166245290817, 629.2009148381529, 639.8336432527576, 8378.958105209435, 8471.49171049739, 8492.320614350838, 8576.785580360542, 8741.562921854009, 490.5781028315646, 517.1957605922826, 519.870032491877, 554.0774610273849, 555.6443875919415, 3718.3492888744363, 3738.626137386294, 3790.65884070435, 3862.9613703863165, 4048.3320252158064, 58650.12024819631, 63762.0435693465, 63830.0, 63959.36040639534, 64056.35943640504, 52536.0, 52731.73634131805, 53169.202461963105, 54821.1776823348, 55093.72453137708, 46603.0, 49498.50501495011, 49819.25271120936, 49949.0010199794, 50230.995380092194, 9097.454152750855, 9247.260219182315, 9423.38747981379, 9462.57418416159, 9510.714678559654, 36274.4558831623, 37049.44425833668, 37315.25369492649, 38188.0, 38414.615853841104, 44488.0, 44612.55387446084, 46262.0, 46715.29927051165, 48488.0, 9818.705438836847, 10224.437655928996, 10827.945860270964, 10969.0, 10976.945115274373, 11273.210875238654, 11583.594574189863, 11588.072954163477, 12244.142909996572, 12737.80893286583, 11115.666530004113, 11259.774804504028, 11486.426036561714, 11750.647480575597, 12078.396080196131, 10797.838032429363, 10878.45607719595, 11135.610253641084, 11522.078233741113, 11850.703732406413, 11365.147613929154, 11378.31730096197, 11403.617843518754, 11750.764984700087, 11916.16586838913, 9992.200623950212, 10014.0, 10036.397816131055, 10349.327293725884, 10385.169186464913, 9298.256139508689, 9460.195883349717, 9725.6596019139, 9797.608095676092, 10387.844182337421], "unit": "score", "name": "yui.html", "value": 6294.291541345922}], "name": "dromaeo_css", "value": 7041.763072259106}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 110.0, 111.0, 111.0, 102.0, 112.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [158.0, 121.0, 146.0, 165.0, 124.0, 153.0, 150.0, 123.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 159.0, 162.0, 161.0, 160.0, 159.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 80.0, 92.0, 73.0, 72.0, 71.0, 95.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 133.0, 93.0, 93.0, 92.0, 137.0, 93.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 57.0, 57.0, 57.0, 58.0, 57.0, 67.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 80.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 91.0, 85.0, 86.0, 85.0, 85.0, 85.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [123.0, 118.0, 118.0, 120.0, 127.0, 122.0, 120.0, 117.0, 136.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [152.0, 154.0, 161.0, 165.0, 153.0, 140.0, 150.0, 158.0, 149.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 68.0, 67.0, 66.0, 67.0, 69.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1501.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "Richards", "value": 213.25938200000004}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1953.125], "unit": "score", "name": "RayTrace", "value": 378.87436799999995}, {"lowerIsBetter": false, "replicates": [754.7169811320755], "unit": "score", "name": "Earley", "value": 883.0634750000003}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [568.1818181818181], "unit": "score", "name": "Splay", "value": 143.42415999999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20144.389276436552}]} 05:22:53 INFO - RETURN: dromaeo_css: 7041.76 05:22:53 INFO - RETURN: kraken: 1501.10 05:22:53 INFO - RETURN: v8_7: 20144.39 05:22:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20144.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7041.76"}}} 05:22:53 INFO - Return code: 0 05:22:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:53 ERROR - # TBPL SUCCESS # 05:22:53 INFO - Running post-action listener: _resource_record_post_action 05:22:53 INFO - Running post-run listener: _resource_record_post_run 05:22:54 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10686464; Write bytes: 453550080; Read time: 4996; Write time: 480344 05:22:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5488640; Read time: 0; Write time: 372 05:22:54 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8790016; Write bytes: 446586880; Read time: 4668; Write time: 479476 05:22:54 INFO - Running post-run listener: _upload_blobber_files 05:22:54 INFO - Blob upload gear active. 05:22:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:22:54 INFO - Copying logs to upload dir... 05:22:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.505616 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-20 05:22:54.226325) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:22:54.230174) ========= 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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009882 build_url: 'https://queue.taskcluster.net/v1/task/jK8elaSDTBOtcVGOJIqDJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:22:54.286463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:22:54.286786) ========= 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=0cff312cb257a7829adc5a5d000001df-1450601947.118510-659884778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:22:54.336206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 05:22:54.336524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 05:22:54.336841) ========= ========= Total master_lag: 0.25 =========