builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1450410279.78 results: success (0) buildid: 20151217173001 builduid: b96c6d39aa53421db69d08b0e202a113 revision: e1ce5b4fa814367b46379641a77f06eabd9348ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.784167) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.784657) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.784955) ========= 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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006279 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.812944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.813278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.859213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.859492) ========= 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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.909711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.910008) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.910365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:39.910640) ========= 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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 19:44:40-- 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% 43.4M=0s 2015-12-17 19:44:40 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.404987 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.341673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.342000) ========= 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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014242 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.391916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.392293) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1ce5b4fa814367b46379641a77f06eabd9348ed --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e1ce5b4fa814367b46379641a77f06eabd9348ed --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 19:44:40,801 truncating revision to first 12 chars 2015-12-17 19:44:40,801 Setting DEBUG logging. 2015-12-17 19:44:40,801 attempt 1/10 2015-12-17 19:44:40,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1ce5b4fa814?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 19:44:41,044 unpacking tar archive at: fx-team-e1ce5b4fa814/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.909808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.910132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.918366) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.918648) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 19:44:40.919081) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-17 19:44:40.919392) ========= /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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:44:41 INFO - MultiFileLogger online at 20151217 19:44:41 in /builds/slave/test-pgo 19:44:41 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 19:44:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:44:41 INFO - {'append_to_log': False, 19:44:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:44:41 INFO - 'blob_upload_branch': 'Fx-Team', 19:44:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:44:41 INFO - 'branch': 'Fx-Team', 19:44:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:41 INFO - 'config_files': ('talos/linux_config.py',), 19:44:41 INFO - 'default_actions': ('clobber', 19:44:41 INFO - 'read-buildbot-config', 19:44:41 INFO - 'download-and-extract', 19:44:41 INFO - 'populate-webroot', 19:44:41 INFO - 'create-virtualenv', 19:44:41 INFO - 'install', 19:44:41 INFO - 'run-tests'), 19:44:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:41 INFO - 'download_minidump_stackwalk': True, 19:44:41 INFO - 'download_symbols': 'ondemand', 19:44:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:44:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:44:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:44:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:44:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:41 INFO - 'installer_path': 'installer.exe', 19:44:41 INFO - 'log_level': 'info', 19:44:41 INFO - 'log_name': 'talos', 19:44:41 INFO - 'log_to_console': True, 19:44:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:44:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:44:41 INFO - 'opt_config_files': (), 19:44:41 INFO - 'pip_index': False, 19:44:41 INFO - 'sps_profile': False, 19:44:41 INFO - 'sps_profile_interval': 0, 19:44:41 INFO - 'suite': 'dromaeojs', 19:44:41 INFO - 'system_bits': '64', 19:44:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:41 INFO - 'title': 'talos-linux64-ix-014', 19:44:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:44:41 INFO - 'use_talos_json': True, 19:44:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:44:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:41 INFO - 'work_dir': 'build'} 19:44:41 INFO - ##### 19:44:41 INFO - ##### Running clobber step. 19:44:41 INFO - ##### 19:44:41 INFO - Running pre-action listener: _resource_record_pre_action 19:44:41 INFO - Running main action method: clobber 19:44:41 INFO - rmtree: /builds/slave/test-pgo/build 19:44:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:44:41 INFO - Running post-action listener: _resource_record_post_action 19:44:41 INFO - ##### 19:44:41 INFO - ##### Running read-buildbot-config step. 19:44:41 INFO - ##### 19:44:41 INFO - Running pre-action listener: _resource_record_pre_action 19:44:41 INFO - Running main action method: read_buildbot_config 19:44:41 INFO - Using buildbot properties: 19:44:41 INFO - { 19:44:41 INFO - "project": "", 19:44:41 INFO - "product": "firefox", 19:44:41 INFO - "script_repo_revision": "production", 19:44:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:44:41 INFO - "repository": "", 19:44:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:44:41 INFO - "buildid": "20151217173001", 19:44:41 INFO - "pgo_build": "True", 19:44:41 INFO - "basedir": "/builds/slave/test-pgo", 19:44:41 INFO - "buildnumber": 842, 19:44:41 INFO - "slavename": "talos-linux64-ix-014", 19:44:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:44:41 INFO - "platform": "ubuntu64_hw", 19:44:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:44:41 INFO - "branch": "fx-team", 19:44:41 INFO - "repo_path": "integration/fx-team", 19:44:41 INFO - "revision": "e1ce5b4fa814367b46379641a77f06eabd9348ed", 19:44:41 INFO - "stage_platform": "linux64-pgo", 19:44:41 INFO - "builduid": "b96c6d39aa53421db69d08b0e202a113", 19:44:41 INFO - "slavebuilddir": "test" 19:44:41 INFO - } 19:44:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:44:41 INFO - Running post-action listener: _resource_record_post_action 19:44:41 INFO - ##### 19:44:41 INFO - ##### Running download-and-extract step. 19:44:41 INFO - ##### 19:44:41 INFO - Running pre-action listener: _resource_record_pre_action 19:44:41 INFO - Running main action method: download_and_extract 19:44:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:41 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json 19:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json 19:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:44:43 INFO - Downloaded 1302 bytes. 19:44:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:44:43 INFO - Using the following test package requirements: 19:44:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:44:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'jsshell-linux-x86_64.zip'], 19:44:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:44:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:44:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:44:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:44:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:44:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:43 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:44:45 INFO - Downloaded 23119750 bytes. 19:44: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 19:44:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44: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 19:44:46 INFO - Return code: 0 19:44:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:46 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:44:52 INFO - Downloaded 23119750 bytes. 19:44:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:44:54 INFO - Return code: 0 19:44: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')]} 19:44:54 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:44:54 INFO - Downloaded 11132039 bytes. 19:44:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:44:55 INFO - Return code: 0 19:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:55 INFO - https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:44:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:44:56 INFO - Downloaded 54645377 bytes. 19:44:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:56 INFO - mkdir: /builds/slave/test-pgo/properties 19:44:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:44:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:44:56 INFO - Contents: 19:44:56 INFO - build_url:https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:56 INFO - Running post-action listener: _resource_record_post_action 19:44:56 INFO - Running post-action listener: set_extra_try_arguments 19:44:56 INFO - ##### 19:44:56 INFO - ##### Running populate-webroot step. 19:44:56 INFO - ##### 19:44:56 INFO - Running pre-action listener: _resource_record_pre_action 19:44:56 INFO - Running main action method: populate_webroot 19:44:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:56 INFO - '--tppagecycles', 19:44:56 INFO - '7'], 19:44:56 INFO - 'tests': ['tsvgm']}}, 19:44:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:44:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'tests': ['damp', 'tps']}, 19:44:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['damp', 'tps']}, 19:44:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:44:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:44:56 INFO - 'other': {'tests': ['a11yr', 19:44:56 INFO - 'ts_paint', 19:44:56 INFO - 'tpaint', 19:44:56 INFO - 'sessionrestore', 19:44:56 INFO - 'sessionrestore_no_auto_restore']}, 19:44:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['a11yr', 19:44:56 INFO - 'ts_paint', 19:44:56 INFO - 'tpaint', 19:44:56 INFO - 'sessionrestore', 19:44:56 INFO - 'sessionrestore_no_auto_restore']}, 19:44:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['a11yr', 19:44:56 INFO - 'ts_paint', 19:44:56 INFO - 'tpaint', 19:44:56 INFO - 'sessionrestore', 19:44:56 INFO - 'sessionrestore_no_auto_restore']}, 19:44:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['a11yr', 19:44:56 INFO - 'ts_paint', 19:44:56 INFO - 'tpaint', 19:44:56 INFO - 'sessionrestore', 19:44:56 INFO - 'sessionrestore_no_auto_restore']}, 19:44:56 INFO - 'other_l64': {'tests': ['a11yr', 19:44:56 INFO - 'ts_paint', 19:44:56 INFO - 'tpaint', 19:44:56 INFO - 'sessionrestore', 19:44:56 INFO - 'sessionrestore_no_auto_restore']}, 19:44:56 INFO - 'other_nol64': {'tests': ['a11yr', 19:44:56 INFO - 'ts_paint', 19:44:56 INFO - 'tpaint', 19:44:56 INFO - 'sessionrestore', 19:44:56 INFO - 'sessionrestore_no_auto_restore']}, 19:44:56 INFO - 'svgr': {'tests': ['tsvgx', 19:44:56 INFO - 'tsvgr_opacity', 19:44:56 INFO - 'tart', 19:44:56 INFO - 'tscrollx', 19:44:56 INFO - 'cart']}, 19:44:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['tsvgx', 19:44:56 INFO - 'tsvgr_opacity', 19:44:56 INFO - 'tart', 19:44:56 INFO - 'tscrollx', 19:44:56 INFO - 'cart']}, 19:44:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'tests': ['tp5o']}, 19:44:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'talos_options': ['--e10s'], 19:44:56 INFO - 'tests': ['tp5o']}, 19:44:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'talos_options': ['--xperf_path', 19:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:56 INFO - 'tests': ['tp5n']}, 19:44:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:56 INFO - 'talos_options': ['--e10s', 19:44:56 INFO - '--xperf_path', 19:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:56 INFO - 'tests': ['tp5n']}}, 19:44:56 INFO - 'talos.zip': {'path': '', 19:44:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:56 INFO - Running post-action listener: _resource_record_post_action 19:44:56 INFO - ##### 19:44:56 INFO - ##### Running create-virtualenv step. 19:44:56 INFO - ##### 19:44:56 INFO - Running pre-action listener: _resource_record_pre_action 19:44:56 INFO - Running main action method: create_virtualenv 19:44:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:44:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:44:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:44:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:56 INFO - Using real prefix '/usr' 19:44:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:44:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:44:59 INFO - Installing pip.................done. 19:44:59 INFO - Return code: 0 19:44:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:59 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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:44:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:44:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:44:59 INFO - Using env: {'DISPLAY': ':0', 19:44:59 INFO - 'HOME': '/home/cltbld', 19:44:59 INFO - 'LANG': 'en_US.UTF-8', 19:44:59 INFO - 'LANGUAGE': 'en_US:en', 19:44:59 INFO - 'LOGNAME': 'cltbld', 19:44:59 INFO - 'MAIL': '/var/mail/cltbld', 19:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:59 INFO - 'MOZ_NO_REMOTE': '1', 19:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:59 INFO - 'NO_EM_RESTART': '1', 19:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:59 INFO - 'SHELL': '/bin/bash', 19:44:59 INFO - 'SHLVL': '1', 19:44:59 INFO - 'TERM': 'linux', 19:44:59 INFO - 'TMOUT': '86400', 19:44:59 INFO - 'USER': 'cltbld', 19:44:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:59 INFO - '_': '/tools/buildbot/bin/python'} 19:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:44:59 INFO - Cleaning up... 19:44:59 INFO - Return code: 0 19:44:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:59 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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:44:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:44:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:44:59 INFO - Using env: {'DISPLAY': ':0', 19:44:59 INFO - 'HOME': '/home/cltbld', 19:44:59 INFO - 'LANG': 'en_US.UTF-8', 19:44:59 INFO - 'LANGUAGE': 'en_US:en', 19:44:59 INFO - 'LOGNAME': 'cltbld', 19:44:59 INFO - 'MAIL': '/var/mail/cltbld', 19:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:59 INFO - 'MOZ_NO_REMOTE': '1', 19:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:59 INFO - 'NO_EM_RESTART': '1', 19:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:59 INFO - 'SHELL': '/bin/bash', 19:44:59 INFO - 'SHLVL': '1', 19:44:59 INFO - 'TERM': 'linux', 19:44:59 INFO - 'TMOUT': '86400', 19:44:59 INFO - 'USER': 'cltbld', 19:44:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:59 INFO - '_': '/tools/buildbot/bin/python'} 19:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:59 INFO - Downloading/unpacking psutil>=0.7.1 19:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:45:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:45:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:01 INFO - Installing collected packages: psutil 19:45:01 INFO - Running setup.py install for psutil 19:45:01 INFO - building 'psutil._psutil_linux' extension 19:45:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:45:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:45:01 INFO - building 'psutil._psutil_posix' extension 19:45:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:45:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:02 INFO - Successfully installed psutil 19:45:02 INFO - Cleaning up... 19:45:02 INFO - Return code: 0 19:45:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:02 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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:45:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:45:02 INFO - Using env: {'DISPLAY': ':0', 19:45:02 INFO - 'HOME': '/home/cltbld', 19:45:02 INFO - 'LANG': 'en_US.UTF-8', 19:45:02 INFO - 'LANGUAGE': 'en_US:en', 19:45:02 INFO - 'LOGNAME': 'cltbld', 19:45:02 INFO - 'MAIL': '/var/mail/cltbld', 19:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:02 INFO - 'MOZ_NO_REMOTE': '1', 19:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:02 INFO - 'NO_EM_RESTART': '1', 19:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:02 INFO - 'SHELL': '/bin/bash', 19:45:02 INFO - 'SHLVL': '1', 19:45:02 INFO - 'TERM': 'linux', 19:45:02 INFO - 'TMOUT': '86400', 19:45:02 INFO - 'USER': 'cltbld', 19:45:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:02 INFO - '_': '/tools/buildbot/bin/python'} 19:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:45:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:45:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:45:04 INFO - Installing collected packages: mozsystemmonitor 19:45:04 INFO - Running setup.py install for mozsystemmonitor 19:45:04 INFO - Successfully installed mozsystemmonitor 19:45:04 INFO - Cleaning up... 19:45:04 INFO - Return code: 0 19:45:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:45:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:45:04 INFO - Using env: {'DISPLAY': ':0', 19:45:04 INFO - 'HOME': '/home/cltbld', 19:45:04 INFO - 'LANG': 'en_US.UTF-8', 19:45:04 INFO - 'LANGUAGE': 'en_US:en', 19:45:04 INFO - 'LOGNAME': 'cltbld', 19:45:04 INFO - 'MAIL': '/var/mail/cltbld', 19:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:04 INFO - 'MOZ_NO_REMOTE': '1', 19:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:04 INFO - 'NO_EM_RESTART': '1', 19:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:04 INFO - 'SHELL': '/bin/bash', 19:45:04 INFO - 'SHLVL': '1', 19:45:04 INFO - 'TERM': 'linux', 19:45:04 INFO - 'TMOUT': '86400', 19:45:04 INFO - 'USER': 'cltbld', 19:45:04 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:04 INFO - '_': '/tools/buildbot/bin/python'} 19:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:04 INFO - Downloading/unpacking blobuploader==1.2.4 19:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:06 INFO - Downloading blobuploader-1.2.4.tar.gz 19:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:45:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:45:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:06 INFO - Downloading docopt-0.6.1.tar.gz 19:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:45:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:45:07 INFO - Running setup.py install for blobuploader 19:45:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:45:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:45:07 INFO - Running setup.py install for requests 19:45:07 INFO - Running setup.py install for docopt 19:45:07 INFO - Successfully installed blobuploader requests docopt 19:45:07 INFO - Cleaning up... 19:45:07 INFO - Return code: 0 19:45:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:45:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:07 INFO - Using env: {'DISPLAY': ':0', 19:45:07 INFO - 'HOME': '/home/cltbld', 19:45:07 INFO - 'LANG': 'en_US.UTF-8', 19:45:07 INFO - 'LANGUAGE': 'en_US:en', 19:45:07 INFO - 'LOGNAME': 'cltbld', 19:45:07 INFO - 'MAIL': '/var/mail/cltbld', 19:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:07 INFO - 'MOZ_NO_REMOTE': '1', 19:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:07 INFO - 'NO_EM_RESTART': '1', 19:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:07 INFO - 'SHELL': '/bin/bash', 19:45:07 INFO - 'SHLVL': '1', 19:45:07 INFO - 'TERM': 'linux', 19:45:07 INFO - 'TMOUT': '86400', 19:45:07 INFO - 'USER': 'cltbld', 19:45:07 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:07 INFO - '_': '/tools/buildbot/bin/python'} 19:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:07 INFO - Running setup.py (path:/tmp/pip-JUEFTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:07 INFO - Running setup.py (path:/tmp/pip-kesl8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:07 INFO - Running setup.py (path:/tmp/pip-EgH1GK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:08 INFO - Running setup.py (path:/tmp/pip-OZkhbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:08 INFO - Running setup.py (path:/tmp/pip-nODhU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:08 INFO - Running setup.py (path:/tmp/pip-lyPdwa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:08 INFO - Running setup.py (path:/tmp/pip-0DCSfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:08 INFO - Running setup.py (path:/tmp/pip-mQ6cT2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:08 INFO - Running setup.py (path:/tmp/pip-gneqxj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:08 INFO - Running setup.py (path:/tmp/pip-_sgY6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:08 INFO - Running setup.py (path:/tmp/pip-uQ_2G_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:08 INFO - Running setup.py (path:/tmp/pip-kLcdQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:08 INFO - Running setup.py (path:/tmp/pip-bCZ3M6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:08 INFO - Running setup.py (path:/tmp/pip-lX2g8p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:08 INFO - Running setup.py (path:/tmp/pip-9knFby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:08 INFO - Running setup.py (path:/tmp/pip-pwcnOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:08 INFO - Running setup.py (path:/tmp/pip-TS8FNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:45:09 INFO - Running setup.py install for manifestparser 19:45:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Running setup.py install for mozcrash 19:45:09 INFO - Running setup.py install for mozdebug 19:45:09 INFO - Running setup.py install for mozdevice 19:45:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Running setup.py install for mozfile 19:45:09 INFO - Running setup.py install for mozhttpd 19:45:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Running setup.py install for mozinfo 19:45:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Running setup.py install for mozInstall 19:45:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:45:09 INFO - Running setup.py install for mozleak 19:45:09 INFO - Running setup.py install for mozlog 19:45:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Running setup.py install for moznetwork 19:45:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Running setup.py install for mozprocess 19:45:10 INFO - Running setup.py install for mozprofile 19:45:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Running setup.py install for mozrunner 19:45:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Running setup.py install for mozscreenshot 19:45:10 INFO - Running setup.py install for moztest 19:45:10 INFO - Running setup.py install for mozversion 19:45:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:45:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:45:10 INFO - Cleaning up... 19:45:10 INFO - Return code: 0 19:45:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:10 INFO - Using env: {'DISPLAY': ':0', 19:45:10 INFO - 'HOME': '/home/cltbld', 19:45:10 INFO - 'LANG': 'en_US.UTF-8', 19:45:10 INFO - 'LANGUAGE': 'en_US:en', 19:45:10 INFO - 'LOGNAME': 'cltbld', 19:45:10 INFO - 'MAIL': '/var/mail/cltbld', 19:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:10 INFO - 'MOZ_NO_REMOTE': '1', 19:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:10 INFO - 'NO_EM_RESTART': '1', 19:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:10 INFO - 'SHELL': '/bin/bash', 19:45:10 INFO - 'SHLVL': '1', 19:45:10 INFO - 'TERM': 'linux', 19:45:10 INFO - 'TMOUT': '86400', 19:45:10 INFO - 'USER': 'cltbld', 19:45:10 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:10 INFO - '_': '/tools/buildbot/bin/python'} 19:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:11 INFO - Running setup.py (path:/tmp/pip-FOidpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:11 INFO - Running setup.py (path:/tmp/pip-9e7rFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:11 INFO - Running setup.py (path:/tmp/pip-_2v4Dc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:11 INFO - Running setup.py (path:/tmp/pip-dqjubB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:11 INFO - Running setup.py (path:/tmp/pip-ZBzfmK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:11 INFO - Running setup.py (path:/tmp/pip-ikF7dG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:11 INFO - Running setup.py (path:/tmp/pip-kNH2l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:11 INFO - Running setup.py (path:/tmp/pip-eOTtiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:11 INFO - Running setup.py (path:/tmp/pip-JTWPqz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:11 INFO - Running setup.py (path:/tmp/pip-8EBLZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:11 INFO - Running setup.py (path:/tmp/pip-4xDVEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:11 INFO - Running setup.py (path:/tmp/pip-i6j3N6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:11 INFO - Running setup.py (path:/tmp/pip-J7PVrX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:11 INFO - Running setup.py (path:/tmp/pip-Fatq6_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:12 INFO - Running setup.py (path:/tmp/pip-dqWx8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:12 INFO - Running setup.py (path:/tmp/pip-0TCL4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:12 INFO - Running setup.py (path:/tmp/pip-w6D18U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:13 INFO - Downloading blessings-1.5.1.tar.gz 19:45:13 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:45:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:45:14 INFO - Installing collected packages: blessings 19:45:14 INFO - Running setup.py install for blessings 19:45:14 INFO - Successfully installed blessings 19:45:14 INFO - Cleaning up... 19:45:14 INFO - Return code: 0 19:45:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:45:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:14 INFO - Reading from file tmpfile_stdout 19:45:14 INFO - Current package versions: 19:45:14 INFO - argparse == 1.2.1 19:45:14 INFO - blessings == 1.5.1 19:45:14 INFO - blobuploader == 1.2.4 19:45:14 INFO - docopt == 0.6.1 19:45:14 INFO - manifestparser == 1.1 19:45:14 INFO - mozInstall == 1.12 19:45:14 INFO - mozcrash == 0.16 19:45:14 INFO - mozdebug == 0.1 19:45:14 INFO - mozdevice == 0.47 19:45:14 INFO - mozfile == 1.2 19:45:14 INFO - mozhttpd == 0.7 19:45:14 INFO - mozinfo == 0.9 19:45:14 INFO - mozleak == 0.1 19:45:14 INFO - mozlog == 3.1 19:45:14 INFO - moznetwork == 0.27 19:45:14 INFO - mozprocess == 0.22 19:45:14 INFO - mozprofile == 0.27 19:45:14 INFO - mozrunner == 6.11 19:45:14 INFO - mozscreenshot == 0.1 19:45:14 INFO - mozsystemmonitor == 0.0 19:45:14 INFO - moztest == 0.7 19:45:14 INFO - mozversion == 1.4 19:45:14 INFO - psutil == 3.1.1 19:45:14 INFO - requests == 1.2.3 19:45:14 INFO - wsgiref == 0.1.2 19:45:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:14 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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:14 INFO - Using env: {'DISPLAY': ':0', 19:45:14 INFO - 'HOME': '/home/cltbld', 19:45:14 INFO - 'LANG': 'en_US.UTF-8', 19:45:14 INFO - 'LANGUAGE': 'en_US:en', 19:45:14 INFO - 'LOGNAME': 'cltbld', 19:45:14 INFO - 'MAIL': '/var/mail/cltbld', 19:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:14 INFO - 'MOZ_NO_REMOTE': '1', 19:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:14 INFO - 'NO_EM_RESTART': '1', 19:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:14 INFO - 'SHELL': '/bin/bash', 19:45:14 INFO - 'SHLVL': '1', 19:45:14 INFO - 'TERM': 'linux', 19:45:14 INFO - 'TMOUT': '86400', 19:45:14 INFO - 'USER': 'cltbld', 19:45:14 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:14 INFO - '_': '/tools/buildbot/bin/python'} 19:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:14 INFO - Cleaning up... 19:45:14 INFO - Return code: 0 19:45:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:14 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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:45:14 INFO - Using env: {'DISPLAY': ':0', 19:45:14 INFO - 'HOME': '/home/cltbld', 19:45:14 INFO - 'LANG': 'en_US.UTF-8', 19:45:14 INFO - 'LANGUAGE': 'en_US:en', 19:45:14 INFO - 'LOGNAME': 'cltbld', 19:45:14 INFO - 'MAIL': '/var/mail/cltbld', 19:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:14 INFO - 'MOZ_NO_REMOTE': '1', 19:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:14 INFO - 'NO_EM_RESTART': '1', 19:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:14 INFO - 'SHELL': '/bin/bash', 19:45:14 INFO - 'SHLVL': '1', 19:45:14 INFO - 'TERM': 'linux', 19:45:14 INFO - 'TMOUT': '86400', 19:45:14 INFO - 'USER': 'cltbld', 19:45:14 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:14 INFO - '_': '/tools/buildbot/bin/python'} 19:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:14 INFO - Downloading/unpacking jsonschema 19:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:45:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:45:16 INFO - Downloading/unpacking functools32 (from jsonschema) 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:45:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:45:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:45:16 INFO - warning: no files found matching '*.txt' 19:45:16 INFO - no previously-included directories found matching 'build' 19:45:16 INFO - no previously-included directories found matching 'dist' 19:45:16 INFO - no previously-included directories found matching '.git*' 19:45:16 INFO - Installing collected packages: jsonschema, functools32 19:45:16 INFO - Running setup.py install for functools32 19:45:16 INFO - warning: no files found matching '*.txt' 19:45:16 INFO - no previously-included directories found matching 'build' 19:45:16 INFO - no previously-included directories found matching 'dist' 19:45:16 INFO - no previously-included directories found matching '.git*' 19:45:16 INFO - Successfully installed jsonschema functools32 19:45:16 INFO - Cleaning up... 19:45:16 INFO - Return code: 0 19:45:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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 0x7f4ad627cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, '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': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:45: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 19:45: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 19:45:16 INFO - Using env: {'DISPLAY': ':0', 19:45:16 INFO - 'HOME': '/home/cltbld', 19:45:16 INFO - 'LANG': 'en_US.UTF-8', 19:45:16 INFO - 'LANGUAGE': 'en_US:en', 19:45:16 INFO - 'LOGNAME': 'cltbld', 19:45:16 INFO - 'MAIL': '/var/mail/cltbld', 19:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:16 INFO - 'MOZ_NO_REMOTE': '1', 19:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:16 INFO - 'NO_EM_RESTART': '1', 19:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:16 INFO - 'SHELL': '/bin/bash', 19:45:16 INFO - 'SHLVL': '1', 19:45:16 INFO - 'TERM': 'linux', 19:45:16 INFO - 'TMOUT': '86400', 19:45:16 INFO - 'USER': 'cltbld', 19:45:16 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:16 INFO - '_': '/tools/buildbot/bin/python'} 19:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:17 INFO - Downloading/unpacking flake8 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:45:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:45:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:45:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:45:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:45:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:45:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:19 INFO - no previously-included directories found matching 'docs/_build' 19:45:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:45:19 INFO - Running setup.py install for pep8 19:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:19 INFO - no previously-included directories found matching 'docs/_build' 19:45:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:45:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:45:19 INFO - Cleaning up... 19:45:19 INFO - Return code: 0 19:45:19 INFO - Running post-action listener: _resource_record_post_action 19:45:19 INFO - Running post-action listener: _start_resource_monitoring 19:45:19 INFO - Starting resource monitoring. 19:45:19 INFO - ##### 19:45:19 INFO - ##### Running install step. 19:45:19 INFO - ##### 19:45:19 INFO - Running pre-action listener: _resource_record_pre_action 19:45:19 INFO - Running main action method: install 19:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:19 INFO - Reading from file tmpfile_stdout 19:45:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:45:20 INFO - Reading from file tmpfile_stdout 19:45:20 INFO - Output received: 19:45:20 INFO - Usage: mozinstall [options] installer 19:45:20 INFO - Options: 19:45:20 INFO - -h, --help show this help message and exit 19:45:20 INFO - -d DEST, --destination=DEST 19:45:20 INFO - Directory to install application into. [default: 19:45:20 INFO - "/builds/slave/test-pgo"] 19:45:20 INFO - --app=APP Application being installed. [default: firefox] 19:45:20 INFO - mkdir: /builds/slave/test-pgo/build/application 19:45:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:45:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:45:35 INFO - Reading from file tmpfile_stdout 19:45:35 INFO - Output received: 19:45:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:45:35 INFO - Running post-action listener: _resource_record_post_action 19:45:35 INFO - ##### 19:45:35 INFO - ##### Running run-tests step. 19:45:35 INFO - ##### 19:45:35 INFO - Running pre-action listener: _resource_record_pre_action 19:45:35 INFO - Running main action method: run_tests 19:45:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:45:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:45:35 INFO - Python 2.7.3 19:45:35 INFO - Return code: 0 19:45:35 INFO - grabbing minidump binary from tooltool 19:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:35 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 0x13ad350>, '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 0x13ae250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ae6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:45:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:45:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:45:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:45:35 INFO - Return code: 0 19:45:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:45:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:45:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:45:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:45:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:45:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:45:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:45:36 INFO - Return code: 0 19:45: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/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:45: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/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 19:45:36 INFO - Using env: {'DISPLAY': ':0', 19:45:36 INFO - 'HOME': '/home/cltbld', 19:45:36 INFO - 'LANG': 'en_US.UTF-8', 19:45:36 INFO - 'LANGUAGE': 'en_US:en', 19:45:36 INFO - 'LOGNAME': 'cltbld', 19:45:36 INFO - 'MAIL': '/var/mail/cltbld', 19:45:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:45:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:36 INFO - 'MOZ_NO_REMOTE': '1', 19:45:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:36 INFO - 'NO_EM_RESTART': '1', 19:45:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:45:36 INFO - 'SHELL': '/bin/bash', 19:45:36 INFO - 'SHLVL': '1', 19:45:36 INFO - 'TERM': 'linux', 19:45:36 INFO - 'TMOUT': '86400', 19:45:36 INFO - 'USER': 'cltbld', 19:45:36 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214', 19:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:36 INFO - '_': '/tools/buildbot/bin/python'} 19:45: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/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 19:45:37 INFO - mozversion INFO | application_buildid: 20151217173001 19:45:37 INFO - mozversion INFO | application_changeset: e1ce5b4fa814367b46379641a77f06eabd9348ed 19:45:37 INFO - mozversion INFO | application_display_name: Nightly 19:45:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:45:37 INFO - mozversion INFO | application_name: Firefox 19:45:37 INFO - mozversion INFO | application_remotingname: firefox 19:45:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:45:37 INFO - mozversion INFO | application_vendor: Mozilla 19:45:37 INFO - mozversion INFO | application_version: 46.0a1 19:45:37 INFO - mozversion INFO | platform_buildid: 20151217173001 19:45:37 INFO - mozversion INFO | platform_changeset: e1ce5b4fa814367b46379641a77f06eabd9348ed 19:45:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:45:37 INFO - mozversion INFO | platform_version: 46.0a1 19:45:37 INFO - 2015-12-17 19:45:37,011 DEBUG : using testdate: 1450410337 19:45:37 INFO - 2015-12-17 19:45:37,011 DEBUG : actual date: 1450410337 19:45:37 INFO - 2015-12-17 19:45:37,105 INFO : starting webserver on 'localhost:46365' 19:45:37 INFO - 2015-12-17 19:45:37,106 INFO : Starting test suite talos-linux64-ix-014 19:45:37 INFO - 2015-12-17 19:45:37,106 INFO : Starting test dromaeo_css 19:45:37 INFO - 2015-12-17 19:45:37,106 DEBUG : operating with platform_type : linux_ 19:45:37 INFO - 2015-12-17 19:45:37,107 INFO : Initialising browser for dromaeo_css test... 19:45:37 INFO - 2015-12-17 19:45:37,120 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppNrkYU/profile http://localhost:46365/getInfo.html 19:45:41 INFO - 2015-12-17 19:45:41,047 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:45:41 INFO - 2015-12-17 19:45:41,047 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:45:41 INFO - 2015-12-17 19:45:41,047 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:45:41 INFO - 2015-12-17 19:45:41,047 DEBUG : BROWSER_OUTPUT: __metrics 19:45:41 INFO - 2015-12-17 19:45:41,148 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:45:41 INFO - 2015-12-17 19:45:41,204 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] 19:45:42 INFO - 2015-12-17 19:45:42,389 INFO : Browser initialized. 19:45:42 INFO - 2015-12-17 19:45:42,389 INFO : Running cycle 1/1 for dromaeo_css test... 19:45:42 INFO - 2015-12-17 19:45:42,390 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppNrkYU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:45:54 INFO - 2015-12-17 19:45:54,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 149667840 19:45:54 INFO - 2015-12-17 19:45:54,151 DEBUG : BROWSER_OUTPUT: 19:46:45 INFO - 2015-12-17 19:46:45,394 DEBUG : BROWSER_OUTPUT: 1450410405392 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:48:53 INFO - 2015-12-17 19:48:53,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46365/tests/dromaeo/cssquery-ext.html) 19:48:55 INFO - 2015-12-17 19:48:55,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 290549760 19:48:55 INFO - 2015-12-17 19:48:55,177 DEBUG : BROWSER_OUTPUT: 19:51:57 INFO - 2015-12-17 19:51:57,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/dromaeo/cssquery-ext.html (next: http://localhost:46365/tests/dromaeo/cssquery-jquery.html) 19:51:58 INFO - 2015-12-17 19:51:58,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 243568640 19:51:58 INFO - 2015-12-17 19:51:58,226 DEBUG : BROWSER_OUTPUT: 19:55:00 INFO - 2015-12-17 19:55:00,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46365/tests/dromaeo/cssquery-mootools.html) 19:55:00 INFO - 2015-12-17 19:55:00,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 236052480 19:55:00 INFO - 2015-12-17 19:55:00,750 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-12-17 19:58:02,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46365/tests/dromaeo/cssquery-prototype.html) 19:58:03 INFO - 2015-12-17 19:58:03,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 214634496 19:58:03 INFO - 2015-12-17 19:58:03,128 DEBUG : BROWSER_OUTPUT: 20:01:05 INFO - 2015-12-17 20:01:05,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46365/tests/dromaeo/cssquery-yui.html) 20:01:06 INFO - 2015-12-17 20:01:06,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 214822912 20:01:06 INFO - 2015-12-17 20:01:06,201 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2015-12-17 20:04:08,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/dromaeo/cssquery-yui.html (next: http://localhost:46365/tests/dromaeo/cssquery-dojo.html) 20:04:08 INFO - 2015-12-17 20:04:08,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 257765376 20:04:08 INFO - 2015-12-17 20:04:08,996 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2015-12-17 20:04:08,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:04:08 INFO - 2015-12-17 20:04:08,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:04:08 INFO - 2015-12-17 20:04:08,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:04:08 INFO - 2015-12-17 20:04:08,997 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:04:08 INFO - 2015-12-17 20:04:08,997 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3066.9539956900644;3125.109343837004;3162;3163.1143279881626;3192.2976945072082;5063.392392912856;5213.400458947222;5222.738863056847;5254.448282930294;5299.920501192485;5133.3326667533165;5200.6099542534275;5202.0376230397405;5220.086484865143;5273.604479664022;4792.880177995552;4815;4827.517248275162;4845.37010188675;4887.839315402934;4803.327534145223;4853.126437241295;4857.10143623429;4890.535399137077;4897.265410188483;4641.141388843075;4685.882852928704;4742.2886567014875;4792.065547218293;4799.904001919959;4736.64475164364;4742.928856067162;4743.335932969387;4751.216049351853;4754.66717329787;4762.261849413347;4764;4766.666333356667;4773.260144677581;4783.784729687172;4864.805407783684;4979.900401991976;4987.925181122286;5004.374453193351;5011.32347133136;5582.63712858667;5583.8883222335735;5589.860253493654;5590.301212348457;5593.748281327309;5372.704501252469;5528.944710552883;5615.550755939515;5620.522255608278;5670.121131224667;5176.275321454999;5253.159494480865;5264.131418315935;5269.130593452114;5309.681419114827;5606.915896261559;5636.971815140898;5642;5649.322081350264;5652.943470565242;5251.973740131351;5347.759350829222;5349.090654588729;5470.152126420411;5489.780408783604;5360.142377219626;5447;5448.972755136199;5450.209719590637;5473.261109750212;5577.470140336662;5594.356648985337;5596.188552659842;5599.720013999284;5603.495685388253;5211.1922651989;5314.787408503694;5321.308229930084;5591.832245032656;5646.97176514123;4198.727082739673;4280.764557949343;4289.227938971015;4319.33050377192;4323.113761678848;3810.8475660973804;3818.809059547067;3839.9616003840165;3846.942295865564;3851.017990412427;5146.742662866842;5258.526732594085;5261.973690131525;5289.285946397187;5340.91988620171;5498.972505137449;5560.499555040065;5668.716564171775;5674.092145256739;5699.08814589672;5222.556082732935;5231.189165679326;5231.738413079331;5232.3721153461065;5238.449962753933;4559.6808223424705;4620.561046700558;4701.247800351927;4704.458987216514;4734.4081989751285;5619.43805619443;5654.236678048493;5691.772329106872;5713.057345538023;5764.913526297109;5592;5592.496675299242;5593.161025846156;5598.888022239614;5600.943990560042;5464.3442786865835;5574.86062848432;5733.569982251432;5739.196512488338;5745.827625171251;5467.07059799843;5477.863053423696;5481.095619222783;5517.200005999188;5528.695921724344;5492.258545096521;5541.113421852484;5542.5565954722715;5554.75003624846;5558.388577256418;5254.13306804373;5352.9732351338;5354.571634269327;5423.6783320923305;5467.781288748405;5319.707416091997;5388.326459192601;5388.946110538845;5392.460753924733;5392.676439413648;5358.22305765654;5372.355317361786;5372.838814835562;5373.220882972026;5374.220737993047;5246.213068039825;5356.384015838228;5370.892582148414;5378.408375078817;5386.299781028441;5338.279332290091;5355.491228333302;5371.382291036581;5376.139817629317;5395.217693434509 20:04:09 INFO - 2015-12-17 20:04:08,997 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.8872225554888;567.7615401531358;588.2764200033959;605.5730709849556;609.3753902250196;28027.579586306223;37655.4351684725;38041.42937855931;38129.61870381295;38190.61809381905;40621.59378406215;41258.38112428316;41265.38101928466;41371.79314103425;41407.79296103523;7604.6577903994175;7699.26856948589;8741.69404070856;8941.552922353889;8944.01615822259;10388.688339349794;10675.19936004799;10731.678049658523;10733.677989660322;10745.08666763326;10312.639057632985;10410.375377477376;10416.791664166713;10418.062374386303;10420.791584168312;7792.922070779305;7950.284474397332;10333.689989300334;10479.214058945534;10733.83899241512;10271.845922311171;10404.063634272876;10408.583656653725;10413.5834566618;10425.113865321457;39045.21909561821;39618.20763584741;39629.207415851524;39629.40555891664;39648;3185.2036990752313;3236;3242.643309235982;3263.102646772133;3293.670632936711;29990.100296990906;30093;30264.69735302663;30748;31187.532187017212;3907.179492306619;3911.3741801311653;3978.0850404407147;4000.399940008993;4044;267212;267805;268491;269316;270574;56752.71623641856;57354.426455735746;57371.71314143486;57378.7131064342;57382.7130864343;56542;58376.708116459144;64859.351406486276;66268.6686566564;66280.6685966567;14073.507427239998;14112.85887141136;14118.788218176736;14200.64498387528;14242.14547127155;9856;9888.357256778287;9929.553170107363;9938.304318697621;9958.551865166084;18775.34286299973;18947;19029.904850475657;19056.809431905782;19091.80908190928;7196.856062878713;7449.2923172299625;7482.1021477423055;7490.775276741707;7567.432442566829;974.7222041718077;1041.3075304922293;1059.7774467361787;1077.9059254856327;1086.7935092332432;28286.85856570745;28352.85823570869;28553;28762.568561471595;29027.564586530796;1021.3055122516612;1026.2764750850633;1030.9793804124026;1064.590132798878;1064.6752740414092;13315.334233288491;13444.260565668983;13594.93202533981;13632.113912595649;13634.590962271148;308243;313668;314213;314599;314871;48739;48743.75628121837;48932.7553362238;48933.266001010015;48987.75506122447;1340.1757918880014;1349.291621898511;1351.63505853421;1357.1585616917378;1364.270115488209;23348.416289592897;25351.492970140123;26649.467010660064;26732;27556.311092222855;40830;40860;40924.79537602293;41227.58772412237;41316.1736765269;200331;201061;202916;203094;203507;26869.193924182306;27422.45155096927;29226;30628;30658.693413065583;36990.815045924595;37137.814310928276;37200.81399593093;37731;38188.2362352757;34066.31867362688;34286;35013;35075.82462087673;35736;29580.260493487836;29833.85083074571;30036.399272014874;30039.399212016073;30188.69811301859;32730;34852.65147348595;35957.820210898775;36131.458028130124;36189;27064.72935270622;28882.566761499016;29239.269018274714;29418.411631766816;29833.70166298396;24020.279391618278;24506.387340316636;24600.384990375383;24605.38486537851;24904 20:04:09 INFO - 2015-12-17 20:04:08,999 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.7212160575552;365.3879751416377;365.64897698209717;366.4503245132301;371.03715857350164;13849;14195.077319974194;16273.267702953366;17376.131193440324;17695.823041769578;13063.73872522549;15442.227888605554;15792.526224213263;15820.367185312574;15850.445234416798;5346.759395827187;5442.6462279951675;5471.124620060791;5472.753726082336;5472.945270547303;3946.3883098119836;4049.311617025113;5333.4399888011585;5494.780208791643;5853.765849366042;6066.454019138277;6079.331273559905;6093.451589356957;6130.754769809202;6131.570790044699;5921.111833225008;6042.184305118797;6043.153958445821;6048.092786082079;6069.757209711606;5257.974694934489;5312.309399778004;5313.335833020872;5323.22813192085;5334.813281535166;20891.37325880226;20923.372298830905;21089.261875834272;21240.362789116352;21315.742414909855;2260.5930932432157;2336.9298921032396;2343.8828058597;2351.318117745852;2440.926772196819;13003.349832508431;13245.47018119274;13319.334033298297;13337.19976801395;13733.656658583515;1839;1848.2976468941852;1851;1868.9532761681066;1872.7378167056622;56120;58126.41873581252;58478.70760646212;58732.41267587312;58784.11823822689;9526.476043817518;9735.367201131903;9918.950405248072;9919.752006199902;9981.550830212658;12812;12929.482820687068;12934.805977910151;12947.223166610034;12956.093073484953;6983.079653095338;7095.432365410755;7109.004739336497;7139.107611548557;7181.461390395742;6844.28135045823;6863.828404289833;6886;6888.793336199822;6917.965410172917;5918.763249470059;5969.582129250911;5997;6021.066734656135;6026.367231440723;1696.550414140254;1726.4993151985784;1761.8238176182278;1777.8933264004202;1789.6778579855752;446.01653354353573;449.42249209765293;949.4770923753719;988.7528117970363;1078.7357097511003;9808.21534277256;10609.893901061045;10799.298045627167;10961.287516311573;11006.889931100586;455.26702009764256;887.3477993674644;941.9529023548795;947.1049857884233;1010.0101900137906;7884.211578842184;9023.014936713913;9110.088991100969;9172.527085308206;9196.12636799503;464351;467966;508154;515796;525103;73407.63296183485;76763.61618191985;78003.60998194973;78506.60746696344;78587;1181.716388066875;1184.040926849255;1189.9464524096436;1191.9414393988484;1205.4153735438306;15238.466653667068;15292.541223763305;15300.464483743015;15429.685547168014;15558.688826223639;34831.65168348284;35084.824575876955;35595.64404355923;36001.81999089988;37127;47702;48018.75990620025;49253.75373123112;50851.49148508615;50924;9102.681406150752;9211.170994610517;9232.95383523078;9317.953410232905;9355.672551460666;14693.853061469676;17333.133343333036;17535.123243838014;17665.38171164003;17674.646507070043;14293.499727509487;14417.279136042946;14572.85427145715;14711.043782154125;14894.957352985188;14053;14150.716985660023;14522.128672279698;14698.779518307449;14853.777193341892;14645.853541464876;14693;14885.85114148888;14911.105333680014;15215.283888383698;9287.767805804639;9326.160645541662;9507.096825801538;9529.52352382392;9604.471754053595;14319.57041288763;14446.205458699453;14482.855171448573;14766.557003289918;15104.169270689777 20:04:09 INFO - 2015-12-17 20:04:09,000 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1302.941367638456;1714.451375559821;1749.8775085743996;1778.3509019207993;1779.5817982774042;6487;6914.412274956629;7072.717091316347;7073.893891591618;7079.64601769912;7138.6430678465995;7314.634268286578;7316;7318.7438439654625;7318.96340518298;1881.5390229393818;1912.416712902564;1914.63621911837;2161.059938926568;2201.0645475672854;2182.508935489518;2217.5121473275935;2218.7559368469456;2220.3006053093304;2221.3558068160214;2089.4358523198725;2100.674395468697;2192.2655910270078;2195.220696652689;2195.484061245606;2159.88120653364;2179.3135162423864;2189.2009416563;2205.162038425396;2205.900734466945;2196.8132708719777;2216.9778302216932;2217.7449593296815;2218.6450167973207;2220.04538048639;7165.247648996885;7218.314260145278;7243.5653860768525;7246.71013159473;7254.709811607529;4365.476142862845;4398.64810815134;4450.933236001462;4453.042595841877;4460.732356058615;2919.8832046718107;3011.2471882029495;3023.576699262105;3025.6520500142547;3033.059751477027;1020.1736593359402;1034.1571619130384;1047.36634336227;1058.5659879449388;1085.1969542538543;9647.855282170773;9768.07203315684;9785.608575656965;9787.706368808947;9802.166815820592;3826.445165450994;3841.250956063541;3900.2589507993957;3955.9011024724036;3965.147493288957;8445.408821382567;8450.366222533212;8453.450525715809;8455.196756308142;8475.406721529434;4390.978045109818;4391.5827996340295;4393.450818647669;4413.1394378095965;4432.268675668479;4029.6776257899296;4030.1133750574827;4032.334664780278;4032.737872038308;4034.576369481221;3087.830169340663;3142.3715256948703;3392.8642854286045;3462.1690794209208;3556.324298383299;1127.22784892349;1132.17351333527;1135.937523436219;1139.174098778379;1141.1156353825686;1047.4134484688598;1061.177587369779;1062.2670357453333;1188.2514016169757;1305.7584346895856;6735.528513004043;6790.083338749305;6914.274001229798;6916.135483064617;6916.1700595927805;1119.6025410978984;1125.9774804503863;1126.4705588373452;1129.683688567186;1137.2721458266717;5310.309659744285;5401.108817045144;5419.674819510842;5422.810201642924;5429.647072940246;7831.725889593837;7955.323797477279;8052.516848989079;8514.531700756394;8780.912190878138;7995.200479952075;8042.67829286822;8065.274125328749;8075.717349892843;8079.111297757242;6766.424853887376;6792.184937807495;6892.620905850226;6951.957206419078;6972.511924165361;6736.124303840469;6778.559393639398;6810.5913645181445;6812.591244525344;6816.216135144522;7501.88747168782;7624.428167887319;7749.690012399667;7765.61171941412;7837.725679601187;7851.2148785121035;7953.8409231816195;8028.237317454832;8191.754247372588;8200.876986845322;6398.264199616918;6402.583832051088;6445.70994305248;6449.161608990801;6465.062565928009;6893.310668933066;7078.752243671653;7096.964515177598;7102.573845569283;7104.147502299757;6576.112224849584;6634.402903738686;6667.599944003376;6741.629210393476;6803.89794153098;6509.414152726277;6555.639439830665;6574.671266436755;6678.332166783282;6729.259781423942;6623.569467984758;6651.634160121046;6666.133402657623;6668.899966500603;6672.766453174116;5655.688937108334;5819.6508209507565;6107.511399087974;6146.293176284606;6152.907706384318;6108.11432342299;6143;6159;6165.290991536031;6167.167432396569 20:04:09 INFO - 2015-12-17 20:04:09,001 DEBUG : BROWSER_OUTPUT: |4;prototype.html;334.3396791337109;337.71294399760205;339.60266488208794;342.8611412377987;346.4076429305887;5801.883962320751;5880.882382352351;5945.108233764932;5961.970190149049;6001.48987336077;5762.855928601787;5862.706864656771;5880.6765627890445;5893.057110862263;5912.054071348585;4575.954240457603;4577.130345234395;4580.656450766189;4584.5644663756975;4586.3579098926175;4370.060437006043;4460.4647442306805;4476.507584165739;4552.567506086916;4599.563041511051;4503.279475283955;4505.707129036618;4514.548545145492;4526.366308716782;4550.294704320819;4472.373867658531;4546.727196368212;4549.317602359656;4551.385562948993;4554.089182163548;4027.2750904837117;4028.315186418316;4028.3756017817286;4029.4560234368278;4039.252738243405;5523.530499907512;5639.774409023634;5648.406917273709;5658.349289831681;5706.429357064302;5299.8410047698635;5324.201369794523;5327.334083239595;5329.360476742777;5331.520163185293;5973.6415815050805;6262.718177682015;6276.5292603054495;6282;6289.842753931142;4291.806868690916;4413.735175889425;4414.690971631955;4469.664775141845;4471.642268618535;6373.5857169283845;6478.060681201199;6480.092787009822;6483.092367068614;6484.383983521558;4544.659150563721;4584.564466375689;4589.449266088091;4590.747508887043;4591.334256532784;4547.067851090518;4636.142313671981;4644.628429725613;4651.069786042805;4652.604528615038;5288.629795914326;5289.233061206103;5289.973550132225;5290.867728306823;5301.469853014668;6278.089676996901;6284;6285.214348206474;6286.245650521875;6291.937080629135;1630.3641579783894;1645.19385501106;1645.2596331650566;1647.8681705463534;1647.9176041197893;1101.5758932810925;1120.8879112088725;1123.4270522033821;1123.752774389633;1144.3019757947645;6056;6061.7575296987625;6062.120992456069;6063.575549711478;6069.089636554464;6487.091807147003;6491.740330386731;6499.902501462388;6501.804945851537;6503.28463868974;5905.379935106838;6049.637021778707;6053;6053.152558641794;6054.122152287893;3518.1908161123083;3536.4341705327024;3541.256336169382;3541.7520773545602;3543.8228088595465;6620.503462240351;6625.105610742585;6631.469482441393;6637.668116594151;6638.369354911372;6481.675916204171;6602.801915942529;6611.33886611335;6617.834554136089;6620.106285651472;6608.669566521655;6613.041109039163;6619.966900165468;6628.635425051572;6631.204255489276;6334;6443.323451037573;6494.512911531559;6495.772647957298;6496.447801936699;6333.20834895638;6449.032645103084;6472.417482426604;6481.805545833632;6483.222013358239;6657.234418041793;6678.899816502659;6686.0973768540625;6686.29793871656;6687.699053542699;4540.545945405565;4630.398048253705;4630.652701047367;4632.953670463387;4641.466231383434;6529.771457998947;6531.052997315458;6532.510061745483;6536.967315163393;6539.607623542603;6274.968625156845;6348.396902294275;6368.968155159195;6375.426211640789;6381;6200.0699895016105;6338.556301058881;6353.237611486651;6353.3011368748475;6358.332375100548;6227.408396202353;6231.626102433868;6232;6236.563440559299;6238.407351301619;6357.396047375492;6379.553431259767;6382.457491113308;6387;6391.776287829904;6107.54193435503;6228.968855155696;6232.5637205397;6247.31279559239;6277.027060805583 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: |5;yui.html;694.3334398976982;732.2860211293986;822.1039067416515;831.3889291370841;843.6794018273056;13473.663158421032;13893;13908.095973761698;13924.930375348134;13926.373313200906;11799.882001179985;11815.172937894351;11873.406329683525;12224.08319376046;12975.870241297584;690.1235431002624;698.1238545625233;816.4856140631409;827;831.6881169561415;826.277007618334;836.7489753074084;837.2841220756258;843.3548335523329;844.8352571248608;869.395769939892;878.7407714724171;879.0550158579521;879.6261588824756;879.7140929198005;715.8067321823105;726.3100054947794;841.7769291137853;855.4995327733284;862.1335557764406;627.9905801412982;629.4869681209799;631.2771876201723;631.3055638797332;631.4159402552621;13465.259410732406;13667.521636742766;13681.384337704827;13694.726105477934;13706.246156461391;11664.708382290426;12036.759264814742;12077.637670869888;12256.387180640932;12570.434330455151;9872.60509579616;10029.849552256723;10045.79908401828;10296.691099267035;10315.742106447324;3515.753897227195;3524.488949102366;3565.3047655707146;3579.961811074785;3672.026912868092;44760.55239447596;45161.32258016132;45177.77411112956;45192.322115168296;45197.774011130066;9799.657012004545;9908.20734341251;10059.39643621385;10099.798004040025;10146.898531014744;17651.117444127744;17952.102394880203;17972.55068623295;17999.910000449912;18003.909980450277;7605.809854753676;7805.648745806452;7871.252231038156;7953.801154971172;8010;4142.875713728533;4153.958460415418;4174.165166966619;4184.330507118846;4233.1322078973735;2802.1173330400857;2838.120182743356;2849.244950088228;2851.6720577133897;2855.628768260113;508.23003150227436;528.5111272073317;532.3079996005255;533.2561077297149;537.6370949609077;497.8158081509792;517.9559737422361;593.7268856326052;624.0670198053848;647.899575565788;8159.95920020408;8257.256846883689;8295.668173273001;8334.70828521011;8453;607.2197226563844;608.9482393996472;622.5082185073832;631.9778807741707;646.6249575246346;3814.9809250953567;3856.402257650069;3875.0823195036432;3884.5726970033274;3917.804109794499;56589.434105658416;57329;57915.42084579184;58381.70809145927;58459.70770146122;50459;51500.227496587584;51722.48277517177;51783.48216517787;51802.48197518052;44291.55708442939;44453.77773111178;44624.77687611606;46853;47032.12098487689;7506.662200200894;7746.728864489716;7785.883211751715;7857.528548287121;8021.197880211932;35389.29221415506;36092.63907360998;36109;36826.447603285436;36893.81553092218;42277.78861105675;42282.57717422787;44885.551144488134;45102.54897450984;45727.314090288004;9658.613655453702;9707.501703463195;9800.558974846006;10130.08829205375;10191.84712229332;10316.719618744917;10442.269041167045;10465.215108866712;10469.842952355873;10581.62964296246;10076.848847267443;10205.84691229647;10244.53899574506;10386.065254127165;10639.89360106389;9379.437233765995;9410.57652405657;9470.100340467645;9478.668246611336;9494.525273736424;7513.416815742413;10477;10997.560097596006;11130.387828669178;11494.770104598028;9059.411138275991;9096.950527898873;9211.815763684555;9392.107749763762;9725.659601914182;8987.550622468982;9250.676226332045;9329.860052099088;9464.133092166712;9523.619055237712 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1433 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: __startTimestamp1450411448993__endTimestamp 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5152.49 Median:5340.92 stddev:554.11 (10.4%) stddev-sans-first:531.11 20:04:09 INFO - 2015-12-17 20:04:09,005 DEBUG : BROWSER_OUTPUT: Values: 3067.0 3125.1 3162.0 3163.1 3192.3 5063.4 5213.4 5222.7 5254.4 5299.9 5133.3 5200.6 5202.0 5220.1 5273.6 4792.9 4815.0 4827.5 4845.4 4887.8 4803.3 4853.1 4857.1 4890.5 4897.3 4641.1 4685.9 4742.3 4792.1 4799.9 4736.6 4742.9 4743.3 4751.2 4754.7 4762.3 4764.0 4766.7 4773.3 4783.8 4864.8 4979.9 4987.9 5004.4 5011.3 5582.6 5583.9 5589.9 5590.3 5593.7 5372.7 5528.9 5615.6 5620.5 5670.1 5176.3 5253.2 5264.1 5269.1 5309.7 5606.9 5637.0 5642.0 5649.3 5652.9 5252.0 5347.8 5349.1 5470.2 5489.8 5360.1 5447.0 5449.0 5450.2 5473.3 5577.5 5594.4 5596.2 5599.7 5603.5 5211.2 5314.8 5321.3 5591.8 5647.0 4198.7 4280.8 4289.2 4319.3 4323.1 3810.8 3818.8 3840.0 3846.9 3851.0 5146.7 5258.5 5262.0 5289.3 5340.9 5499.0 5560.5 5668.7 5674.1 5699.1 5222.6 5231.2 5231.7 5232.4 5238.4 4559.7 4620.6 4701.2 4704.5 4734.4 5619.4 5654.2 5691.8 5713.1 5764.9 5592.0 5592.5 5593.2 5598.9 5600.9 5464.3 5574.9 5733.6 5739.2 5745.8 5467.1 5477.9 5481.1 5517.2 5528.7 5492.3 5541.1 5542.6 5554.8 5558.4 5254.1 5353.0 5354.6 5423.7 5467.8 5319.7 5388.3 5388.9 5392.5 5392.7 5358.2 5372.4 5372.8 5373.2 5374.2 5246.2 5356.4 5370.9 5378.4 5386.3 5338.3 5355.5 5371.4 5376.1 5395.2 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42766.02 Median:30703.35 stddev:69311.17 (225.7%) stddev-sans-first:69433.17 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: Values: 563.9 567.8 588.3 605.6 609.4 28027.6 37655.4 38041.4 38129.6 38190.6 40621.6 41258.4 41265.4 41371.8 41407.8 7604.7 7699.3 8741.7 8941.6 8944.0 10388.7 10675.2 10731.7 10733.7 10745.1 10312.6 10410.4 10416.8 10418.1 10420.8 7792.9 7950.3 10333.7 10479.2 10733.8 10271.8 10404.1 10408.6 10413.6 10425.1 39045.2 39618.2 39629.2 39629.4 39648.0 3185.2 3236.0 3242.6 3263.1 3293.7 29990.1 30093.0 30264.7 30748.0 31187.5 3907.2 3911.4 3978.1 4000.4 4044.0 267212.0 267805.0 268491.0 269316.0 270574.0 56752.7 57354.4 57371.7 57378.7 57382.7 56542.0 58376.7 64859.4 66268.7 66280.7 14073.5 14112.9 14118.8 14200.6 14242.1 9856.0 9888.4 9929.6 9938.3 9958.6 18775.3 18947.0 19029.9 19056.8 19091.8 7196.9 7449.3 7482.1 7490.8 7567.4 974.7 1041.3 1059.8 1077.9 1086.8 28286.9 28352.9 28553.0 28762.6 29027.6 1021.3 1026.3 1031.0 1064.6 1064.7 13315.3 13444.3 13594.9 13632.1 13634.6 308243.0 313668.0 314213.0 314599.0 314871.0 48739.0 48743.8 48932.8 48933.3 48987.8 1340.2 1349.3 1351.6 1357.2 1364.3 23348.4 25351.5 26649.5 26732.0 27556.3 40830.0 40860.0 40924.8 41227.6 41316.2 200331.0 201061.0 202916.0 203094.0 203507.0 26869.2 27422.5 29226.0 30628.0 30658.7 36990.8 37137.8 37200.8 37731.0 38188.2 34066.3 34286.0 35013.0 35075.8 35736.0 29580.3 29833.9 30036.4 30039.4 30188.7 32730.0 34852.7 35957.8 36131.5 36189.0 27064.7 28882.6 29239.3 29418.4 29833.7 24020.3 24506.4 24600.4 24605.4 24904.0 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27518.85 Median:20536.69 stddev:81211.73 (395.4%) stddev-sans-first:81413.94 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: Values: 359.7 365.4 365.6 366.5 371.0 13849.0 14195.1 16273.3 17376.1 17695.8 13063.7 15442.2 15792.5 15820.4 15850.4 5346.8 5442.6 5471.1 5472.8 5472.9 3946.4 4049.3 5333.4 5494.8 5853.8 6066.5 6079.3 6093.5 6130.8 6131.6 5921.1 6042.2 6043.2 6048.1 6069.8 5258.0 5312.3 5313.3 5323.2 5334.8 20891.4 20923.4 21089.3 21240.4 21315.7 2260.6 2336.9 2343.9 2351.3 2440.9 13003.3 13245.5 13319.3 13337.2 13733.7 1839.0 1848.3 1851.0 1869.0 1872.7 56120.0 58126.4 58478.7 58732.4 58784.1 9526.5 9735.4 9919.0 9919.8 9981.6 12812.0 12929.5 12934.8 12947.2 12956.1 6983.1 7095.4 7109.0 7139.1 7181.5 6844.3 6863.8 6886.0 6888.8 6918.0 5918.8 5969.6 5997.0 6021.1 6026.4 1696.6 1726.5 1761.8 1777.9 1789.7 446.0 449.4 949.5 988.8 1078.7 9808.2 10609.9 10799.3 10961.3 11006.9 455.3 887.3 942.0 947.1 1010.0 7884.2 9023.0 9110.1 9172.5 9196.1 464351.0 467966.0 508154.0 515796.0 525103.0 73407.6 76763.6 78003.6 78506.6 78587.0 1181.7 1184.0 1189.9 1191.9 1205.4 15238.5 15292.5 15300.5 15429.7 15558.7 34831.7 35084.8 35595.6 36001.8 37127.0 47702.0 48018.8 49253.8 50851.5 50924.0 9102.7 9211.2 9233.0 9318.0 9355.7 14693.9 17333.1 17535.1 17665.4 17674.6 14293.5 14417.3 14572.9 14711.0 14895.0 14053.0 14150.7 14522.1 14698.8 14853.8 14645.9 14693.0 14885.9 14911.1 15215.3 9287.8 9326.2 9507.1 9529.5 9604.5 14319.6 14446.2 14482.9 14766.6 15104.2 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5086.95 Median:6149.60 stddev:2554.35 (41.5%) stddev-sans-first:2545.68 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: Values: 1302.9 1714.5 1749.9 1778.4 1779.6 6487.0 6914.4 7072.7 7073.9 7079.6 7138.6 7314.6 7316.0 7318.7 7319.0 1881.5 1912.4 1914.6 2161.1 2201.1 2182.5 2217.5 2218.8 2220.3 2221.4 2089.4 2100.7 2192.3 2195.2 2195.5 2159.9 2179.3 2189.2 2205.2 2205.9 2196.8 2217.0 2217.7 2218.6 2220.0 7165.2 7218.3 7243.6 7246.7 7254.7 4365.5 4398.6 4450.9 4453.0 4460.7 2919.9 3011.2 3023.6 3025.7 3033.1 1020.2 1034.2 1047.4 1058.6 1085.2 9647.9 9768.1 9785.6 9787.7 9802.2 3826.4 3841.3 3900.3 3955.9 3965.1 8445.4 8450.4 8453.5 8455.2 8475.4 4391.0 4391.6 4393.5 4413.1 4432.3 4029.7 4030.1 4032.3 4032.7 4034.6 3087.8 3142.4 3392.9 3462.2 3556.3 1127.2 1132.2 1135.9 1139.2 1141.1 1047.4 1061.2 1062.3 1188.3 1305.8 6735.5 6790.1 6914.3 6916.1 6916.2 1119.6 1126.0 1126.5 1129.7 1137.3 5310.3 5401.1 5419.7 5422.8 5429.6 7831.7 7955.3 8052.5 8514.5 8780.9 7995.2 8042.7 8065.3 8075.7 8079.1 6766.4 6792.2 6892.6 6952.0 6972.5 6736.1 6778.6 6810.6 6812.6 6816.2 7501.9 7624.4 7749.7 7765.6 7837.7 7851.2 7953.8 8028.2 8191.8 8200.9 6398.3 6402.6 6445.7 6449.2 6465.1 6893.3 7078.8 7097.0 7102.6 7104.1 6576.1 6634.4 6667.6 6741.6 6803.9 6509.4 6555.6 6574.7 6678.3 6729.3 6623.6 6651.6 6666.1 6668.9 6672.8 5655.7 5819.7 6107.5 6146.3 6152.9 6108.1 6143.0 6159.0 6165.3 6167.2 20:04:09 INFO - 2015-12-17 20:04:09,006 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,007 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5279.41 Median:5987.57 stddev:1563.79 (26.1%) stddev-sans-first:1523.50 20:04:09 INFO - 2015-12-17 20:04:09,007 DEBUG : BROWSER_OUTPUT: Values: 334.3 337.7 339.6 342.9 346.4 5801.9 5880.9 5945.1 5962.0 6001.5 5762.9 5862.7 5880.7 5893.1 5912.1 4576.0 4577.1 4580.7 4584.6 4586.4 4370.1 4460.5 4476.5 4552.6 4599.6 4503.3 4505.7 4514.5 4526.4 4550.3 4472.4 4546.7 4549.3 4551.4 4554.1 4027.3 4028.3 4028.4 4029.5 4039.3 5523.5 5639.8 5648.4 5658.3 5706.4 5299.8 5324.2 5327.3 5329.4 5331.5 5973.6 6262.7 6276.5 6282.0 6289.8 4291.8 4413.7 4414.7 4469.7 4471.6 6373.6 6478.1 6480.1 6483.1 6484.4 4544.7 4584.6 4589.4 4590.7 4591.3 4547.1 4636.1 4644.6 4651.1 4652.6 5288.6 5289.2 5290.0 5290.9 5301.5 6278.1 6284.0 6285.2 6286.2 6291.9 1630.4 1645.2 1645.3 1647.9 1647.9 1101.6 1120.9 1123.4 1123.8 1144.3 6056.0 6061.8 6062.1 6063.6 6069.1 6487.1 6491.7 6499.9 6501.8 6503.3 5905.4 6049.6 6053.0 6053.2 6054.1 3518.2 3536.4 3541.3 3541.8 3543.8 6620.5 6625.1 6631.5 6637.7 6638.4 6481.7 6602.8 6611.3 6617.8 6620.1 6608.7 6613.0 6620.0 6628.6 6631.2 6334.0 6443.3 6494.5 6495.8 6496.4 6333.2 6449.0 6472.4 6481.8 6483.2 6657.2 6678.9 6686.1 6686.3 6687.7 4540.5 4630.4 4630.7 4633.0 4641.5 6529.8 6531.1 6532.5 6537.0 6539.6 6275.0 6348.4 6369.0 6375.4 6381.0 6200.1 6338.6 6353.2 6353.3 6358.3 6227.4 6231.6 6232.0 6236.6 6238.4 6357.4 6379.6 6382.5 6387.0 6391.8 6107.5 6229.0 6232.6 6247.3 6277.0 20:04:09 INFO - 2015-12-17 20:04:09,007 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,007 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13435.45 Median:26004.23 stddev:15830.54 (60.9%) stddev-sans-first:15846.04 20:04:09 INFO - 2015-12-17 20:04:09,008 DEBUG : BROWSER_OUTPUT: Values: 694.3 732.3 822.1 831.4 843.7 13473.7 13893.0 13908.1 13924.9 13926.4 11799.9 11815.2 11873.4 12224.1 12975.9 690.1 698.1 816.5 827.0 831.7 826.3 836.7 837.3 843.4 844.8 869.4 878.7 879.1 879.6 879.7 715.8 726.3 841.8 855.5 862.1 628.0 629.5 631.3 631.3 631.4 13465.3 13667.5 13681.4 13694.7 13706.2 11664.7 12036.8 12077.6 12256.4 12570.4 9872.6 10029.8 10045.8 10296.7 10315.7 3515.8 3524.5 3565.3 3580.0 3672.0 44760.6 45161.3 45177.8 45192.3 45197.8 9799.7 9908.2 10059.4 10099.8 10146.9 17651.1 17952.1 17972.6 17999.9 18003.9 7605.8 7805.6 7871.3 7953.8 8010.0 4142.9 4154.0 4174.2 4184.3 4233.1 2802.1 2838.1 2849.2 2851.7 2855.6 508.2 528.5 532.3 533.3 537.6 497.8 518.0 593.7 624.1 647.9 8160.0 8257.3 8295.7 8334.7 8453.0 607.2 608.9 622.5 632.0 646.6 3815.0 3856.4 3875.1 3884.6 3917.8 56589.4 57329.0 57915.4 58381.7 58459.7 50459.0 51500.2 51722.5 51783.5 51802.5 44291.6 44453.8 44624.8 46853.0 47032.1 7506.7 7746.7 7785.9 7857.5 8021.2 35389.3 36092.6 36109.0 36826.4 36893.8 42277.8 42282.6 44885.6 45102.5 45727.3 9658.6 9707.5 9800.6 10130.1 10191.8 10316.7 10442.3 10465.2 10469.8 10581.6 10076.8 10205.8 10244.5 10386.1 10639.9 9379.4 9410.6 9470.1 9478.7 9494.5 7513.4 10477.0 10997.6 11130.4 11494.8 9059.4 9097.0 9211.8 9392.1 9725.7 8987.6 9250.7 9329.9 9464.1 9523.6 20:04:09 INFO - 2015-12-17 20:04:09,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:04:09 INFO - 2015-12-17 20:04:09,008 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2015-12-17 20:04:09,675 INFO : Browser exited with error code: 0 20:04:09 INFO - 2015-12-17 20:04:09,693 INFO : Completed test dromaeo_css (00:18:32) 20:04:09 INFO - 2015-12-17 20:04:09,693 INFO : Starting test kraken 20:04:09 INFO - 2015-12-17 20:04:09,693 DEBUG : operating with platform_type : linux_ 20:04:09 INFO - 2015-12-17 20:04:09,693 INFO : Initialising browser for kraken test... 20:04:09 INFO - 2015-12-17 20:04:09,700 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptN3HiN/profile http://localhost:46365/getInfo.html 20:04:13 INFO - 2015-12-17 20:04:13,985 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:04:13 INFO - 2015-12-17 20:04:13,986 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:04:13 INFO - 2015-12-17 20:04:13,986 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:04:13 INFO - 2015-12-17 20:04:13,986 DEBUG : BROWSER_OUTPUT: __metrics 20:04:14 INFO - 2015-12-17 20:04:14,102 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:04:14 INFO - 2015-12-17 20:04:14,144 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] 20:04:14 ERROR - 2015-12-17 20:04:14,159 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 20:04:15 INFO - 2015-12-17 20:04:15,019 INFO : Browser initialized. 20:04:15 INFO - 2015-12-17 20:04:15,019 INFO : Running cycle 1/1 for kraken test... 20:04:15 INFO - 2015-12-17 20:04:15,020 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptN3HiN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:04:26 INFO - 2015-12-17 20:04:26,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 149889024 20:04:26 INFO - 2015-12-17 20:04:26,861 DEBUG : BROWSER_OUTPUT: 20:04:29 INFO - 2015-12-17 20:04:29,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46365/tests/kraken/driver.html?testName=audio-beat-detection) 20:04:29 INFO - 2015-12-17 20:04:29,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 186527744 20:04:29 INFO - 2015-12-17 20:04:29,942 DEBUG : BROWSER_OUTPUT: 20:04:32 INFO - 2015-12-17 20:04:32,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46365/tests/kraken/driver.html?testName=audio-dft) 20:04:33 INFO - 2015-12-17 20:04:33,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 177311744 20:04:33 INFO - 2015-12-17 20:04:33,120 DEBUG : BROWSER_OUTPUT: 20:04:36 INFO - 2015-12-17 20:04:36,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46365/tests/kraken/driver.html?testName=audio-fft) 20:04:36 INFO - 2015-12-17 20:04:36,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 160911360 20:04:36 INFO - 2015-12-17 20:04:36,601 DEBUG : BROWSER_OUTPUT: 20:04:38 INFO - 2015-12-17 20:04:38,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46365/tests/kraken/driver.html?testName=audio-oscillator) 20:04:39 INFO - 2015-12-17 20:04:39,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 163041280 20:04:39 INFO - 2015-12-17 20:04:39,159 DEBUG : BROWSER_OUTPUT: 20:04:41 INFO - 2015-12-17 20:04:41,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:04:41 INFO - 2015-12-17 20:04:41,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 164536320 20:04:41 INFO - 2015-12-17 20:04:41,921 DEBUG : BROWSER_OUTPUT: 20:04:44 INFO - 2015-12-17 20:04:44,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46365/tests/kraken/driver.html?testName=imaging-darkroom) 20:04:45 INFO - 2015-12-17 20:04:45,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 164610048 20:04:45 INFO - 2015-12-17 20:04:45,373 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2015-12-17 20:04:48,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46365/tests/kraken/driver.html?testName=imaging-desaturate) 20:04:49 INFO - 2015-12-17 20:04:49,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 166486016 20:04:49 INFO - 2015-12-17 20:04:49,309 DEBUG : BROWSER_OUTPUT: 20:04:52 INFO - 2015-12-17 20:04:52,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46365/tests/kraken/driver.html?testName=json-parse-financial) 20:04:52 INFO - 2015-12-17 20:04:52,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 166629376 20:04:52 INFO - 2015-12-17 20:04:52,603 DEBUG : BROWSER_OUTPUT: 20:04:54 INFO - 2015-12-17 20:04:54,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:04:54 INFO - 2015-12-17 20:04:54,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 177307648 20:04:54 INFO - 2015-12-17 20:04:54,759 DEBUG : BROWSER_OUTPUT: 20:04:56 INFO - 2015-12-17 20:04:56,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:04:57 INFO - 2015-12-17 20:04:57,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 174252032 20:04:57 INFO - 2015-12-17 20:04:57,155 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-17 20:04:59,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:04:59 INFO - 2015-12-17 20:04:59,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 185372672 20:04:59 INFO - 2015-12-17 20:04:59,776 DEBUG : BROWSER_OUTPUT: 20:05:02 INFO - 2015-12-17 20:05:02,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:05:02 INFO - 2015-12-17 20:05:02,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 192475136 20:05:02 INFO - 2015-12-17 20:05:02,745 DEBUG : BROWSER_OUTPUT: 20:05:05 INFO - 2015-12-17 20:05:05,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:05:05 INFO - 2015-12-17 20:05:05,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 189648896 20:05:05 INFO - 2015-12-17 20:05:05,920 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46365/tests/kraken/driver.html?testName=ai-astar) 20:05:07 INFO - 2015-12-17 20:05:07,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 247472128 20:05:07 INFO - 2015-12-17 20:05:07,845 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,845 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;112;111;112;102;113;113;119 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;129;149;161;129;152;159;122;161;123 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;160;161;159;161;163;162 20:05:07 INFO - 2015-12-17 20:05:07,846 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;81;93;71;72;71;110;91;71 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;93;142;92;93;94;137;93;93;135 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;144;146;145;145;145;144;145 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;96;96;96 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;59;58;58;60;59;67;57;57 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;67;67;72;67;68;69;68 20:05:07 INFO - 2015-12-17 20:05:07,847 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;92;85;87;84;84;88;86 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;116;122;114;121;125;121;114;120;120 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;141;159;152;157;142;151;162;151;147 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;68;68;65;67;66;65;67 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,937 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:05:07 INFO - 2015-12-17 20:05:07,848 DEBUG : BROWSER_OUTPUT: __startTimestamp1450411507844__endTimestamp 20:05:07 INFO - 2015-12-17 20:05:07,849 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:4.62 (4.1%) stddev-sans-first:4.90 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 112.0 111.0 112.0 102.0 113.0 113.0 119.0 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.50 stddev:15.86 (10.5%) stddev-sans-first:16.78 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: Values: 146.0 129.0 149.0 161.0 129.0 152.0 159.0 122.0 161.0 123.0 20:05:07 INFO - 2015-12-17 20:05:07,852 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 160.0 161.0 159.0 161.0 163.0 162.0 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:72.50 stddev:13.37 (18.4%) stddev-sans-first:13.82 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 81.0 93.0 71.0 72.0 71.0 110.0 91.0 71.0 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:93.00 stddev:21.52 (23.1%) stddev-sans-first:22.58 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: Values: 98.0 93.0 142.0 92.0 93.0 94.0 137.0 93.0 93.0 135.0 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 144.0 146.0 145.0 145.0 145.0 144.0 145.0 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,853 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:2.88 (4.9%) stddev-sans-first:3.05 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 59.0 58.0 58.0 60.0 59.0 67.0 57.0 57.0 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 67.0 72.0 67.0 68.0 69.0 68.0 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.56 (3.0%) stddev-sans-first:2.62 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 92.0 85.0 87.0 84.0 84.0 88.0 86.0 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:120.50 stddev:3.56 (3.0%) stddev-sans-first:3.77 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: Values: 120.0 116.0 122.0 114.0 121.0 125.0 121.0 114.0 120.0 120.0 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,854 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.50 stddev:6.90 (4.6%) stddev-sans-first:7.23 20:05:07 INFO - 2015-12-17 20:05:07,855 DEBUG : BROWSER_OUTPUT: Values: 148.0 141.0 159.0 152.0 157.0 142.0 151.0 162.0 151.0 147.0 20:05:07 INFO - 2015-12-17 20:05:07,855 DEBUG : BROWSER_OUTPUT: 20:05:07 INFO - 2015-12-17 20:05:07,855 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 20:05:07 INFO - 2015-12-17 20:05:07,855 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 65.0 67.0 66.0 65.0 67.0 20:05:07 INFO - 2015-12-17 20:05:07,855 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:07 INFO - 2015-12-17 20:05:07,855 DEBUG : BROWSER_OUTPUT: 20:05:08 INFO - 2015-12-17 20:05:08,627 INFO : Browser exited with error code: 0 20:05:08 INFO - 2015-12-17 20:05:08,680 INFO : Completed test kraken (00:00:58) 20:05:08 INFO - 2015-12-17 20:05:08,680 INFO : Starting test v8_7 20:05:08 INFO - 2015-12-17 20:05:08,680 DEBUG : operating with platform_type : linux_ 20:05:08 INFO - 2015-12-17 20:05:08,680 INFO : Initialising browser for v8_7 test... 20:05:08 INFO - 2015-12-17 20:05:08,686 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXiefsL/profile http://localhost:46365/getInfo.html 20:05:13 INFO - 2015-12-17 20:05:13,012 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:13 INFO - 2015-12-17 20:05:13,013 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:13 INFO - 2015-12-17 20:05:13,013 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:05:13 INFO - 2015-12-17 20:05:13,013 DEBUG : BROWSER_OUTPUT: __metrics 20:05:13 INFO - 2015-12-17 20:05:13,121 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:05:13 INFO - 2015-12-17 20:05:13,177 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] 20:05:13 INFO - 2015-12-17 20:05:13,435 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:05:14 INFO - 2015-12-17 20:05:14,106 INFO : Browser initialized. 20:05:14 INFO - 2015-12-17 20:05:14,106 INFO : Running cycle 1/1 for v8_7 test... 20:05:14 INFO - 2015-12-17 20:05:14,107 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXiefsL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:05:25 INFO - 2015-12-17 20:05:25,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 148213760 20:05:25 INFO - 2015-12-17 20:05:25,955 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46365/tests/v8_7/run.html (next: http://localhost:46365/tests/v8_7/run.html) 20:05:47 INFO - 2015-12-17 20:05:47,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 612859904 20:05:47 INFO - 2015-12-17 20:05:47,640 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:47 INFO - 2015-12-17 20:05:47,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:47 INFO - 2015-12-17 20:05:47,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:47 INFO - 2015-12-17 20:05:47,640 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |0;Richards;166.22340425531914 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.67924528301887 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2024.2914979757086 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |6;Boyer;12550 20:05:47 INFO - 2015-12-17 20:05:47,641 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: |8;Splay;613.8735420503376 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1450411547633__endTimestamp 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:47 INFO - 2015-12-17 20:05:47,642 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: Values: 166.2 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: Values: 188.7 20:05:47 INFO - 2015-12-17 20:05:47,643 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: Values: 279.9 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: Values: 5148.7 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,644 DEBUG : BROWSER_OUTPUT: Values: 2024.3 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: Values: 782.5 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: Values: 12550.0 20:05:47 INFO - 2015-12-17 20:05:47,645 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: Values: 25250.0 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.87 Median:613.87 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: Values: 613.9 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:05:47 INFO - 2015-12-17 20:05:47,646 DEBUG : BROWSER_OUTPUT: Values: 4840.6 20:05:47 INFO - 2015-12-17 20:05:47,647 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:47 INFO - 2015-12-17 20:05:47,647 DEBUG : BROWSER_OUTPUT: 20:05:48 INFO - 2015-12-17 20:05:48,463 INFO : Browser exited with error code: 0 20:05:48 INFO - 2015-12-17 20:05:48,475 INFO : Completed test v8_7 (00:00:39) 20:05:48 INFO - 2015-12-17 20:05:48,627 INFO : Completed test suite (00:20:11) 20:05:48 INFO - 2015-12-17 20:05:48,627 DEBUG : Working with test: dromaeo_css 20:05:48 INFO - 2015-12-17 20:05:48,627 DEBUG : Generating results file: dromaeo_css 20:05:48 INFO - 2015-12-17 20:05:48,628 DEBUG : Working with test: kraken 20:05:48 INFO - 2015-12-17 20:05:48,629 DEBUG : Generating results file: kraken 20:05:48 INFO - 2015-12-17 20:05:48,629 INFO : javascript benchmark 20:05:48 INFO - 2015-12-17 20:05:48,629 DEBUG : Working with test: v8_7 20:05:48 INFO - 2015-12-17 20:05:48,629 DEBUG : Generating results file: v8_7 20:05:48 INFO - 2015-12-17 20:05:48,630 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:48 INFO - 2015-12-17 20:05:48,696 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:05:48 INFO - 2015-12-17 20:05:48,696 DEBUG : process_Request line: dromaeo_css 6805.57 graph.html#tests=[[72,64,35]] 20:05:48 INFO - 2015-12-17 20:05:48,696 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:48 INFO - 2015-12-17 20:05:48,737 DEBUG : process_Request line: kraken 1502.60 graph.html#tests=[[232,64,35]] 20:05:48 INFO - 2015-12-17 20:05:48,738 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:48 INFO - 2015-12-17 20:05:48,769 DEBUG : process_Request line: v8_7 19792.98 graph.html#tests=[[230,64,35]] 20:05:48 INFO - 2015-12-17 20:05:48,770 INFO : javascript benchmark 20:05:48 INFO - 2015-12-17 20:05:48,774 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3066.9539956900644, 3125.109343837004, 3162.0, 3163.1143279881626, 3192.2976945072082, 5063.392392912856, 5213.400458947222, 5222.738863056847, 5254.448282930294, 5299.920501192485, 5133.3326667533165, 5200.6099542534275, 5202.0376230397405, 5220.086484865143, 5273.604479664022, 4792.880177995552, 4815.0, 4827.517248275162, 4845.37010188675, 4887.839315402934, 4803.327534145223, 4853.126437241295, 4857.10143623429, 4890.535399137077, 4897.265410188483, 4641.141388843075, 4685.882852928704, 4742.2886567014875, 4792.065547218293, 4799.904001919959, 4736.64475164364, 4742.928856067162, 4743.335932969387, 4751.216049351853, 4754.66717329787, 4762.261849413347, 4764.0, 4766.666333356667, 4773.260144677581, 4783.784729687172, 4864.805407783684, 4979.900401991976, 4987.925181122286, 5004.374453193351, 5011.32347133136, 5582.63712858667, 5583.8883222335735, 5589.860253493654, 5590.301212348457, 5593.748281327309, 5372.704501252469, 5528.944710552883, 5615.550755939515, 5620.522255608278, 5670.121131224667, 5176.275321454999, 5253.159494480865, 5264.131418315935, 5269.130593452114, 5309.681419114827, 5606.915896261559, 5636.971815140898, 5642.0, 5649.322081350264, 5652.943470565242, 5251.973740131351, 5347.759350829222, 5349.090654588729, 5470.152126420411, 5489.780408783604, 5360.142377219626, 5447.0, 5448.972755136199, 5450.209719590637, 5473.261109750212, 5577.470140336662, 5594.356648985337, 5596.188552659842, 5599.720013999284, 5603.495685388253, 5211.1922651989, 5314.787408503694, 5321.308229930084, 5591.832245032656, 5646.97176514123, 4198.727082739673, 4280.764557949343, 4289.227938971015, 4319.33050377192, 4323.113761678848, 3810.8475660973804, 3818.809059547067, 3839.9616003840165, 3846.942295865564, 3851.017990412427, 5146.742662866842, 5258.526732594085, 5261.973690131525, 5289.285946397187, 5340.91988620171, 5498.972505137449, 5560.499555040065, 5668.716564171775, 5674.092145256739, 5699.08814589672, 5222.556082732935, 5231.189165679326, 5231.738413079331, 5232.3721153461065, 5238.449962753933, 4559.6808223424705, 4620.561046700558, 4701.247800351927, 4704.458987216514, 4734.4081989751285, 5619.43805619443, 5654.236678048493, 5691.772329106872, 5713.057345538023, 5764.913526297109, 5592.0, 5592.496675299242, 5593.161025846156, 5598.888022239614, 5600.943990560042, 5464.3442786865835, 5574.86062848432, 5733.569982251432, 5739.196512488338, 5745.827625171251, 5467.07059799843, 5477.863053423696, 5481.095619222783, 5517.200005999188, 5528.695921724344, 5492.258545096521, 5541.113421852484, 5542.5565954722715, 5554.75003624846, 5558.388577256418, 5254.13306804373, 5352.9732351338, 5354.571634269327, 5423.6783320923305, 5467.781288748405, 5319.707416091997, 5388.326459192601, 5388.946110538845, 5392.460753924733, 5392.676439413648, 5358.22305765654, 5372.355317361786, 5372.838814835562, 5373.220882972026, 5374.220737993047, 5246.213068039825, 5356.384015838228, 5370.892582148414, 5378.408375078817, 5386.299781028441, 5338.279332290091, 5355.491228333302, 5371.382291036581, 5376.139817629317, 5395.217693434509], "unit": "score", "name": "dojo.html", "value": 5117.7536184812625}, {"lowerIsBetter": false, "replicates": [563.8872225554888, 567.7615401531358, 588.2764200033959, 605.5730709849556, 609.3753902250196, 28027.579586306223, 37655.4351684725, 38041.42937855931, 38129.61870381295, 38190.61809381905, 40621.59378406215, 41258.38112428316, 41265.38101928466, 41371.79314103425, 41407.79296103523, 7604.6577903994175, 7699.26856948589, 8741.69404070856, 8941.552922353889, 8944.01615822259, 10388.688339349794, 10675.19936004799, 10731.678049658523, 10733.677989660322, 10745.08666763326, 10312.639057632985, 10410.375377477376, 10416.791664166713, 10418.062374386303, 10420.791584168312, 7792.922070779305, 7950.284474397332, 10333.689989300334, 10479.214058945534, 10733.83899241512, 10271.845922311171, 10404.063634272876, 10408.583656653725, 10413.5834566618, 10425.113865321457, 39045.21909561821, 39618.20763584741, 39629.207415851524, 39629.40555891664, 39648.0, 3185.2036990752313, 3236.0, 3242.643309235982, 3263.102646772133, 3293.670632936711, 29990.100296990906, 30093.0, 30264.69735302663, 30748.0, 31187.532187017212, 3907.179492306619, 3911.3741801311653, 3978.0850404407147, 4000.399940008993, 4044.0, 267212.0, 267805.0, 268491.0, 269316.0, 270574.0, 56752.71623641856, 57354.426455735746, 57371.71314143486, 57378.7131064342, 57382.7130864343, 56542.0, 58376.708116459144, 64859.351406486276, 66268.6686566564, 66280.6685966567, 14073.507427239998, 14112.85887141136, 14118.788218176736, 14200.64498387528, 14242.14547127155, 9856.0, 9888.357256778287, 9929.553170107363, 9938.304318697621, 9958.551865166084, 18775.34286299973, 18947.0, 19029.904850475657, 19056.809431905782, 19091.80908190928, 7196.856062878713, 7449.2923172299625, 7482.1021477423055, 7490.775276741707, 7567.432442566829, 974.7222041718077, 1041.3075304922293, 1059.7774467361787, 1077.9059254856327, 1086.7935092332432, 28286.85856570745, 28352.85823570869, 28553.0, 28762.568561471595, 29027.564586530796, 1021.3055122516612, 1026.2764750850633, 1030.9793804124026, 1064.590132798878, 1064.6752740414092, 13315.334233288491, 13444.260565668983, 13594.93202533981, 13632.113912595649, 13634.590962271148, 308243.0, 313668.0, 314213.0, 314599.0, 314871.0, 48739.0, 48743.75628121837, 48932.7553362238, 48933.266001010015, 48987.75506122447, 1340.1757918880014, 1349.291621898511, 1351.63505853421, 1357.1585616917378, 1364.270115488209, 23348.416289592897, 25351.492970140123, 26649.467010660064, 26732.0, 27556.311092222855, 40830.0, 40860.0, 40924.79537602293, 41227.58772412237, 41316.1736765269, 200331.0, 201061.0, 202916.0, 203094.0, 203507.0, 26869.193924182306, 27422.45155096927, 29226.0, 30628.0, 30658.693413065583, 36990.815045924595, 37137.814310928276, 37200.81399593093, 37731.0, 38188.2362352757, 34066.31867362688, 34286.0, 35013.0, 35075.82462087673, 35736.0, 29580.260493487836, 29833.85083074571, 30036.399272014874, 30039.399212016073, 30188.69811301859, 32730.0, 34852.65147348595, 35957.820210898775, 36131.458028130124, 36189.0, 27064.72935270622, 28882.566761499016, 29239.269018274714, 29418.411631766816, 29833.70166298396, 24020.279391618278, 24506.387340316636, 24600.384990375383, 24605.38486537851, 24904.0], "unit": "score", "name": "ext.html", "value": 17891.556770705287}, {"lowerIsBetter": false, "replicates": [359.7212160575552, 365.3879751416377, 365.64897698209717, 366.4503245132301, 371.03715857350164, 13849.0, 14195.077319974194, 16273.267702953366, 17376.131193440324, 17695.823041769578, 13063.73872522549, 15442.227888605554, 15792.526224213263, 15820.367185312574, 15850.445234416798, 5346.759395827187, 5442.6462279951675, 5471.124620060791, 5472.753726082336, 5472.945270547303, 3946.3883098119836, 4049.311617025113, 5333.4399888011585, 5494.780208791643, 5853.765849366042, 6066.454019138277, 6079.331273559905, 6093.451589356957, 6130.754769809202, 6131.570790044699, 5921.111833225008, 6042.184305118797, 6043.153958445821, 6048.092786082079, 6069.757209711606, 5257.974694934489, 5312.309399778004, 5313.335833020872, 5323.22813192085, 5334.813281535166, 20891.37325880226, 20923.372298830905, 21089.261875834272, 21240.362789116352, 21315.742414909855, 2260.5930932432157, 2336.9298921032396, 2343.8828058597, 2351.318117745852, 2440.926772196819, 13003.349832508431, 13245.47018119274, 13319.334033298297, 13337.19976801395, 13733.656658583515, 1839.0, 1848.2976468941852, 1851.0, 1868.9532761681066, 1872.7378167056622, 56120.0, 58126.41873581252, 58478.70760646212, 58732.41267587312, 58784.11823822689, 9526.476043817518, 9735.367201131903, 9918.950405248072, 9919.752006199902, 9981.550830212658, 12812.0, 12929.482820687068, 12934.805977910151, 12947.223166610034, 12956.093073484953, 6983.079653095338, 7095.432365410755, 7109.004739336497, 7139.107611548557, 7181.461390395742, 6844.28135045823, 6863.828404289833, 6886.0, 6888.793336199822, 6917.965410172917, 5918.763249470059, 5969.582129250911, 5997.0, 6021.066734656135, 6026.367231440723, 1696.550414140254, 1726.4993151985784, 1761.8238176182278, 1777.8933264004202, 1789.6778579855752, 446.01653354353573, 449.42249209765293, 949.4770923753719, 988.7528117970363, 1078.7357097511003, 9808.21534277256, 10609.893901061045, 10799.298045627167, 10961.287516311573, 11006.889931100586, 455.26702009764256, 887.3477993674644, 941.9529023548795, 947.1049857884233, 1010.0101900137906, 7884.211578842184, 9023.014936713913, 9110.088991100969, 9172.527085308206, 9196.12636799503, 464351.0, 467966.0, 508154.0, 515796.0, 525103.0, 73407.63296183485, 76763.61618191985, 78003.60998194973, 78506.60746696344, 78587.0, 1181.716388066875, 1184.040926849255, 1189.9464524096436, 1191.9414393988484, 1205.4153735438306, 15238.466653667068, 15292.541223763305, 15300.464483743015, 15429.685547168014, 15558.688826223639, 34831.65168348284, 35084.824575876955, 35595.64404355923, 36001.81999089988, 37127.0, 47702.0, 48018.75990620025, 49253.75373123112, 50851.49148508615, 50924.0, 9102.681406150752, 9211.170994610517, 9232.95383523078, 9317.953410232905, 9355.672551460666, 14693.853061469676, 17333.133343333036, 17535.123243838014, 17665.38171164003, 17674.646507070043, 14293.499727509487, 14417.279136042946, 14572.85427145715, 14711.043782154125, 14894.957352985188, 14053.0, 14150.716985660023, 14522.128672279698, 14698.779518307449, 14853.777193341892, 14645.853541464876, 14693.0, 14885.85114148888, 14911.105333680014, 15215.283888383698, 9287.767805804639, 9326.160645541662, 9507.096825801538, 9529.52352382392, 9604.471754053595, 14319.57041288763, 14446.205458699453, 14482.855171448573, 14766.557003289918, 15104.169270689777], "unit": "score", "name": "jquery.html", "value": 8828.656518369839}, {"lowerIsBetter": false, "replicates": [1302.941367638456, 1714.451375559821, 1749.8775085743996, 1778.3509019207993, 1779.5817982774042, 6487.0, 6914.412274956629, 7072.717091316347, 7073.893891591618, 7079.64601769912, 7138.6430678465995, 7314.634268286578, 7316.0, 7318.7438439654625, 7318.96340518298, 1881.5390229393818, 1912.416712902564, 1914.63621911837, 2161.059938926568, 2201.0645475672854, 2182.508935489518, 2217.5121473275935, 2218.7559368469456, 2220.3006053093304, 2221.3558068160214, 2089.4358523198725, 2100.674395468697, 2192.2655910270078, 2195.220696652689, 2195.484061245606, 2159.88120653364, 2179.3135162423864, 2189.2009416563, 2205.162038425396, 2205.900734466945, 2196.8132708719777, 2216.9778302216932, 2217.7449593296815, 2218.6450167973207, 2220.04538048639, 7165.247648996885, 7218.314260145278, 7243.5653860768525, 7246.71013159473, 7254.709811607529, 4365.476142862845, 4398.64810815134, 4450.933236001462, 4453.042595841877, 4460.732356058615, 2919.8832046718107, 3011.2471882029495, 3023.576699262105, 3025.6520500142547, 3033.059751477027, 1020.1736593359402, 1034.1571619130384, 1047.36634336227, 1058.5659879449388, 1085.1969542538543, 9647.855282170773, 9768.07203315684, 9785.608575656965, 9787.706368808947, 9802.166815820592, 3826.445165450994, 3841.250956063541, 3900.2589507993957, 3955.9011024724036, 3965.147493288957, 8445.408821382567, 8450.366222533212, 8453.450525715809, 8455.196756308142, 8475.406721529434, 4390.978045109818, 4391.5827996340295, 4393.450818647669, 4413.1394378095965, 4432.268675668479, 4029.6776257899296, 4030.1133750574827, 4032.334664780278, 4032.737872038308, 4034.576369481221, 3087.830169340663, 3142.3715256948703, 3392.8642854286045, 3462.1690794209208, 3556.324298383299, 1127.22784892349, 1132.17351333527, 1135.937523436219, 1139.174098778379, 1141.1156353825686, 1047.4134484688598, 1061.177587369779, 1062.2670357453333, 1188.2514016169757, 1305.7584346895856, 6735.528513004043, 6790.083338749305, 6914.274001229798, 6916.135483064617, 6916.1700595927805, 1119.6025410978984, 1125.9774804503863, 1126.4705588373452, 1129.683688567186, 1137.2721458266717, 5310.309659744285, 5401.108817045144, 5419.674819510842, 5422.810201642924, 5429.647072940246, 7831.725889593837, 7955.323797477279, 8052.516848989079, 8514.531700756394, 8780.912190878138, 7995.200479952075, 8042.67829286822, 8065.274125328749, 8075.717349892843, 8079.111297757242, 6766.424853887376, 6792.184937807495, 6892.620905850226, 6951.957206419078, 6972.511924165361, 6736.124303840469, 6778.559393639398, 6810.5913645181445, 6812.591244525344, 6816.216135144522, 7501.88747168782, 7624.428167887319, 7749.690012399667, 7765.61171941412, 7837.725679601187, 7851.2148785121035, 7953.8409231816195, 8028.237317454832, 8191.754247372588, 8200.876986845322, 6398.264199616918, 6402.583832051088, 6445.70994305248, 6449.161608990801, 6465.062565928009, 6893.310668933066, 7078.752243671653, 7096.964515177598, 7102.573845569283, 7104.147502299757, 6576.112224849584, 6634.402903738686, 6667.599944003376, 6741.629210393476, 6803.89794153098, 6509.414152726277, 6555.639439830665, 6574.671266436755, 6678.332166783282, 6729.259781423942, 6623.569467984758, 6651.634160121046, 6666.133402657623, 6668.899966500603, 6672.766453174116, 5655.688937108334, 5819.6508209507565, 6107.511399087974, 6146.293176284606, 6152.907706384318, 6108.11432342299, 6143.0, 6159.0, 6165.290991536031, 6167.167432396569], "unit": "score", "name": "mootools.html", "value": 4237.808368316273}, {"lowerIsBetter": false, "replicates": [334.3396791337109, 337.71294399760205, 339.60266488208794, 342.8611412377987, 346.4076429305887, 5801.883962320751, 5880.882382352351, 5945.108233764932, 5961.970190149049, 6001.48987336077, 5762.855928601787, 5862.706864656771, 5880.6765627890445, 5893.057110862263, 5912.054071348585, 4575.954240457603, 4577.130345234395, 4580.656450766189, 4584.5644663756975, 4586.3579098926175, 4370.060437006043, 4460.4647442306805, 4476.507584165739, 4552.567506086916, 4599.563041511051, 4503.279475283955, 4505.707129036618, 4514.548545145492, 4526.366308716782, 4550.294704320819, 4472.373867658531, 4546.727196368212, 4549.317602359656, 4551.385562948993, 4554.089182163548, 4027.2750904837117, 4028.315186418316, 4028.3756017817286, 4029.4560234368278, 4039.252738243405, 5523.530499907512, 5639.774409023634, 5648.406917273709, 5658.349289831681, 5706.429357064302, 5299.8410047698635, 5324.201369794523, 5327.334083239595, 5329.360476742777, 5331.520163185293, 5973.6415815050805, 6262.718177682015, 6276.5292603054495, 6282.0, 6289.842753931142, 4291.806868690916, 4413.735175889425, 4414.690971631955, 4469.664775141845, 4471.642268618535, 6373.5857169283845, 6478.060681201199, 6480.092787009822, 6483.092367068614, 6484.383983521558, 4544.659150563721, 4584.564466375689, 4589.449266088091, 4590.747508887043, 4591.334256532784, 4547.067851090518, 4636.142313671981, 4644.628429725613, 4651.069786042805, 4652.604528615038, 5288.629795914326, 5289.233061206103, 5289.973550132225, 5290.867728306823, 5301.469853014668, 6278.089676996901, 6284.0, 6285.214348206474, 6286.245650521875, 6291.937080629135, 1630.3641579783894, 1645.19385501106, 1645.2596331650566, 1647.8681705463534, 1647.9176041197893, 1101.5758932810925, 1120.8879112088725, 1123.4270522033821, 1123.752774389633, 1144.3019757947645, 6056.0, 6061.7575296987625, 6062.120992456069, 6063.575549711478, 6069.089636554464, 6487.091807147003, 6491.740330386731, 6499.902501462388, 6501.804945851537, 6503.28463868974, 5905.379935106838, 6049.637021778707, 6053.0, 6053.152558641794, 6054.122152287893, 3518.1908161123083, 3536.4341705327024, 3541.256336169382, 3541.7520773545602, 3543.8228088595465, 6620.503462240351, 6625.105610742585, 6631.469482441393, 6637.668116594151, 6638.369354911372, 6481.675916204171, 6602.801915942529, 6611.33886611335, 6617.834554136089, 6620.106285651472, 6608.669566521655, 6613.041109039163, 6619.966900165468, 6628.635425051572, 6631.204255489276, 6334.0, 6443.323451037573, 6494.512911531559, 6495.772647957298, 6496.447801936699, 6333.20834895638, 6449.032645103084, 6472.417482426604, 6481.805545833632, 6483.222013358239, 6657.234418041793, 6678.899816502659, 6686.0973768540625, 6686.29793871656, 6687.699053542699, 4540.545945405565, 4630.398048253705, 4630.652701047367, 4632.953670463387, 4641.466231383434, 6529.771457998947, 6531.052997315458, 6532.510061745483, 6536.967315163393, 6539.607623542603, 6274.968625156845, 6348.396902294275, 6368.968155159195, 6375.426211640789, 6381.0, 6200.0699895016105, 6338.556301058881, 6353.237611486651, 6353.3011368748475, 6358.332375100548, 6227.408396202353, 6231.626102433868, 6232.0, 6236.563440559299, 6238.407351301619, 6357.396047375492, 6379.553431259767, 6382.457491113308, 6387.0, 6391.776287829904, 6107.54193435503, 6228.968855155696, 6232.5637205397, 6247.31279559239, 6277.027060805583], "unit": "score", "name": "prototype.html", "value": 4776.447022811863}, {"lowerIsBetter": false, "replicates": [694.3334398976982, 732.2860211293986, 822.1039067416515, 831.3889291370841, 843.6794018273056, 13473.663158421032, 13893.0, 13908.095973761698, 13924.930375348134, 13926.373313200906, 11799.882001179985, 11815.172937894351, 11873.406329683525, 12224.08319376046, 12975.870241297584, 690.1235431002624, 698.1238545625233, 816.4856140631409, 827.0, 831.6881169561415, 826.277007618334, 836.7489753074084, 837.2841220756258, 843.3548335523329, 844.8352571248608, 869.395769939892, 878.7407714724171, 879.0550158579521, 879.6261588824756, 879.7140929198005, 715.8067321823105, 726.3100054947794, 841.7769291137853, 855.4995327733284, 862.1335557764406, 627.9905801412982, 629.4869681209799, 631.2771876201723, 631.3055638797332, 631.4159402552621, 13465.259410732406, 13667.521636742766, 13681.384337704827, 13694.726105477934, 13706.246156461391, 11664.708382290426, 12036.759264814742, 12077.637670869888, 12256.387180640932, 12570.434330455151, 9872.60509579616, 10029.849552256723, 10045.79908401828, 10296.691099267035, 10315.742106447324, 3515.753897227195, 3524.488949102366, 3565.3047655707146, 3579.961811074785, 3672.026912868092, 44760.55239447596, 45161.32258016132, 45177.77411112956, 45192.322115168296, 45197.774011130066, 9799.657012004545, 9908.20734341251, 10059.39643621385, 10099.798004040025, 10146.898531014744, 17651.117444127744, 17952.102394880203, 17972.55068623295, 17999.910000449912, 18003.909980450277, 7605.809854753676, 7805.648745806452, 7871.252231038156, 7953.801154971172, 8010.0, 4142.875713728533, 4153.958460415418, 4174.165166966619, 4184.330507118846, 4233.1322078973735, 2802.1173330400857, 2838.120182743356, 2849.244950088228, 2851.6720577133897, 2855.628768260113, 508.23003150227436, 528.5111272073317, 532.3079996005255, 533.2561077297149, 537.6370949609077, 497.8158081509792, 517.9559737422361, 593.7268856326052, 624.0670198053848, 647.899575565788, 8159.95920020408, 8257.256846883689, 8295.668173273001, 8334.70828521011, 8453.0, 607.2197226563844, 608.9482393996472, 622.5082185073832, 631.9778807741707, 646.6249575246346, 3814.9809250953567, 3856.402257650069, 3875.0823195036432, 3884.5726970033274, 3917.804109794499, 56589.434105658416, 57329.0, 57915.42084579184, 58381.70809145927, 58459.70770146122, 50459.0, 51500.227496587584, 51722.48277517177, 51783.48216517787, 51802.48197518052, 44291.55708442939, 44453.77773111178, 44624.77687611606, 46853.0, 47032.12098487689, 7506.662200200894, 7746.728864489716, 7785.883211751715, 7857.528548287121, 8021.197880211932, 35389.29221415506, 36092.63907360998, 36109.0, 36826.447603285436, 36893.81553092218, 42277.78861105675, 42282.57717422787, 44885.551144488134, 45102.54897450984, 45727.314090288004, 9658.613655453702, 9707.501703463195, 9800.558974846006, 10130.08829205375, 10191.84712229332, 10316.719618744917, 10442.269041167045, 10465.215108866712, 10469.842952355873, 10581.62964296246, 10076.848847267443, 10205.84691229647, 10244.53899574506, 10386.065254127165, 10639.89360106389, 9379.437233765995, 9410.57652405657, 9470.100340467645, 9478.668246611336, 9494.525273736424, 7513.416815742413, 10477.0, 10997.560097596006, 11130.387828669178, 11494.770104598028, 9059.411138275991, 9096.950527898873, 9211.815763684555, 9392.107749763762, 9725.659601914182, 8987.550622468982, 9250.676226332045, 9329.860052099088, 9464.133092166712, 9523.619055237712], "unit": "score", "name": "yui.html", "value": 6071.248345773213}], "name": "dromaeo_css", "value": 6805.569310719506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 112.0, 111.0, 112.0, 102.0, 113.0, 113.0, 119.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [146.0, 129.0, 149.0, 161.0, 129.0, 152.0, 159.0, 122.0, 161.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 159.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 81.0, 93.0, 71.0, 72.0, 71.0, 110.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [98.0, 93.0, 142.0, 92.0, 93.0, 94.0, 137.0, 93.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 58.0, 58.0, 60.0, 59.0, 67.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 72.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 92.0, 85.0, 87.0, 84.0, 84.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 122.0, 114.0, 121.0, 125.0, 121.0, 114.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [148.0, 141.0, 159.0, 152.0, 157.0, 142.0, 151.0, 162.0, 151.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 65.0, 67.0, 66.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1502.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.22340425531914], "unit": "score", "name": "Richards", "value": 212.37683199999995}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [613.8735420503376], "unit": "score", "name": "Splay", "value": 132.748839}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19792.9822920416}]} 20:05:48 INFO - RETURN: dromaeo_css: 6805.57 20:05:48 INFO - RETURN: kraken: 1502.60 20:05:48 INFO - RETURN: v8_7: 19792.98 20:05:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19792.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1502.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6805.57"}}} 20:05:48 INFO - Return code: 0 20:05:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:05:48 ERROR - # TBPL SUCCESS # 20:05:48 INFO - Running post-action listener: _resource_record_post_action 20:05:48 INFO - Running post-run listener: _resource_record_post_run 20:05:49 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556122112; Read time: 12; Write time: 650860 20:05:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234557440; Read time: 0; Write time: 387496 20:05:50 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310308864; Read time: 12; Write time: 259568 20:05:50 INFO - Running post-run listener: _upload_blobber_files 20:05:50 INFO - Blob upload gear active. 20:05:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:05:50 INFO - Copying logs to upload dir... 20:05:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.746639 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-17 20:05:49.684130) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:49.687514) ========= 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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/FyIbwv8-Qn2S4KfjlQXR4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:49.739327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:49.739664) ========= 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=01deea79d00cc2c334834894000001d2-1450407620.104469-1712083214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004758 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:05:49.789089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 20:05:49.789411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 20:05:49.789717) ========= ========= Total master_lag: 0.25 =========