builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1450313377.63 results: success (0) buildid: 20151216143013 builduid: f1b4d2d0ce144db3aaf22dc1fd9016ed revision: 1cf6f364d319a2932f1fc9fac255d9d24b495075 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.631055) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.631562) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.631896) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006354 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.676697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.680051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.745046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.745336) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.814260) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.814558) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.814923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.818290) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 16:49:37-- 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% 94.0M=0s 2015-12-16 16:49:37 (94.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105272 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.962779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:37.966170) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016554 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.018023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.018416) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1cf6f364d319a2932f1fc9fac255d9d24b495075 --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 1cf6f364d319a2932f1fc9fac255d9d24b495075 --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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 16:49:38,104 truncating revision to first 12 chars 2015-12-16 16:49:38,104 Setting DEBUG logging. 2015-12-16 16:49:38,104 attempt 1/10 2015-12-16 16:49:38,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1cf6f364d319?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 16:49:38,354 unpacking tar archive at: fx-team-1cf6f364d319/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525004 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.561254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.561589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.569341) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.569666) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:38.570379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-16 16:49:38.570706) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:38 INFO - MultiFileLogger online at 20151216 16:49:38 in /builds/slave/test-pgo 16:49:38 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 16:49:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:49:38 INFO - {'append_to_log': False, 16:49:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:49:38 INFO - 'blob_upload_branch': 'Fx-Team', 16:49:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:49:38 INFO - 'branch': 'Fx-Team', 16:49:38 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:38 INFO - 'config_files': ('talos/linux_config.py',), 16:49:38 INFO - 'default_actions': ('clobber', 16:49:38 INFO - 'read-buildbot-config', 16:49:38 INFO - 'download-and-extract', 16:49:38 INFO - 'populate-webroot', 16:49:38 INFO - 'create-virtualenv', 16:49:38 INFO - 'install', 16:49:38 INFO - 'run-tests'), 16:49:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:38 INFO - 'download_minidump_stackwalk': True, 16:49:38 INFO - 'download_symbols': 'ondemand', 16:49:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:38 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:38 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:38 INFO - 'installer_path': 'installer.exe', 16:49:38 INFO - 'log_level': 'info', 16:49:38 INFO - 'log_name': 'talos', 16:49:38 INFO - 'log_to_console': True, 16:49:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:38 INFO - 'opt_config_files': (), 16:49:38 INFO - 'pip_index': False, 16:49:38 INFO - 'sps_profile': False, 16:49:38 INFO - 'sps_profile_interval': 0, 16:49:38 INFO - 'suite': 'dromaeojs', 16:49:38 INFO - 'system_bits': '64', 16:49:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:38 INFO - 'title': 'talos-linux64-ix-011', 16:49:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:38 INFO - 'use_talos_json': True, 16:49:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:49:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:38 INFO - 'work_dir': 'build'} 16:49:38 INFO - ##### 16:49:38 INFO - ##### Running clobber step. 16:49:38 INFO - ##### 16:49:38 INFO - Running pre-action listener: _resource_record_pre_action 16:49:38 INFO - Running main action method: clobber 16:49:38 INFO - rmtree: /builds/slave/test-pgo/build 16:49:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:49:39 INFO - Running post-action listener: _resource_record_post_action 16:49:39 INFO - ##### 16:49:39 INFO - ##### Running read-buildbot-config step. 16:49:39 INFO - ##### 16:49:39 INFO - Running pre-action listener: _resource_record_pre_action 16:49:39 INFO - Running main action method: read_buildbot_config 16:49:39 INFO - Using buildbot properties: 16:49:39 INFO - { 16:49:39 INFO - "project": "", 16:49:39 INFO - "product": "firefox", 16:49:39 INFO - "script_repo_revision": "production", 16:49:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:49:39 INFO - "repository": "", 16:49:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:49:39 INFO - "buildid": "20151216143013", 16:49:39 INFO - "pgo_build": "True", 16:49:39 INFO - "basedir": "/builds/slave/test-pgo", 16:49:39 INFO - "buildnumber": 838, 16:49:39 INFO - "slavename": "talos-linux64-ix-011", 16:49:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:49:39 INFO - "platform": "ubuntu64_hw", 16:49:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:49:39 INFO - "branch": "fx-team", 16:49:39 INFO - "repo_path": "integration/fx-team", 16:49:39 INFO - "revision": "1cf6f364d319a2932f1fc9fac255d9d24b495075", 16:49:39 INFO - "stage_platform": "linux64-pgo", 16:49:39 INFO - "builduid": "f1b4d2d0ce144db3aaf22dc1fd9016ed", 16:49:39 INFO - "slavebuilddir": "test" 16:49:39 INFO - } 16:49:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:49:39 INFO - Running post-action listener: _resource_record_post_action 16:49:39 INFO - ##### 16:49:39 INFO - ##### Running download-and-extract step. 16:49:39 INFO - ##### 16:49:39 INFO - Running pre-action listener: _resource_record_pre_action 16:49:39 INFO - Running main action method: download_and_extract 16:49:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:39 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json 16:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json 16:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:49:39 INFO - Downloaded 1302 bytes. 16:49:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:49:39 INFO - Using the following test package requirements: 16:49:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'jsshell-linux-x86_64.zip'], 16:49:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:49:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:49:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:39 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:41 INFO - Downloaded 23119090 bytes. 16:49:41 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 16:49:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:41 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 16:49:42 INFO - Return code: 0 16:49:42 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 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:42 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:43 INFO - Downloaded 23119090 bytes. 16:49:43 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 16:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:43 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 16:49:45 INFO - Return code: 0 16:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:45 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:47 INFO - Downloaded 11132052 bytes. 16:49:47 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 16:49:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:47 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 16:49:48 INFO - Return code: 0 16:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:48 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:50 INFO - Downloaded 59284684 bytes. 16:49:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:50 INFO - mkdir: /builds/slave/test-pgo/properties 16:49:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:49:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:49:50 INFO - Contents: 16:49:50 INFO - build_url:https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:50 INFO - Running post-action listener: _resource_record_post_action 16:49:50 INFO - Running post-action listener: set_extra_try_arguments 16:49:50 INFO - ##### 16:49:50 INFO - ##### Running populate-webroot step. 16:49:50 INFO - ##### 16:49:50 INFO - Running pre-action listener: _resource_record_pre_action 16:49:50 INFO - Running main action method: populate_webroot 16:49:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:50 INFO - '--tppagecycles', 16:49:50 INFO - '7'], 16:49:50 INFO - 'tests': ['tsvgm']}}, 16:49:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:49:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'tests': ['damp', 'tps']}, 16:49:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['damp', 'tps']}, 16:49:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:49:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:50 INFO - 'other': {'tests': ['a11yr', 16:49:50 INFO - 'ts_paint', 16:49:50 INFO - 'tpaint', 16:49:50 INFO - 'sessionrestore', 16:49:50 INFO - 'sessionrestore_no_auto_restore']}, 16:49:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['a11yr', 16:49:50 INFO - 'ts_paint', 16:49:50 INFO - 'tpaint', 16:49:50 INFO - 'sessionrestore', 16:49:50 INFO - 'sessionrestore_no_auto_restore']}, 16:49:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['a11yr', 16:49:50 INFO - 'ts_paint', 16:49:50 INFO - 'tpaint', 16:49:50 INFO - 'sessionrestore', 16:49:50 INFO - 'sessionrestore_no_auto_restore']}, 16:49:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['a11yr', 16:49:50 INFO - 'ts_paint', 16:49:50 INFO - 'tpaint', 16:49:50 INFO - 'sessionrestore', 16:49:50 INFO - 'sessionrestore_no_auto_restore']}, 16:49:50 INFO - 'other_l64': {'tests': ['a11yr', 16:49:50 INFO - 'ts_paint', 16:49:50 INFO - 'tpaint', 16:49:50 INFO - 'sessionrestore', 16:49:50 INFO - 'sessionrestore_no_auto_restore']}, 16:49:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:49:50 INFO - 'ts_paint', 16:49:50 INFO - 'tpaint', 16:49:50 INFO - 'sessionrestore', 16:49:50 INFO - 'sessionrestore_no_auto_restore']}, 16:49:50 INFO - 'svgr': {'tests': ['tsvgx', 16:49:50 INFO - 'tsvgr_opacity', 16:49:50 INFO - 'tart', 16:49:50 INFO - 'tscrollx', 16:49:50 INFO - 'cart']}, 16:49:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['tsvgx', 16:49:50 INFO - 'tsvgr_opacity', 16:49:50 INFO - 'tart', 16:49:50 INFO - 'tscrollx', 16:49:50 INFO - 'cart']}, 16:49:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'tests': ['tp5o']}, 16:49:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'talos_options': ['--e10s'], 16:49:50 INFO - 'tests': ['tp5o']}, 16:49:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'talos_options': ['--xperf_path', 16:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:50 INFO - 'tests': ['tp5n']}, 16:49:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:50 INFO - 'talos_options': ['--e10s', 16:49:50 INFO - '--xperf_path', 16:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:50 INFO - 'tests': ['tp5n']}}, 16:49:50 INFO - 'talos.zip': {'path': '', 16:49:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:50 INFO - Running post-action listener: _resource_record_post_action 16:49:50 INFO - ##### 16:49:50 INFO - ##### Running create-virtualenv step. 16:49:50 INFO - ##### 16:49:50 INFO - Running pre-action listener: _resource_record_pre_action 16:49:50 INFO - Running main action method: create_virtualenv 16:49:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:49:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:49:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:49:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:50 INFO - Using real prefix '/usr' 16:49:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:49:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:52 INFO - Installing pip.................done. 16:49:52 INFO - Return code: 0 16:49:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:49:52 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')]} 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 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')]} 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 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 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:49:52 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 16:49:52 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 16:49:52 INFO - Using env: {'DISPLAY': ':0', 16:49:52 INFO - 'HOME': '/home/cltbld', 16:49:52 INFO - 'LANG': 'en_US.UTF-8', 16:49:52 INFO - 'LANGUAGE': 'en_US:en', 16:49:52 INFO - 'LOGNAME': 'cltbld', 16:49:52 INFO - 'MAIL': '/var/mail/cltbld', 16:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:52 INFO - 'MOZ_NO_REMOTE': '1', 16:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:52 INFO - 'NO_EM_RESTART': '1', 16:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:52 INFO - 'SHELL': '/bin/bash', 16:49:52 INFO - 'SHLVL': '1', 16:49:52 INFO - 'TERM': 'linux', 16:49:52 INFO - 'TMOUT': '86400', 16:49:52 INFO - 'USER': 'cltbld', 16:49:52 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:52 INFO - '_': '/tools/buildbot/bin/python'} 16:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:49:53 INFO - Cleaning up... 16:49:53 INFO - Return code: 0 16:49:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:49:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:49:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:49:53 INFO - Using env: {'DISPLAY': ':0', 16:49:53 INFO - 'HOME': '/home/cltbld', 16:49:53 INFO - 'LANG': 'en_US.UTF-8', 16:49:53 INFO - 'LANGUAGE': 'en_US:en', 16:49:53 INFO - 'LOGNAME': 'cltbld', 16:49:53 INFO - 'MAIL': '/var/mail/cltbld', 16:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:53 INFO - 'MOZ_NO_REMOTE': '1', 16:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:53 INFO - 'NO_EM_RESTART': '1', 16:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:53 INFO - 'SHELL': '/bin/bash', 16:49:53 INFO - 'SHLVL': '1', 16:49:53 INFO - 'TERM': 'linux', 16:49:53 INFO - 'TMOUT': '86400', 16:49:53 INFO - 'USER': 'cltbld', 16:49:53 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:53 INFO - '_': '/tools/buildbot/bin/python'} 16:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:53 INFO - Downloading/unpacking psutil>=0.7.1 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:55 INFO - Installing collected packages: psutil 16:49:55 INFO - Running setup.py install for psutil 16:49:55 INFO - building 'psutil._psutil_linux' extension 16:49:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:49:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:49:55 INFO - building 'psutil._psutil_posix' extension 16:49:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:49:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:55 INFO - Successfully installed psutil 16:49:55 INFO - Cleaning up... 16:49:55 INFO - Return code: 0 16:49:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:49: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')]} 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:49:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:49:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:49:55 INFO - Using env: {'DISPLAY': ':0', 16:49:55 INFO - 'HOME': '/home/cltbld', 16:49:55 INFO - 'LANG': 'en_US.UTF-8', 16:49:55 INFO - 'LANGUAGE': 'en_US:en', 16:49:55 INFO - 'LOGNAME': 'cltbld', 16:49:55 INFO - 'MAIL': '/var/mail/cltbld', 16:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:55 INFO - 'MOZ_NO_REMOTE': '1', 16:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:55 INFO - 'NO_EM_RESTART': '1', 16:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:55 INFO - 'SHELL': '/bin/bash', 16:49:55 INFO - 'SHLVL': '1', 16:49:55 INFO - 'TERM': 'linux', 16:49:55 INFO - 'TMOUT': '86400', 16:49:55 INFO - 'USER': 'cltbld', 16:49:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:55 INFO - '_': '/tools/buildbot/bin/python'} 16:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:49:55 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 16:49:55 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 16:49:55 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 16:49:55 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 16:49:55 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 16:49:55 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 16:49:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:49:57 INFO - Installing collected packages: mozsystemmonitor 16:49:57 INFO - Running setup.py install for mozsystemmonitor 16:49:57 INFO - Successfully installed mozsystemmonitor 16:49:57 INFO - Cleaning up... 16:49:57 INFO - Return code: 0 16:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:49:57 INFO - Using env: {'DISPLAY': ':0', 16:49:57 INFO - 'HOME': '/home/cltbld', 16:49:57 INFO - 'LANG': 'en_US.UTF-8', 16:49:57 INFO - 'LANGUAGE': 'en_US:en', 16:49:57 INFO - 'LOGNAME': 'cltbld', 16:49:57 INFO - 'MAIL': '/var/mail/cltbld', 16:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:57 INFO - 'MOZ_NO_REMOTE': '1', 16:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:57 INFO - 'NO_EM_RESTART': '1', 16:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:57 INFO - 'SHELL': '/bin/bash', 16:49:57 INFO - 'SHLVL': '1', 16:49:57 INFO - 'TERM': 'linux', 16:49:57 INFO - 'TMOUT': '86400', 16:49:57 INFO - 'USER': 'cltbld', 16:49:57 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:57 INFO - '_': '/tools/buildbot/bin/python'} 16:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:00 INFO - Downloading docopt-0.6.1.tar.gz 16:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:50:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:50:00 INFO - Running setup.py install for blobuploader 16:50:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:50:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:50:00 INFO - Running setup.py install for requests 16:50:00 INFO - Running setup.py install for docopt 16:50:01 INFO - Successfully installed blobuploader requests docopt 16:50:01 INFO - Cleaning up... 16:50:01 INFO - Return code: 0 16:50:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:50:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:50:01 INFO - Using env: {'DISPLAY': ':0', 16:50:01 INFO - 'HOME': '/home/cltbld', 16:50:01 INFO - 'LANG': 'en_US.UTF-8', 16:50:01 INFO - 'LANGUAGE': 'en_US:en', 16:50:01 INFO - 'LOGNAME': 'cltbld', 16:50:01 INFO - 'MAIL': '/var/mail/cltbld', 16:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:01 INFO - 'MOZ_NO_REMOTE': '1', 16:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:01 INFO - 'NO_EM_RESTART': '1', 16:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:01 INFO - 'SHELL': '/bin/bash', 16:50:01 INFO - 'SHLVL': '1', 16:50:01 INFO - 'TERM': 'linux', 16:50:01 INFO - 'TMOUT': '86400', 16:50:01 INFO - 'USER': 'cltbld', 16:50:01 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:01 INFO - '_': '/tools/buildbot/bin/python'} 16:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:01 INFO - Running setup.py (path:/tmp/pip-OryR47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:01 INFO - Running setup.py (path:/tmp/pip-ebk0AI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:01 INFO - Running setup.py (path:/tmp/pip-De_RtF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:01 INFO - Running setup.py (path:/tmp/pip-xqwgUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:01 INFO - Running setup.py (path:/tmp/pip-CAqTy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:01 INFO - Running setup.py (path:/tmp/pip-M46SBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:01 INFO - Running setup.py (path:/tmp/pip-0uvDhq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:01 INFO - Running setup.py (path:/tmp/pip-h7Z0Uw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:01 INFO - Running setup.py (path:/tmp/pip-NklnJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:01 INFO - Running setup.py (path:/tmp/pip-SmWXPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:02 INFO - Running setup.py (path:/tmp/pip-025pIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:02 INFO - Running setup.py (path:/tmp/pip-d6be0o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:02 INFO - Running setup.py (path:/tmp/pip-CDYfou-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:02 INFO - Running setup.py (path:/tmp/pip-TkLapl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:02 INFO - Running setup.py (path:/tmp/pip-9IwsJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:02 INFO - Running setup.py (path:/tmp/pip-WGzOjE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:02 INFO - Running setup.py (path:/tmp/pip-Hs6gy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:50:02 INFO - Running setup.py install for manifestparser 16:50:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozcrash 16:50:02 INFO - Running setup.py install for mozdebug 16:50:02 INFO - Running setup.py install for mozdevice 16:50:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozfile 16:50:03 INFO - Running setup.py install for mozhttpd 16:50:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozinfo 16:50:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozInstall 16:50:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozleak 16:50:03 INFO - Running setup.py install for mozlog 16:50:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for moznetwork 16:50:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozprocess 16:50:03 INFO - Running setup.py install for mozprofile 16:50:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozrunner 16:50:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:50:04 INFO - Running setup.py install for mozscreenshot 16:50:04 INFO - Running setup.py install for moztest 16:50:04 INFO - Running setup.py install for mozversion 16:50:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:50:04 INFO - Cleaning up... 16:50:04 INFO - Return code: 0 16:50:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:50:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:50:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:50:04 INFO - Using env: {'DISPLAY': ':0', 16:50:04 INFO - 'HOME': '/home/cltbld', 16:50:04 INFO - 'LANG': 'en_US.UTF-8', 16:50:04 INFO - 'LANGUAGE': 'en_US:en', 16:50:04 INFO - 'LOGNAME': 'cltbld', 16:50:04 INFO - 'MAIL': '/var/mail/cltbld', 16:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:04 INFO - 'MOZ_NO_REMOTE': '1', 16:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:04 INFO - 'NO_EM_RESTART': '1', 16:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:04 INFO - 'SHELL': '/bin/bash', 16:50:04 INFO - 'SHLVL': '1', 16:50:04 INFO - 'TERM': 'linux', 16:50:04 INFO - 'TMOUT': '86400', 16:50:04 INFO - 'USER': 'cltbld', 16:50:04 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:04 INFO - '_': '/tools/buildbot/bin/python'} 16:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:04 INFO - Running setup.py (path:/tmp/pip-SwU42e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:04 INFO - Running setup.py (path:/tmp/pip-6MuFMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:04 INFO - Running setup.py (path:/tmp/pip-r1_8tj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:04 INFO - Running setup.py (path:/tmp/pip-32tHhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:04 INFO - Running setup.py (path:/tmp/pip-Bj58es-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:04 INFO - Running setup.py (path:/tmp/pip-gaqKop-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:04 INFO - Running setup.py (path:/tmp/pip-MvcgZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:05 INFO - Running setup.py (path:/tmp/pip-Q1rKUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:05 INFO - Running setup.py (path:/tmp/pip-y4I4jT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:05 INFO - Running setup.py (path:/tmp/pip-ESe7sk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:05 INFO - Running setup.py (path:/tmp/pip-ejC8q_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:05 INFO - Running setup.py (path:/tmp/pip-hllE9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:05 INFO - Running setup.py (path:/tmp/pip-1ND0a6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:05 INFO - Running setup.py (path:/tmp/pip-3GJ7qk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:05 INFO - Running setup.py (path:/tmp/pip-LzMKPT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:05 INFO - Running setup.py (path:/tmp/pip-zvc6uC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:05 INFO - Running setup.py (path:/tmp/pip-JdPQUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:50:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:07 INFO - Downloading blessings-1.5.1.tar.gz 16:50:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:50:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:50:07 INFO - Installing collected packages: blessings 16:50:07 INFO - Running setup.py install for blessings 16:50:07 INFO - Successfully installed blessings 16:50:07 INFO - Cleaning up... 16:50:07 INFO - Return code: 0 16:50:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:50:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:07 INFO - Reading from file tmpfile_stdout 16:50:07 INFO - Current package versions: 16:50:07 INFO - argparse == 1.2.1 16:50:07 INFO - blessings == 1.5.1 16:50:07 INFO - blobuploader == 1.2.4 16:50:07 INFO - docopt == 0.6.1 16:50:07 INFO - manifestparser == 1.1 16:50:07 INFO - mozInstall == 1.12 16:50:07 INFO - mozcrash == 0.16 16:50:07 INFO - mozdebug == 0.1 16:50:07 INFO - mozdevice == 0.47 16:50:07 INFO - mozfile == 1.2 16:50:07 INFO - mozhttpd == 0.7 16:50:07 INFO - mozinfo == 0.9 16:50:07 INFO - mozleak == 0.1 16:50:07 INFO - mozlog == 3.1 16:50:07 INFO - moznetwork == 0.27 16:50:07 INFO - mozprocess == 0.22 16:50:07 INFO - mozprofile == 0.27 16:50:07 INFO - mozrunner == 6.11 16:50:07 INFO - mozscreenshot == 0.1 16:50:07 INFO - mozsystemmonitor == 0.0 16:50:07 INFO - moztest == 0.7 16:50:07 INFO - mozversion == 1.4 16:50:07 INFO - psutil == 3.1.1 16:50:07 INFO - requests == 1.2.3 16:50:07 INFO - wsgiref == 0.1.2 16:50:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:50:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:50:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:50:07 INFO - Using env: {'DISPLAY': ':0', 16:50:07 INFO - 'HOME': '/home/cltbld', 16:50:07 INFO - 'LANG': 'en_US.UTF-8', 16:50:07 INFO - 'LANGUAGE': 'en_US:en', 16:50:07 INFO - 'LOGNAME': 'cltbld', 16:50:07 INFO - 'MAIL': '/var/mail/cltbld', 16:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:07 INFO - 'MOZ_NO_REMOTE': '1', 16:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:07 INFO - 'NO_EM_RESTART': '1', 16:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:07 INFO - 'SHELL': '/bin/bash', 16:50:07 INFO - 'SHLVL': '1', 16:50:07 INFO - 'TERM': 'linux', 16:50:07 INFO - 'TMOUT': '86400', 16:50:07 INFO - 'USER': 'cltbld', 16:50:07 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:07 INFO - '_': '/tools/buildbot/bin/python'} 16:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:08 INFO - Cleaning up... 16:50:08 INFO - Return code: 0 16:50:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:50:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:50:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:50:08 INFO - Using env: {'DISPLAY': ':0', 16:50:08 INFO - 'HOME': '/home/cltbld', 16:50:08 INFO - 'LANG': 'en_US.UTF-8', 16:50:08 INFO - 'LANGUAGE': 'en_US:en', 16:50:08 INFO - 'LOGNAME': 'cltbld', 16:50:08 INFO - 'MAIL': '/var/mail/cltbld', 16:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:08 INFO - 'MOZ_NO_REMOTE': '1', 16:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:08 INFO - 'NO_EM_RESTART': '1', 16:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:08 INFO - 'SHELL': '/bin/bash', 16:50:08 INFO - 'SHLVL': '1', 16:50:08 INFO - 'TERM': 'linux', 16:50:08 INFO - 'TMOUT': '86400', 16:50:08 INFO - 'USER': 'cltbld', 16:50:08 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:08 INFO - '_': '/tools/buildbot/bin/python'} 16:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:08 INFO - Downloading/unpacking jsonschema 16:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:50:10 INFO - Downloading/unpacking functools32 (from jsonschema) 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:10 INFO - warning: no files found matching '*.txt' 16:50:10 INFO - no previously-included directories found matching 'build' 16:50:10 INFO - no previously-included directories found matching 'dist' 16:50:10 INFO - no previously-included directories found matching '.git*' 16:50:10 INFO - Installing collected packages: jsonschema, functools32 16:50:10 INFO - Running setup.py install for functools32 16:50:10 INFO - warning: no files found matching '*.txt' 16:50:10 INFO - no previously-included directories found matching 'build' 16:50:10 INFO - no previously-included directories found matching 'dist' 16:50:10 INFO - no previously-included directories found matching '.git*' 16:50:10 INFO - Successfully installed jsonschema functools32 16:50:10 INFO - Cleaning up... 16:50:10 INFO - Return code: 0 16:50:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63c251f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', '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 16:50:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:50:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:50:10 INFO - Using env: {'DISPLAY': ':0', 16:50:10 INFO - 'HOME': '/home/cltbld', 16:50:10 INFO - 'LANG': 'en_US.UTF-8', 16:50:10 INFO - 'LANGUAGE': 'en_US:en', 16:50:10 INFO - 'LOGNAME': 'cltbld', 16:50:10 INFO - 'MAIL': '/var/mail/cltbld', 16:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:10 INFO - 'MOZ_NO_REMOTE': '1', 16:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:10 INFO - 'NO_EM_RESTART': '1', 16:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:10 INFO - 'SHELL': '/bin/bash', 16:50:10 INFO - 'SHLVL': '1', 16:50:10 INFO - 'TERM': 'linux', 16:50:10 INFO - 'TMOUT': '86400', 16:50:10 INFO - 'USER': 'cltbld', 16:50:10 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:10 INFO - '_': '/tools/buildbot/bin/python'} 16:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:10 INFO - Downloading/unpacking flake8 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:50:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:50:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:50:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:50:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:50:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:50:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:13 INFO - no previously-included directories found matching 'docs/_build' 16:50:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:50:13 INFO - Running setup.py install for pep8 16:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:13 INFO - no previously-included directories found matching 'docs/_build' 16:50:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:50:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:50:13 INFO - Cleaning up... 16:50:13 INFO - Return code: 0 16:50:13 INFO - Running post-action listener: _resource_record_post_action 16:50:13 INFO - Running post-action listener: _start_resource_monitoring 16:50:13 INFO - Starting resource monitoring. 16:50:13 INFO - ##### 16:50:13 INFO - ##### Running install step. 16:50:13 INFO - ##### 16:50:13 INFO - Running pre-action listener: _resource_record_pre_action 16:50:13 INFO - Running main action method: install 16:50:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:13 INFO - Reading from file tmpfile_stdout 16:50:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:50:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:50:13 INFO - Reading from file tmpfile_stdout 16:50:13 INFO - Output received: 16:50:13 INFO - Usage: mozinstall [options] installer 16:50:13 INFO - Options: 16:50:13 INFO - -h, --help show this help message and exit 16:50:13 INFO - -d DEST, --destination=DEST 16:50:13 INFO - Directory to install application into. [default: 16:50:13 INFO - "/builds/slave/test-pgo"] 16:50:13 INFO - --app=APP Application being installed. [default: firefox] 16:50:13 INFO - mkdir: /builds/slave/test-pgo/build/application 16:50:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:50:29 INFO - Reading from file tmpfile_stdout 16:50:29 INFO - Output received: 16:50:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:50:29 INFO - Running post-action listener: _resource_record_post_action 16:50:29 INFO - ##### 16:50:29 INFO - ##### Running run-tests step. 16:50:29 INFO - ##### 16:50:29 INFO - Running pre-action listener: _resource_record_pre_action 16:50:29 INFO - Running main action method: run_tests 16:50:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:50:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:50:29 INFO - Python 2.7.3 16:50:29 INFO - Return code: 0 16:50:29 INFO - grabbing minidump binary from tooltool 16:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd350>, '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 0x1cce250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cce6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:50:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:50:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:50:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:29 INFO - Return code: 0 16:50:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:50:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:50:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:50:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:50:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:50:30 INFO - Return code: 0 16:50:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:50:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 16:50:30 INFO - Using env: {'DISPLAY': ':0', 16:50:30 INFO - 'HOME': '/home/cltbld', 16:50:30 INFO - 'LANG': 'en_US.UTF-8', 16:50:30 INFO - 'LANGUAGE': 'en_US:en', 16:50:30 INFO - 'LOGNAME': 'cltbld', 16:50:30 INFO - 'MAIL': '/var/mail/cltbld', 16:50:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:30 INFO - 'MOZ_NO_REMOTE': '1', 16:50:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:30 INFO - 'NO_EM_RESTART': '1', 16:50:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:50:30 INFO - 'SHELL': '/bin/bash', 16:50:30 INFO - 'SHLVL': '1', 16:50:30 INFO - 'TERM': 'linux', 16:50:30 INFO - 'TMOUT': '86400', 16:50:30 INFO - 'USER': 'cltbld', 16:50:30 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400', 16:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:30 INFO - '_': '/tools/buildbot/bin/python'} 16:50:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 16:50:30 INFO - mozversion INFO | application_buildid: 20151216143013 16:50:30 INFO - mozversion INFO | application_changeset: 1cf6f364d319a2932f1fc9fac255d9d24b495075 16:50:30 INFO - mozversion INFO | application_display_name: Nightly 16:50:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:30 INFO - mozversion INFO | application_name: Firefox 16:50:30 INFO - mozversion INFO | application_remotingname: firefox 16:50:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:50:30 INFO - mozversion INFO | application_vendor: Mozilla 16:50:30 INFO - mozversion INFO | application_version: 46.0a1 16:50:30 INFO - mozversion INFO | platform_buildid: 20151216143013 16:50:30 INFO - mozversion INFO | platform_changeset: 1cf6f364d319a2932f1fc9fac255d9d24b495075 16:50:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:50:30 INFO - mozversion INFO | platform_version: 46.0a1 16:50:30 INFO - 2015-12-16 16:50:30,522 DEBUG : using testdate: 1450313430 16:50:30 INFO - 2015-12-16 16:50:30,522 DEBUG : actual date: 1450313430 16:50:30 INFO - 2015-12-16 16:50:30,612 INFO : starting webserver on 'localhost:46222' 16:50:30 INFO - 2015-12-16 16:50:30,613 INFO : Starting test suite talos-linux64-ix-011 16:50:30 INFO - 2015-12-16 16:50:30,613 INFO : Starting test dromaeo_css 16:50:30 INFO - 2015-12-16 16:50:30,614 DEBUG : operating with platform_type : linux_ 16:50:30 INFO - 2015-12-16 16:50:30,614 INFO : Initialising browser for dromaeo_css test... 16:50:30 INFO - 2015-12-16 16:50:30,630 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB5TCdG/profile http://localhost:46222/getInfo.html 16:50:35 INFO - 2015-12-16 16:50:35,109 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:50:35 INFO - 2015-12-16 16:50:35,109 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:50:35 INFO - 2015-12-16 16:50:35,109 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:50:35 INFO - 2015-12-16 16:50:35,109 DEBUG : BROWSER_OUTPUT: __metrics 16:50:35 INFO - 2015-12-16 16:50:35,173 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] 16:50:35 INFO - 2015-12-16 16:50:35,217 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] 16:50:35 ERROR - 2015-12-16 16:50:35,237 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 16:50:35 INFO - 2015-12-16 16:50:35,999 INFO : Browser initialized. 16:50:36 INFO - 2015-12-16 16:50:35,999 INFO : Running cycle 1/1 for dromaeo_css test... 16:50:36 INFO - 2015-12-16 16:50:36,000 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB5TCdG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:50:47 INFO - 2015-12-16 16:50:47,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 143126528 16:50:47 INFO - 2015-12-16 16:50:47,767 DEBUG : BROWSER_OUTPUT: 16:51:39 INFO - 2015-12-16 16:51:39,330 DEBUG : BROWSER_OUTPUT: 1450313499326 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] 16:53:48 INFO - 2015-12-16 16:53:48,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46222/tests/dromaeo/cssquery-ext.html) 16:53:49 INFO - 2015-12-16 16:53:49,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 266248192 16:53:49 INFO - 2015-12-16 16:53:49,212 DEBUG : BROWSER_OUTPUT: 16:56:51 INFO - 2015-12-16 16:56:51,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/dromaeo/cssquery-ext.html (next: http://localhost:46222/tests/dromaeo/cssquery-jquery.html) 16:56:52 INFO - 2015-12-16 16:56:52,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 224514048 16:56:52 INFO - 2015-12-16 16:56:52,090 DEBUG : BROWSER_OUTPUT: 16:59:54 INFO - 2015-12-16 16:59:54,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46222/tests/dromaeo/cssquery-mootools.html) 16:59:54 INFO - 2015-12-16 16:59:54,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 215494656 16:59:54 INFO - 2015-12-16 16:59:54,676 DEBUG : BROWSER_OUTPUT: 17:02:56 INFO - 2015-12-16 17:02:56,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46222/tests/dromaeo/cssquery-prototype.html) 17:02:57 INFO - 2015-12-16 17:02:57,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 201465856 17:02:57 INFO - 2015-12-16 17:02:57,079 DEBUG : BROWSER_OUTPUT: 17:05:59 INFO - 2015-12-16 17:05:59,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46222/tests/dromaeo/cssquery-yui.html) 17:06:00 INFO - 2015-12-16 17:06:00,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 205357056 17:06:00 INFO - 2015-12-16 17:06:00,059 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/dromaeo/cssquery-yui.html (next: http://localhost:46222/tests/dromaeo/cssquery-dojo.html) 17:09:02 INFO - 2015-12-16 17:09:02,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 269168640 17:09:02 INFO - 2015-12-16 17:09:02,888 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,888 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:09:02 INFO - 2015-12-16 17:09:02,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:09:02 INFO - 2015-12-16 17:09:02,889 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:09:02 INFO - 2015-12-16 17:09:02,890 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:09:02 INFO - 2015-12-16 17:09:02,891 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3110.860011299492;3168.4455220336436;3211.839408029598;3215.8070515769055;3244.724198443132;5081;5214.270002199695;5294.682319060854;5334.89330213396;5381.542568881645;5204.687718736878;5243.79024839007;5325.866853328669;5360.973195134019;5388.353397592295;4838.250071238946;4884.242942343924;4902.313676085351;5043.798248070073;5056.595472362203;4984.4018717753925;4994.1260279451135;5069.974650126745;5073.543381095701;5099.184130539114;4682.6019788318035;4734.289856521515;4785.808567657289;4843.515648435164;4948.430930442991;4835.05716385305;4843.467218605951;4845.781939812717;4853.587445067174;4870.0746858096845;4792.041591681677;4844.418669759616;4845.781939812681;4855.101806165835;4857.489963553847;5030.2957585938;5066.923996140061;5189.143791274435;5193.792248310063;5211.557017653504;5812.215350927655;5814.592978491507;5815.040518314473;5817.156512305734;5828.242328497311;5802.042662960649;5808.157817116495;5827.708614569255;5829.125631155361;5835;5151.098557752378;5223.6343455958095;5249.212618107238;5305.973470132624;5376.542993845528;5855.941440585625;5868.735906884201;5894.616849904743;5899.587028907935;5906.5570082244;5629.521490673257;5670.036093864053;5670.319561652545;5674.517665998354;5679.261695979496;5507.201455788888;5548.639338442988;5612.242347283064;5766.88466230673;5767.192593036978;5551.250581171571;5588.4690954360085;5592.2730045094695;5620.269364982608;5672.8865422691315;5785.30576330843;5864.179014937912;5869;5870.383609721003;5871.941280587225;4344.326629372453;4387.122575484916;4462;4497.685162038626;4561.543845615478;3948.1314110895555;3956.7032472564097;3978.701597380208;3987.5813039631003;4008.4588580541836;5399.325084364455;5403.108487099585;5404.0272750905215;5410.431904650034;5449.972750136303;5526.4749848765105;5551.611387202857;5664.037113690682;5664.6034777566;5772.62477938941;5443.074677304868;5449.6730196188355;5463.207834864002;5463.508284254436;5482.479164479368;5072.137736584789;5075.3148324975655;5076.923846142311;5077.111505486525;5124.282600435942;5674.205611214434;5738.626989245686;5800.274965629296;5841.18223448726;5948.434898684618;5839.824805255849;5844.181814546052;5851.268591426072;5857.824265272048;5888.705564721832;5963.224780778471;5963.91054134197;5966.164736936919;5967.701614919323;5995.640261584319;5400.729963501888;5473.370562385217;5495.038368285454;5574.108142697149;5780.624259423124;5817.243758311392;5855.209546711139;5868.882622347614;5873.706314684163;5881.117832325185;5675.233843431249;5677.829665110054;5679.460451257124;5681.318241811009;5681.971590142023;5374.785008599769;5460.726963651722;5469.835904922858;5475.397706252229;5595.692236927008;5599.244102046172;5605.1872478491205;5607.186957891165;5614.017546929189;5618.747156378055;5729.3984131665575;5730.484256416942;5736.627119237236;5742.827715168552;5796.362400135898;5271.1302635064785;5368.892622147457;5374.0864053111845;5483.424240454695;5630.23991761107 17:09:02 INFO - 2015-12-16 17:09:02,894 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.7216391804095;590.7902694543437;597.9790707325242;598.9431004054615;602.647451241024;30073.398532029372;38185.61814381855;38730.41904371437;38748.41877371842;38780.80609596955;42192.57807421925;42600.78699606498;42767.78616106923;42802.57197428025;42887.57112428875;7598.582077985709;7738.342240909529;8763.956180219106;9018.909810901905;9023.323250756186;10369.325993810417;10578;10592.25854190207;10608.681739547786;10611.681649550526;10451.790964180711;10460.215483838743;10528.315659482108;10552.683419497389;10558.736031599195;7822.804429889241;8003.719869804587;8027.397945154137;10315.174786017138;10557.577696892115;10255.384676919408;10348.482575871252;10372.481375931173;10378.273520853543;10380.636677716318;39521.60478395208;40306.79846600748;40420.393694094615;40431.7978410109;40432.19135617271;3283.5731354923946;3813.8544506577105;3832.2910261601414;3868.729188956774;3945.28984782739;30149.381645689424;30166.095017149302;30957;31414.371712565848;31563.52654710181;3875.922481550353;3926.096997690547;3931.213757248533;3952.288588054149;3960.2871483133026;266096;266118;267580;267998.66000670067;268107;55190.72404637951;56110.15834762482;58294.7085264571;58638.4136158633;62769.37230627727;58106.7094664524;58116.4188358111;58274;58341.70829145827;58368.708156458946;14224.857751422353;14312.212828294543;14418;14463.13221206731;14483.406825249425;10647.361158330525;10700.571977120984;10710.678679639623;10718.35689858611;10745;19289.25388642452;19651.803481965282;19668.90165549163;19730.90134549318;19779.703304450446;7838.372930165573;8045.356371490267;8065.475744076616;8193.262606365455;8199.877001844978;1017.8371460566422;1021.0147207944221;1024.9545463627207;1036.2694300518117;1050.0339687487376;24051.27846164583;26972.190834275003;27040.18879433581;28525.14424567266;29317.120486385444;986.4525188520297;1023.9078482936571;1028.565151613495;1078.8219943709357;1113.1150735165563;14075.648108797157;14298.784603308628;14480;14527;14535;313636;316216;316332;316852;317967;49963;50040.49959500358;50136;50180.74909625429;50337.496625034015;1271.4024408527978;1290.2967882504058;1353.485675443345;1361.8706222908809;1366.5422083602105;24854.00583976693;25792.871035645454;25870.61194082128;26217.344566385993;27610.171694849185;41094.1781164369;41382.586174137876;41387;41397.586024140575;41449.37825932674;224867;228098;276938;279342;292773;29733.10800675983;30524.236894076937;30697.232569185948;31004.844975774977;31032.22419439532;42172.57827421809;42728.78635606802;42763.78618106889;43608;43883.341749873136;36409.817950910074;36629;36826.8158659205;37194.256114878095;37859.432108517845;36149;36851.81574092113;39090.80454597709;39746;40281.1943761129;34226.65773342235;34988.82505587456;34997.82501087478;35019.64980350164;35210.64789352176;30331;31666.525002125447;32099.839500802347;32188;32190.517142242417;24645.630315544924;24982.875085624455;25121.246362609152;25227.74772252254;25470.235892923243 17:09:02 INFO - 2015-12-16 17:09:02,896 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.48668937235;354.7534463547834;358.88874448920836;359.20615439877866;359.80750298590243;13971.091879027856;14399.856001439983;16194.757078643815;16463.917680411596;17195;15801.288941997609;16206.35174593015;16624.75062874055;16952.660946781056;16969.74545381817;5412.756425960842;5540.750666220029;5541.972290138544;5545.1682247662975;5546.417626149257;4019.2765302245584;4130.277201489742;5482.671039737628;5916.822495325147;6089.147519347295;5968.4031596840405;5992.400759924017;6005.039193729004;6017.157597936292;6023.909641355383;5169.3279873616375;5294.205869119663;5315.096433606296;5315.3621565412395;5317.096093664087;4756.619470442356;5095.0574143783515;5211.817586384458;5215.243789650517;5220.243064755589;12221.755564888741;12403.13178077535;12570.434330455151;19547.706784398244;19803.306884258982;2029.5433527456353;2079.147549504711;2093.099967014183;2093.2464312847515;2097.9854571462624;9103.772405689911;9248;9591.760205994837;11934.224275422157;12558.560450384284;1626.0812640857996;1644.5477493689211;1653.1816750708356;1673.146695185452;1685.2247965935685;59072;61264.69367653133;61384.69307653478;61561.6921915392;61866.38133618696;9768.90231097694;9808.950955245178;9816.607335706634;9819.754506137404;9887.80224395508;12588;12602.684932876751;12686.682832929251;12688.619341419771;12698.174618649758;7274.563526188445;7346.045014148127;7363.852722945511;7376.299251571092;7433.85132297351;7218.67515961783;7225.132984041844;7270;7273.709051637875;7281.1990681025045;3951.407288906687;3964.8810535683974;3976.8011599419915;4257.723247988871;4268.573142685706;1685.991570042142;1719.9914000430167;1741.5733145379463;1765.161548264564;1775.7691500104904;921.3274309753783;928.5171710710528;964.9951750241345;991.8165139449225;1027.1012863744224;13354;15742.134182619837;15853.207339633203;16118.274677639534;16242.75635865463;860.655737704923;932.9626814927327;936.4007035497287;949.5584553182803;984.5520288268821;8537.359698022548;9143.13140251675;9684.41893486379;10343.741406464747;10421.062104410488;463828;470696;492386;555815;562944;78923.60538197387;79478.60260698659;81700.59149704213;82291;83431.58284208662;1146.507001989136;1149.40231079838;1164.4177911044478;1166.0904494494139;1167.0371943147106;14668;14716.484923027643;14958.476453324081;15041.548753537412;15320.31058602388;34685.826570866986;34732.82633586917;34822.30355392928;35698.929032129075;35958.46062309015;45182;45584.54415455803;45811.31283030824;46710.76644616755;47003.52996469991;9299.488528130747;9422.623095076395;9443.338966272295;9537.284703647116;9548.713538593853;16105.597360066093;16498.17509124563;17130.48608541746;17161.485155445356;17366.826331737026;13970;14133.363998619881;14283.64290892736;14403.279836008367;14469.638259043608;14183.574492765234;14362.712745745235;14399.640008999859;14761.55715328542;14908;11505.42472876336;12808.423620937267;14626.780598290821;14824.110553366832;14928.552143435714;9533.856992144985;9558.522073896416;9581.952090239503;9694.709158725249;9710.951445242728;9407.85888211691;9483.620655173716;11159.665210043711;14272.072315299472;14729.558113256191 17:09:02 INFO - 2015-12-16 17:09:02,899 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1339.3035621476827;1459.168274083772;1502.3089378885716;1658.601935535471;1791.4715159028078;6674.8998765018505;7467.402607791377;7594.544327340356;7600.5439673619485;7619.695212191519;7305.159906610741;7483.214262502427;7485.700571977114;7485.775426737193;7489.887651685215;1939.5539026024023;1970.4975231315993;1971.4677037199947;2235.1953296813135;2270.126001489422;2217.1907253852387;2258.2209137847417;2260.1750361118156;2261.1520679745095;2261.434641339665;2175.6627722703006;2202.449387653087;2254.1096266974537;2254.4363909022745;2255.323402979108;2228.0419419649543;2254.5908806995626;2275.340151356105;2282.2126366403563;2285.919992800252;2194.703714998471;2196;2223.7998580127705;2224.9666255006186;2225.688403623494;7426.443016773764;7518.060242469692;7535.171131175621;7535.849283014364;7539.132999705049;4523.163214805239;4601.539846015406;4615.515370886043;4615.792289346954;4649.558291962258;2906;2982.328975980409;3014.954775678367;3027.1070034339923;3032.6209223847018;972.4214092614953;975.5366201054443;994.4232345239743;999.7100840756171;1036.0054347826097;10513.52689128991;10519.84220236697;10521.210909181766;10523.263371563993;10530.210234232387;4121.773302468393;4169.749815011109;4192.601702838226;4230.048239146229;4234.428352172479;8966.86549701755;8997.64009439615;9017.909820901707;9019.774505637411;9020.954895225614;4656.231721765938;4658.091672123971;4690.202665546797;4706.317583950308;4706.623470122382;4297.806598703066;4314.848980285675;4319.049809042006;4322.978385108117;4327.653787696977;3348.28011977426;3389.18659521713;3474.3919814032442;3534.8939531814085;3553.786772793589;1148.1274231584057;1150.8906653867868;1156.0982433701727;1159.6694941941507;1159.8086315757805;1080.3193987787802;1084.2843723142687;1133.9659810205708;1227.533537255855;1326.1512631915582;7082.645867706594;7090.326418990291;7135.464840136907;7159.821004474929;7219.855602887913;1091.9672409827717;1113.6858506961862;1117.0728295514702;1121.3832392184265;1165.4198997938183;5576.191452239403;5681.289838770153;5695.7152142392715;5697.344805347355;5704.087346024699;8455.49267043967;8568.742937711879;8746.606402711894;8781.868271975925;8869.512176830336;8624.223819856243;8680.001799792979;8764.78088047804;8766.868496972551;8879.24526415262;6455;6621.238557565845;6678.3989440950545;6713.194416669933;6739.764108256188;6644.036614690746;6693.531452798257;6745.123133992746;6752.493562982894;6775.62734049632;7810.531368117931;7987.081485629227;7998.280154786097;8029.197080292158;8031.237032481905;7997.480163789335;8191.180881911761;8242.917570824215;8256.958715206385;8296.543690097102;5969.343372228965;6291.245050593958;6688.3646053624825;6760.830979225362;6781.796546103625;6596.274409815012;6697.196336439659;7060.399866011447;7163.7492687755675;7205.747798827016;6579.046038324321;6638.634875081917;6707.295733947865;6756.560823546453;6833.077534532973;6630.53586248958;6698.56459330142;6726.125603671491;6814.318568143146;6834.829129271808;6873.759418420531;6915.619640919797;6918.93081069203;6930.203026652;6932.930670693228;6065.272167339947;6246.437820596168;6275.309715931336;6286.748530058747;6299.307076221704;6142.293636231711;6390.073439351361;6390.424861762278;6396.360363963567;6421.036844473367 17:09:02 INFO - 2015-12-16 17:09:02,901 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.9323941972185;325.76382122960854;327.78202495340605;328.65819547670424;334.46151695769805;6066.757329706812;6097.512199024079;6139.754409823608;6153.077038444236;6179.66011869347;5744.741486633101;5846.707664616773;5900.29196496421;6024.066269728188;6030.517558595313;4593.1961906666365;4605.332226827108;4628.444586649607;4638.420197475316;4638.4665763437215;4402.647788176954;4625.421822272216;4634.142683603527;4635.791389387468;4639.559241872033;4443.688941774077;4482.708623939449;4565.018521017981;4569.748663823489;4600.7929643166135;4553.157665831832;4582.1064892346;4587.7017993830295;4599.816007359702;4606.815727370935;4027.234825383168;4028;4029.6171863672903;4029.6776257899296;4033.092554175287;5573.470520300565;5725.026745453283;5725.570582206351;5729.885402291972;5739.225204597367;5256.658317209369;5269.841904742825;5274.973625131888;5286.841394758163;5291.497307755757;6384.265809431929;6387.041943708435;6389.297177310492;6390.840228994266;6392.904106438407;4320.891977700583;4325.091730736518;4326.6538676905775;4334.32817913224;4335.1979883721615;6518;6579.2104947406615;6588;6608.471322294205;6626.171728533934;4425.269830478;4441.600255976978;4446.221911165533;4453.109378124388;4457.955420445754;4471.23988921884;4495.64034877209;4507.706999045052;4513.661475389359;4520.208963431386;5225.895482090413;5241.580673546107;5252.319257837532;5257.395399529103;5257.4742525747115;6309.305976342599;6431.549791514549;6454.580452270588;6461.0631458438265;6463.612183269019;1579.9526014219591;1601.4234875444831;1601.735713607265;1601.871850251977;1602.7115119278642;1046.890076541952;1057.7249915021996;1058.047757018674;1072.5280876414354;1077.7197928538637;6147.600405973598;6152.0156774915795;6160.476359509492;6163.322034576193;6172.8765424691255;6389.840253993594;6631.403173714389;6646.136002319764;6648.069270302161;6658.267590565034;6077.635341879413;6089;6201.534884883652;6203.751849926042;6210.130581718563;3560.5549306336707;3609.9819500902327;3611.1694310308776;3613.4218525035867;3619.040954147153;6699.196096468455;6826.146731658543;6835.487338449636;6839.760608378683;6845.178578570504;6819.829504262334;6851.2806155353965;6857.211420686585;6859.2454829968665;6869.072675188885;6807;6841.657917104125;6854.760083397057;6856.142982127134;6869.656517174121;6586.901196481961;6642.900356494753;6700.530962832555;6708;6716.932830671826;6596.70314835824;6600.438962688226;6609.041688955171;6609.339066093545;6610.8347291318105;6804.829879253059;6809.69356378974;6810.31896810315;6814.420774234048;6819.795406137824;4377.649788016887;4441.4892287387365;4445;4458.643308535245;4464.218761716752;6652.434543063894;6670.266270710315;6675.432588229861;6678.499112566674;6686.431653309329;6494.253160886558;6494.383033611799;6494.960806270974;6505.121808555974;6514.0880276760345;6320;6464.676766161767;6483.902741458976;6490.610563366213;6500.512461565307;6304.369563043659;6306.337834527309;6310.05349197624;6311.147995020797;6311.652859092794;6488.967555162194;6502.284748677547;6505.934940650723;6508.739650413931;6509.7396104155305;6175.289841668266;6301.4328710416285;6342.429181373698;6356.841078973062;6359.904601431075 17:09:02 INFO - 2015-12-16 17:09:02,902 DEBUG : BROWSER_OUTPUT: |5;yui.html;818.8433094751871;819.3977426591455;825.5524354789096;838.6771093129144;857.2242120880603;12576.874231257685;12665.430055647495;12677.429515671794;12855.35723213839;12873.098883078188;12468.937655311733;14779.187144707037;15123.24383780812;15150.848491515082;15160.317785699643;659.1036190780535;667.8497338098913;798.3453568074196;807.9717209897655;809.2554849538438;795.3557618329172;803.5901690138043;812.7968007998;814.0597609760706;815.0097631377874;837.1084794693662;845.2266176448542;846.1327139681814;846.2130218896424;846.4159729786459;686.6086330791451;696.4846013949641;696.6342670098163;697.870893884633;839.1105428246049;612.1124369664005;622.0886401421939;624.1667374055642;624.2602516018487;624.3849807939176;12705.428255728515;12824.166429182073;12832;12872;12912.225266483947;10962.397068161248;11337;11376.943115284454;11498.597549085825;11695.415229238504;9205.935642304155;9430.10414010668;9430.10414010668;9541;9716.659916902945;3499.61504234534;3520.7887526748477;3563.893083207508;3635.363811333006;3637.3089113068695;47168.29247561289;47386.52613473855;47389.28916066227;47513.28730069086;47671.76164119192;8505.74482765518;8731.912680873236;8834.734957951272;9029.729108126767;9100.544972751468;16984.49046528606;17027.40404085851;17038.06290654026;17047.48857534276;17056.829431705773;6897.896531552031;6929.029935808991;6942.375186233263;7168.88827269307;7188.353048225685;4112.547619761824;4120.484939382577;4151.7924103794685;4159.209750147463;4164.37534369847;2845.8292502449917;2869.153599688097;2875.6549214094443;2877.309445733051;2886.1197334812664;497.40311626048884;518.1761000010002;528.6378830501119;534.593708781329;534.6391185949468;485.6333468231533;608.3551435478407;628.7233617208414;645.6965226343611;687.52560733094;7727.459077864495;7994.560299183485;8043.316318112909;8300.916990830136;8351.29014033814;512.2521119165984;655.9376859198369;661.6823924516259;663.134609334813;678.1861765880963;3773.7735735855936;3814.504114465102;3832.136721581732;3834.084046923691;3841.327767640652;59132;59676;60050.699746500984;60169.097463538084;60336.396636033955;52888.20667689988;53399.733001334745;53417.46582534203;53453.465465345624;53539.464605353445;47441.76279118582;48008.5199148004;48236;48314.516854831;48332;7804.765857024071;7866.567338796421;7985.560794156378;8092.595370231583;8094.959525202336;34256.48615270723;34521.482177766855;34525.48211776775;34911.47632785561;35736.28527429385;43136;43159.568404315556;43176;45131.54868451274;46199.3070103942;11251.212415130862;11478.311301321948;11502.53989840397;11595.884041159481;11749.76500470003;11144.609938652433;11185.21703480781;11351.943240283746;11845.348505832262;12176.695582610151;10316.587336506456;10537.736556586147;10596.364218146937;11191.944040279746;11436.485358158736;10598.947005264925;10842.620508282173;10853.620123295646;11029.503672334604;11261.605843795427;10318.17454603645;10580.206484513847;10614.522346494272;10637.680869573926;10715.624953126604;8970.775730606787;9202.493862837608;9498.430094194371;9500.90499095028;9530.95234523823;8637.265832404064;8709.738707838775;8767.044411021487;8908.688195913111;9399.154076133182 17:09:02 INFO - 2015-12-16 17:09:02,902 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:09:02 INFO - 2015-12-16 17:09:02,902 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:09:02 INFO - 2015-12-16 17:09:02,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,893 17:09:02 INFO - 2015-12-16 17:09:02,903 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:09:02 INFO - 2015-12-16 17:09:02,903 DEBUG : BROWSER_OUTPUT: __startTimestamp1450314542888__endTimestamp 17:09:02 INFO - 2015-12-16 17:09:02,903 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,903 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:09:02 INFO - 2015-12-16 17:09:02,903 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:09:02 INFO - 2015-12-16 17:09:02,904 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,904 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5330.53 Median:5475.40 stddev:592.19 (10.8%) stddev-sans-first:567.83 17:09:02 INFO - 2015-12-16 17:09:02,905 DEBUG : BROWSER_OUTPUT: Values: 3110.9 3168.4 3211.8 3215.8 3244.7 5081.0 5214.3 5294.7 5334.9 5381.5 5204.7 5243.8 5325.9 5361.0 5388.4 4838.3 4884.2 4902.3 5043.8 5056.6 4984.4 4994.1 5070.0 5073.5 5099.2 4682.6 4734.3 4785.8 4843.5 4948.4 4835.1 4843.5 4845.8 4853.6 4870.1 4792.0 4844.4 4845.8 4855.1 4857.5 5030.3 5066.9 5189.1 5193.8 5211.6 5812.2 5814.6 5815.0 5817.2 5828.2 5802.0 5808.2 5827.7 5829.1 5835.0 5151.1 5223.6 5249.2 5306.0 5376.5 5855.9 5868.7 5894.6 5899.6 5906.6 5629.5 5670.0 5670.3 5674.5 5679.3 5507.2 5548.6 5612.2 5766.9 5767.2 5551.3 5588.5 5592.3 5620.3 5672.9 5785.3 5864.2 5869.0 5870.4 5871.9 4344.3 4387.1 4462.0 4497.7 4561.5 3948.1 3956.7 3978.7 3987.6 4008.5 5399.3 5403.1 5404.0 5410.4 5450.0 5526.5 5551.6 5664.0 5664.6 5772.6 5443.1 5449.7 5463.2 5463.5 5482.5 5072.1 5075.3 5076.9 5077.1 5124.3 5674.2 5738.6 5800.3 5841.2 5948.4 5839.8 5844.2 5851.3 5857.8 5888.7 5963.2 5963.9 5966.2 5967.7 5995.6 5400.7 5473.4 5495.0 5574.1 5780.6 5817.2 5855.2 5868.9 5873.7 5881.1 5675.2 5677.8 5679.5 5681.3 5682.0 5374.8 5460.7 5469.8 5475.4 5595.7 5599.2 5605.2 5607.2 5614.0 5618.7 5729.4 5730.5 5736.6 5742.8 5796.4 5271.1 5368.9 5374.1 5483.4 5630.2 17:09:02 INFO - 2015-12-16 17:09:02,905 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,905 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45108.44 Median:173999.26 stddev:73784.77 (42.4%) stddev-sans-first:73915.93 17:09:02 INFO - 2015-12-16 17:09:02,906 DEBUG : BROWSER_OUTPUT: Values: 556.7 590.8 598.0 598.9 602.6 30073.4 38185.6 38730.4 38748.4 38780.8 42192.6 42600.8 42767.8 42802.6 42887.6 7598.6 7738.3 8764.0 9018.9 9023.3 10369.3 10578.0 10592.3 10608.7 10611.7 10451.8 10460.2 10528.3 10552.7 10558.7 7822.8 8003.7 8027.4 10315.2 10557.6 10255.4 10348.5 10372.5 10378.3 10380.6 39521.6 40306.8 40420.4 40431.8 40432.2 3283.6 3813.9 3832.3 3868.7 3945.3 30149.4 30166.1 30957.0 31414.4 31563.5 3875.9 3926.1 3931.2 3952.3 3960.3 266096.0 266118.0 267580.0 267998.7 268107.0 55190.7 56110.2 58294.7 58638.4 62769.4 58106.7 58116.4 58274.0 58341.7 58368.7 14224.9 14312.2 14418.0 14463.1 14483.4 10647.4 10700.6 10710.7 10718.4 10745.0 19289.3 19651.8 19668.9 19730.9 19779.7 7838.4 8045.4 8065.5 8193.3 8199.9 1017.8 1021.0 1025.0 1036.3 1050.0 24051.3 26972.2 27040.2 28525.1 29317.1 986.5 1023.9 1028.6 1078.8 1113.1 14075.6 14298.8 14480.0 14527.0 14535.0 313636.0 316216.0 316332.0 316852.0 317967.0 49963.0 50040.5 50136.0 50180.7 50337.5 1271.4 1290.3 1353.5 1361.9 1366.5 24854.0 25792.9 25870.6 26217.3 27610.2 41094.2 41382.6 41387.0 41397.6 41449.4 224867.0 228098.0 276938.0 279342.0 292773.0 29733.1 30524.2 30697.2 31004.8 31032.2 42172.6 42728.8 42763.8 43608.0 43883.3 36409.8 36629.0 36826.8 37194.3 37859.4 36149.0 36851.8 39090.8 39746.0 40281.2 34226.7 34988.8 34997.8 35019.6 35210.6 30331.0 31666.5 32099.8 32188.0 32190.5 24645.6 24982.9 25121.2 25227.7 25470.2 17:09:02 INFO - 2015-12-16 17:09:02,906 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,907 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27718.83 Median:3998.04 stddev:83599.49 (2091.0%) stddev-sans-first:83808.75 17:09:02 INFO - 2015-12-16 17:09:02,907 DEBUG : BROWSER_OUTPUT: Values: 354.5 354.8 358.9 359.2 359.8 13971.1 14399.9 16194.8 16463.9 17195.0 15801.3 16206.4 16624.8 16952.7 16969.7 5412.8 5540.8 5542.0 5545.2 5546.4 4019.3 4130.3 5482.7 5916.8 6089.1 5968.4 5992.4 6005.0 6017.2 6023.9 5169.3 5294.2 5315.1 5315.4 5317.1 4756.6 5095.1 5211.8 5215.2 5220.2 12221.8 12403.1 12570.4 19547.7 19803.3 2029.5 2079.1 2093.1 2093.2 2098.0 9103.8 9248.0 9591.8 11934.2 12558.6 1626.1 1644.5 1653.2 1673.1 1685.2 59072.0 61264.7 61384.7 61561.7 61866.4 9768.9 9809.0 9816.6 9819.8 9887.8 12588.0 12602.7 12686.7 12688.6 12698.2 7274.6 7346.0 7363.9 7376.3 7433.9 7218.7 7225.1 7270.0 7273.7 7281.2 3951.4 3964.9 3976.8 4257.7 4268.6 1686.0 1720.0 1741.6 1765.2 1775.8 921.3 928.5 965.0 991.8 1027.1 13354.0 15742.1 15853.2 16118.3 16242.8 860.7 933.0 936.4 949.6 984.6 8537.4 9143.1 9684.4 10343.7 10421.1 463828.0 470696.0 492386.0 555815.0 562944.0 78923.6 79478.6 81700.6 82291.0 83431.6 1146.5 1149.4 1164.4 1166.1 1167.0 14668.0 14716.5 14958.5 15041.5 15320.3 34685.8 34732.8 34822.3 35698.9 35958.5 45182.0 45584.5 45811.3 46710.8 47003.5 9299.5 9422.6 9443.3 9537.3 9548.7 16105.6 16498.2 17130.5 17161.5 17366.8 13970.0 14133.4 14283.6 14403.3 14469.6 14183.6 14362.7 14399.6 14761.6 14908.0 11505.4 12808.4 14626.8 14824.1 14928.6 9533.9 9558.5 9582.0 9694.7 9711.0 9407.9 9483.6 11159.7 14272.1 14729.6 17:09:02 INFO - 2015-12-16 17:09:02,908 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,908 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5258.40 Median:6281.03 stddev:2685.20 (42.8%) stddev-sans-first:2676.58 17:09:02 INFO - 2015-12-16 17:09:02,909 DEBUG : BROWSER_OUTPUT: Values: 1339.3 1459.2 1502.3 1658.6 1791.5 6674.9 7467.4 7594.5 7600.5 7619.7 7305.2 7483.2 7485.7 7485.8 7489.9 1939.6 1970.5 1971.5 2235.2 2270.1 2217.2 2258.2 2260.2 2261.2 2261.4 2175.7 2202.4 2254.1 2254.4 2255.3 2228.0 2254.6 2275.3 2282.2 2285.9 2194.7 2196.0 2223.8 2225.0 2225.7 7426.4 7518.1 7535.2 7535.8 7539.1 4523.2 4601.5 4615.5 4615.8 4649.6 2906.0 2982.3 3015.0 3027.1 3032.6 972.4 975.5 994.4 999.7 1036.0 10513.5 10519.8 10521.2 10523.3 10530.2 4121.8 4169.7 4192.6 4230.0 4234.4 8966.9 8997.6 9017.9 9019.8 9021.0 4656.2 4658.1 4690.2 4706.3 4706.6 4297.8 4314.8 4319.0 4323.0 4327.7 3348.3 3389.2 3474.4 3534.9 3553.8 1148.1 1150.9 1156.1 1159.7 1159.8 1080.3 1084.3 1134.0 1227.5 1326.2 7082.6 7090.3 7135.5 7159.8 7219.9 1092.0 1113.7 1117.1 1121.4 1165.4 5576.2 5681.3 5695.7 5697.3 5704.1 8455.5 8568.7 8746.6 8781.9 8869.5 8624.2 8680.0 8764.8 8766.9 8879.2 6455.0 6621.2 6678.4 6713.2 6739.8 6644.0 6693.5 6745.1 6752.5 6775.6 7810.5 7987.1 7998.3 8029.2 8031.2 7997.5 8191.2 8242.9 8257.0 8296.5 5969.3 6291.2 6688.4 6760.8 6781.8 6596.3 6697.2 7060.4 7163.7 7205.7 6579.0 6638.6 6707.3 6756.6 6833.1 6630.5 6698.6 6726.1 6814.3 6834.8 6873.8 6915.6 6918.9 6930.2 6932.9 6065.3 6246.4 6275.3 6286.7 6299.3 6142.3 6390.1 6390.4 6396.4 6421.0 17:09:02 INFO - 2015-12-16 17:09:02,909 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,909 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5348.98 Median:6149.81 stddev:1633.50 (26.6%) stddev-sans-first:1593.91 17:09:02 INFO - 2015-12-16 17:09:02,910 DEBUG : BROWSER_OUTPUT: Values: 321.9 325.8 327.8 328.7 334.5 6066.8 6097.5 6139.8 6153.1 6179.7 5744.7 5846.7 5900.3 6024.1 6030.5 4593.2 4605.3 4628.4 4638.4 4638.5 4402.6 4625.4 4634.1 4635.8 4639.6 4443.7 4482.7 4565.0 4569.7 4600.8 4553.2 4582.1 4587.7 4599.8 4606.8 4027.2 4028.0 4029.6 4029.7 4033.1 5573.5 5725.0 5725.6 5729.9 5739.2 5256.7 5269.8 5275.0 5286.8 5291.5 6384.3 6387.0 6389.3 6390.8 6392.9 4320.9 4325.1 4326.7 4334.3 4335.2 6518.0 6579.2 6588.0 6608.5 6626.2 4425.3 4441.6 4446.2 4453.1 4458.0 4471.2 4495.6 4507.7 4513.7 4520.2 5225.9 5241.6 5252.3 5257.4 5257.5 6309.3 6431.5 6454.6 6461.1 6463.6 1580.0 1601.4 1601.7 1601.9 1602.7 1046.9 1057.7 1058.0 1072.5 1077.7 6147.6 6152.0 6160.5 6163.3 6172.9 6389.8 6631.4 6646.1 6648.1 6658.3 6077.6 6089.0 6201.5 6203.8 6210.1 3560.6 3610.0 3611.2 3613.4 3619.0 6699.2 6826.1 6835.5 6839.8 6845.2 6819.8 6851.3 6857.2 6859.2 6869.1 6807.0 6841.7 6854.8 6856.1 6869.7 6586.9 6642.9 6700.5 6708.0 6716.9 6596.7 6600.4 6609.0 6609.3 6610.8 6804.8 6809.7 6810.3 6814.4 6819.8 4377.6 4441.5 4445.0 4458.6 4464.2 6652.4 6670.3 6675.4 6678.5 6686.4 6494.3 6494.4 6495.0 6505.1 6514.1 6320.0 6464.7 6483.9 6490.6 6500.5 6304.4 6306.3 6310.1 6311.1 6311.7 6489.0 6502.3 6505.9 6508.7 6509.7 6175.3 6301.4 6342.4 6356.8 6359.9 17:09:02 INFO - 2015-12-16 17:09:02,911 DEBUG : BROWSER_OUTPUT: 17:09:02 INFO - 2015-12-16 17:09:02,911 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13663.20 Median:491.52 stddev:16353.39 (3327.1%) stddev-sans-first:16370.82 17:09:02 INFO - 2015-12-16 17:09:02,911 DEBUG : BROWSER_OUTPUT: Values: 818.8 819.4 825.6 838.7 857.2 12576.9 12665.4 12677.4 12855.4 12873.1 12468.9 14779.2 15123.2 15150.8 15160.3 659.1 667.8 798.3 808.0 809.3 795.4 803.6 812.8 814.1 815.0 837.1 845.2 846.1 846.2 846.4 686.6 696.5 696.6 697.9 839.1 612.1 622.1 624.2 624.3 624.4 12705.4 12824.2 12832.0 12872.0 12912.2 10962.4 11337.0 11376.9 11498.6 11695.4 9205.9 9430.1 9430.1 9541.0 9716.7 3499.6 3520.8 3563.9 3635.4 3637.3 47168.3 47386.5 47389.3 47513.3 47671.8 8505.7 8731.9 8834.7 9029.7 9100.5 16984.5 17027.4 17038.1 17047.5 17056.8 6897.9 6929.0 6942.4 7168.9 7188.4 4112.5 4120.5 4151.8 4159.2 4164.4 2845.8 2869.2 2875.7 2877.3 2886.1 497.4 518.2 528.6 534.6 534.6 485.6 608.4 628.7 645.7 687.5 7727.5 7994.6 8043.3 8300.9 8351.3 512.3 655.9 661.7 663.1 678.2 3773.8 3814.5 3832.1 3834.1 3841.3 59132.0 59676.0 60050.7 60169.1 60336.4 52888.2 53399.7 53417.5 53453.5 53539.5 47441.8 48008.5 48236.0 48314.5 48332.0 7804.8 7866.6 7985.6 8092.6 8095.0 34256.5 34521.5 34525.5 34911.5 35736.3 43136.0 43159.6 43176.0 45131.5 46199.3 11251.2 11478.3 11502.5 11595.9 11749.8 11144.6 11185.2 11351.9 11845.3 12176.7 10316.6 10537.7 10596.4 11191.9 11436.5 10598.9 10842.6 10853.6 11029.5 11261.6 10318.2 10580.2 10614.5 10637.7 10715.6 8970.8 9202.5 9498.4 9500.9 9531.0 8637.3 8709.7 8767.0 8908.7 9399.2 17:09:02 INFO - 2015-12-16 17:09:02,911 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:09:02 INFO - 2015-12-16 17:09:02,911 DEBUG : BROWSER_OUTPUT: 17:09:03 INFO - 2015-12-16 17:09:03,689 INFO : Browser exited with error code: 0 17:09:03 INFO - 2015-12-16 17:09:03,708 INFO : Completed test dromaeo_css (00:18:33) 17:09:03 INFO - 2015-12-16 17:09:03,708 INFO : Starting test kraken 17:09:03 INFO - 2015-12-16 17:09:03,708 DEBUG : operating with platform_type : linux_ 17:09:03 INFO - 2015-12-16 17:09:03,708 INFO : Initialising browser for kraken test... 17:09:03 INFO - 2015-12-16 17:09:03,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAUSEnl/profile http://localhost:46222/getInfo.html 17:09:07 INFO - 2015-12-16 17:09:07,628 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:09:07 INFO - 2015-12-16 17:09:07,629 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:09:07 INFO - 2015-12-16 17:09:07,629 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:09:07 INFO - 2015-12-16 17:09:07,629 DEBUG : BROWSER_OUTPUT: __metrics 17:09:07 INFO - 2015-12-16 17:09:07,705 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] 17:09:07 INFO - 2015-12-16 17:09:07,761 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] 17:09:09 INFO - 2015-12-16 17:09:09,034 INFO : Browser initialized. 17:09:09 INFO - 2015-12-16 17:09:09,034 INFO : Running cycle 1/1 for kraken test... 17:09:09 INFO - 2015-12-16 17:09:09,034 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAUSEnl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:09:20 INFO - 2015-12-16 17:09:20,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 142798848 17:09:20 INFO - 2015-12-16 17:09:20,895 DEBUG : BROWSER_OUTPUT: 17:09:23 INFO - 2015-12-16 17:09:23,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46222/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:23 INFO - 2015-12-16 17:09:23,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 178057216 17:09:23 INFO - 2015-12-16 17:09:23,978 DEBUG : BROWSER_OUTPUT: 17:09:26 INFO - 2015-12-16 17:09:26,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46222/tests/kraken/driver.html?testName=audio-dft) 17:09:27 INFO - 2015-12-16 17:09:27,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 168202240 17:09:27 INFO - 2015-12-16 17:09:27,206 DEBUG : BROWSER_OUTPUT: 17:09:30 INFO - 2015-12-16 17:09:30,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46222/tests/kraken/driver.html?testName=audio-fft) 17:09:30 INFO - 2015-12-16 17:09:30,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 154353664 17:09:30 INFO - 2015-12-16 17:09:30,656 DEBUG : BROWSER_OUTPUT: 17:09:32 INFO - 2015-12-16 17:09:32,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46222/tests/kraken/driver.html?testName=audio-oscillator) 17:09:33 INFO - 2015-12-16 17:09:33,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 154783744 17:09:33 INFO - 2015-12-16 17:09:33,205 DEBUG : BROWSER_OUTPUT: 17:09:35 INFO - 2015-12-16 17:09:35,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:35 INFO - 2015-12-16 17:09:35,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 158961664 17:09:35 INFO - 2015-12-16 17:09:35,981 DEBUG : BROWSER_OUTPUT: 17:09:38 INFO - 2015-12-16 17:09:38,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46222/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:39 INFO - 2015-12-16 17:09:39,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 156741632 17:09:39 INFO - 2015-12-16 17:09:39,425 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2015-12-16 17:09:42,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46222/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:43 INFO - 2015-12-16 17:09:43,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 158875648 17:09:43 INFO - 2015-12-16 17:09:43,357 DEBUG : BROWSER_OUTPUT: 17:09:46 INFO - 2015-12-16 17:09:46,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46222/tests/kraken/driver.html?testName=json-parse-financial) 17:09:46 INFO - 2015-12-16 17:09:46,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 157138944 17:09:46 INFO - 2015-12-16 17:09:46,659 DEBUG : BROWSER_OUTPUT: 17:09:48 INFO - 2015-12-16 17:09:48,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:48 INFO - 2015-12-16 17:09:48,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 171110400 17:09:48 INFO - 2015-12-16 17:09:48,789 DEBUG : BROWSER_OUTPUT: 17:09:50 INFO - 2015-12-16 17:09:50,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:51 INFO - 2015-12-16 17:09:51,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 167763968 17:09:51 INFO - 2015-12-16 17:09:51,167 DEBUG : BROWSER_OUTPUT: 17:09:53 INFO - 2015-12-16 17:09:53,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:53 INFO - 2015-12-16 17:09:53,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 178253824 17:09:53 INFO - 2015-12-16 17:09:53,825 DEBUG : BROWSER_OUTPUT: 17:09:56 INFO - 2015-12-16 17:09:56,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:56 INFO - 2015-12-16 17:09:56,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 185147392 17:09:56 INFO - 2015-12-16 17:09:56,836 DEBUG : BROWSER_OUTPUT: 17:09:59 INFO - 2015-12-16 17:09:59,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:00 INFO - 2015-12-16 17:10:00,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 181305344 17:10:00 INFO - 2015-12-16 17:10:00,024 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46222/tests/kraken/driver.html?testName=ai-astar) 17:10:01 INFO - 2015-12-16 17:10:01,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 240300032 17:10:01 INFO - 2015-12-16 17:10:01,955 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,958 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:10:01 INFO - 2015-12-16 17:10:01,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:10:01 INFO - 2015-12-16 17:10:01,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;110;105;112;111;112;101;111;110;119 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;157;172;127;150;163;129;165;124 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;160;162;161;162;162;161 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;96;70;70;72;97;92;70 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;148;92;92;93;141;92;92;135 17:10:01 INFO - 2015-12-16 17:10:01,959 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;110;109;110;110;109 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;146;145;146;147;146;146;145;145 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;95;95;95;96 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;58;59;58;58;57;66;55;55 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;66;67;68;67;67;67;68;68 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;87;94;85;85;85;85;86 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;116;122;112;119;122;120;122;133;132 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;141;160;149;155;139;146;149;156;145 17:10:01 INFO - 2015-12-16 17:10:01,960 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;66;69;67;66;66;67;68;67 17:10:01 INFO - 2015-12-16 17:10:01,961 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:10:01 INFO - 2015-12-16 17:10:01,961 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:10:01 INFO - 2015-12-16 17:10:01,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 17:10:01 INFO - 2015-12-16 17:10:01,961 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:10:01 INFO - 2015-12-16 17:10:01,961 DEBUG : BROWSER_OUTPUT: __startTimestamp1450314601956__endTimestamp 17:10:01 INFO - 2015-12-16 17:10:01,961 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,962 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:10:01 INFO - 2015-12-16 17:10:01,962 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:10:01 INFO - 2015-12-16 17:10:01,962 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:4.69 (4.2%) stddev-sans-first:4.96 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 105.0 112.0 111.0 112.0 101.0 111.0 110.0 119.0 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.20 Median:154.00 stddev:18.58 (12.1%) stddev-sans-first:19.62 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 157.0 172.0 127.0 150.0 163.0 129.0 165.0 124.0 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 160.0 162.0 161.0 162.0 162.0 161.0 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:76.50 stddev:11.43 (14.9%) stddev-sans-first:11.82 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 96.0 70.0 70.0 72.0 97.0 92.0 70.0 17:10:01 INFO - 2015-12-16 17:10:01,963 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:92.00 stddev:23.76 (25.8%) stddev-sans-first:24.72 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 148.0 92.0 92.0 93.0 141.0 92.0 92.0 135.0 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 145.0 145.0 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 17:10:01 INFO - 2015-12-16 17:10:01,964 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:3.07 (5.3%) stddev-sans-first:3.26 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 58.0 59.0 58.0 58.0 57.0 66.0 55.0 55.0 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 67.0 68.0 67.0 67.0 67.0 68.0 68.0 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.86 (3.3%) stddev-sans-first:2.92 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 87.0 94.0 85.0 85.0 85.0 85.0 86.0 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,965 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.00 stddev:6.48 (5.3%) stddev-sans-first:6.80 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: Values: 119.0 116.0 122.0 112.0 119.0 122.0 120.0 122.0 133.0 132.0 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:149.00 stddev:6.74 (4.5%) stddev-sans-first:7.03 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: Values: 145.0 141.0 160.0 149.0 155.0 139.0 146.0 149.0 156.0 145.0 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 69.0 67.0 66.0 66.0 67.0 68.0 67.0 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:10:01 INFO - 2015-12-16 17:10:01,966 DEBUG : BROWSER_OUTPUT: 17:10:02 INFO - 2015-12-16 17:10:02,785 INFO : Browser exited with error code: 0 17:10:02 INFO - 2015-12-16 17:10:02,838 INFO : Completed test kraken (00:00:59) 17:10:02 INFO - 2015-12-16 17:10:02,838 INFO : Starting test v8_7 17:10:02 INFO - 2015-12-16 17:10:02,838 DEBUG : operating with platform_type : linux_ 17:10:02 INFO - 2015-12-16 17:10:02,839 INFO : Initialising browser for v8_7 test... 17:10:02 INFO - 2015-12-16 17:10:02,845 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp32fikz/profile http://localhost:46222/getInfo.html 17:10:07 INFO - 2015-12-16 17:10:07,229 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:10:07 INFO - 2015-12-16 17:10:07,229 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:10:07 INFO - 2015-12-16 17:10:07,229 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:10:07 INFO - 2015-12-16 17:10:07,229 DEBUG : BROWSER_OUTPUT: __metrics 17:10:07 INFO - 2015-12-16 17:10:07,311 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] 17:10:07 INFO - 2015-12-16 17:10:07,367 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] 17:10:07 ERROR - 2015-12-16 17:10:07,375 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:10:08 INFO - 2015-12-16 17:10:08,264 INFO : Browser initialized. 17:10:08 INFO - 2015-12-16 17:10:08,265 INFO : Running cycle 1/1 for v8_7 test... 17:10:08 INFO - 2015-12-16 17:10:08,265 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp32fikz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:10:20 INFO - 2015-12-16 17:10:20,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 142852096 17:10:20 INFO - 2015-12-16 17:10:20,066 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46222/tests/v8_7/run.html (next: http://localhost:46222/tests/v8_7/run.html) 17:10:41 INFO - 2015-12-16 17:10:41,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 610189312 17:10:41 INFO - 2015-12-16 17:10:41,752 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.39487565938205 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 17:10:41 INFO - 2015-12-16 17:10:41,754 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 17:10:41 INFO - 2015-12-16 17:10:41,755 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2079.002079002079 17:10:41 INFO - 2015-12-16 17:10:41,755 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 17:10:41 INFO - 2015-12-16 17:10:41,755 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 17:10:41 INFO - 2015-12-16 17:10:41,755 DEBUG : BROWSER_OUTPUT: |7;RegExp;25769.23076923077 17:10:41 INFO - 2015-12-16 17:10:41,755 DEBUG : BROWSER_OUTPUT: |8;Splay;689.5133653187114 17:10:41 INFO - 2015-12-16 17:10:41,756 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:10:41 INFO - 2015-12-16 17:10:41,756 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:10:41 INFO - 2015-12-16 17:10:41,756 DEBUG : BROWSER_OUTPUT: __startTimestamp1450314641753__endTimestamp 17:10:41 INFO - 2015-12-16 17:10:41,756 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,756 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:10:41 INFO - 2015-12-16 17:10:41,757 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:10:41 INFO - 2015-12-16 17:10:41,757 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,757 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,757 DEBUG : BROWSER_OUTPUT: Values: 165.8 17:10:41 INFO - 2015-12-16 17:10:41,757 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,758 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,758 DEBUG : BROWSER_OUTPUT: Values: 188.4 17:10:41 INFO - 2015-12-16 17:10:41,758 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,758 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,758 DEBUG : BROWSER_OUTPUT: Values: 279.6 17:10:41 INFO - 2015-12-16 17:10:41,758 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,759 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,759 DEBUG : BROWSER_OUTPUT: Values: 5148.7 17:10:41 INFO - 2015-12-16 17:10:41,759 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,759 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2079.00 Median:2079.00 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,759 DEBUG : BROWSER_OUTPUT: Values: 2079.0 17:10:41 INFO - 2015-12-16 17:10:41,760 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,761 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,761 DEBUG : BROWSER_OUTPUT: Values: 781.9 17:10:41 INFO - 2015-12-16 17:10:41,761 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,761 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,761 DEBUG : BROWSER_OUTPUT: Values: 12345.7 17:10:41 INFO - 2015-12-16 17:10:41,761 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: Values: 25769.2 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:689.51 Median:689.51 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: Values: 689.5 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-16 17:10:41,762 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:10:41 INFO - 2015-12-16 17:10:41,763 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:10:41 INFO - 2015-12-16 17:10:41,763 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:10:41 INFO - 2015-12-16 17:10:41,763 DEBUG : BROWSER_OUTPUT: 17:10:42 INFO - 2015-12-16 17:10:42,641 INFO : Browser exited with error code: 0 17:10:42 INFO - 2015-12-16 17:10:42,656 INFO : Completed test v8_7 (00:00:39) 17:10:42 INFO - 2015-12-16 17:10:42,757 INFO : Completed test suite (00:20:12) 17:10:42 INFO - 2015-12-16 17:10:42,757 DEBUG : Working with test: dromaeo_css 17:10:42 INFO - 2015-12-16 17:10:42,757 DEBUG : Generating results file: dromaeo_css 17:10:42 INFO - 2015-12-16 17:10:42,758 DEBUG : Working with test: kraken 17:10:42 INFO - 2015-12-16 17:10:42,758 DEBUG : Generating results file: kraken 17:10:42 INFO - 2015-12-16 17:10:42,759 INFO : javascript benchmark 17:10:42 INFO - 2015-12-16 17:10:42,759 DEBUG : Working with test: v8_7 17:10:42 INFO - 2015-12-16 17:10:42,759 DEBUG : Generating results file: v8_7 17:10:42 INFO - 2015-12-16 17:10:42,759 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:42 INFO - 2015-12-16 17:10:42,890 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:10:42 INFO - 2015-12-16 17:10:42,890 DEBUG : process_Request line: dromaeo_css 6899.97 graph.html#tests=[[72,64,35]] 17:10:42 INFO - 2015-12-16 17:10:42,890 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:43 INFO - 2015-12-16 17:10:43,000 DEBUG : process_Request line: kraken 1503.60 graph.html#tests=[[232,64,35]] 17:10:43 INFO - 2015-12-16 17:10:43,000 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:43 INFO - 2015-12-16 17:10:43,030 DEBUG : process_Request line: v8_7 19521.29 graph.html#tests=[[230,64,35]] 17:10:43 INFO - 2015-12-16 17:10:43,031 INFO : javascript benchmark 17:10:43 INFO - 2015-12-16 17:10:43,035 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.860011299492, 3168.4455220336436, 3211.839408029598, 3215.8070515769055, 3244.724198443132, 5081.0, 5214.270002199695, 5294.682319060854, 5334.89330213396, 5381.542568881645, 5204.687718736878, 5243.79024839007, 5325.866853328669, 5360.973195134019, 5388.353397592295, 4838.250071238946, 4884.242942343924, 4902.313676085351, 5043.798248070073, 5056.595472362203, 4984.4018717753925, 4994.1260279451135, 5069.974650126745, 5073.543381095701, 5099.184130539114, 4682.6019788318035, 4734.289856521515, 4785.808567657289, 4843.515648435164, 4948.430930442991, 4835.05716385305, 4843.467218605951, 4845.781939812717, 4853.587445067174, 4870.0746858096845, 4792.041591681677, 4844.418669759616, 4845.781939812681, 4855.101806165835, 4857.489963553847, 5030.2957585938, 5066.923996140061, 5189.143791274435, 5193.792248310063, 5211.557017653504, 5812.215350927655, 5814.592978491507, 5815.040518314473, 5817.156512305734, 5828.242328497311, 5802.042662960649, 5808.157817116495, 5827.708614569255, 5829.125631155361, 5835.0, 5151.098557752378, 5223.6343455958095, 5249.212618107238, 5305.973470132624, 5376.542993845528, 5855.941440585625, 5868.735906884201, 5894.616849904743, 5899.587028907935, 5906.5570082244, 5629.521490673257, 5670.036093864053, 5670.319561652545, 5674.517665998354, 5679.261695979496, 5507.201455788888, 5548.639338442988, 5612.242347283064, 5766.88466230673, 5767.192593036978, 5551.250581171571, 5588.4690954360085, 5592.2730045094695, 5620.269364982608, 5672.8865422691315, 5785.30576330843, 5864.179014937912, 5869.0, 5870.383609721003, 5871.941280587225, 4344.326629372453, 4387.122575484916, 4462.0, 4497.685162038626, 4561.543845615478, 3948.1314110895555, 3956.7032472564097, 3978.701597380208, 3987.5813039631003, 4008.4588580541836, 5399.325084364455, 5403.108487099585, 5404.0272750905215, 5410.431904650034, 5449.972750136303, 5526.4749848765105, 5551.611387202857, 5664.037113690682, 5664.6034777566, 5772.62477938941, 5443.074677304868, 5449.6730196188355, 5463.207834864002, 5463.508284254436, 5482.479164479368, 5072.137736584789, 5075.3148324975655, 5076.923846142311, 5077.111505486525, 5124.282600435942, 5674.205611214434, 5738.626989245686, 5800.274965629296, 5841.18223448726, 5948.434898684618, 5839.824805255849, 5844.181814546052, 5851.268591426072, 5857.824265272048, 5888.705564721832, 5963.224780778471, 5963.91054134197, 5966.164736936919, 5967.701614919323, 5995.640261584319, 5400.729963501888, 5473.370562385217, 5495.038368285454, 5574.108142697149, 5780.624259423124, 5817.243758311392, 5855.209546711139, 5868.882622347614, 5873.706314684163, 5881.117832325185, 5675.233843431249, 5677.829665110054, 5679.460451257124, 5681.318241811009, 5681.971590142023, 5374.785008599769, 5460.726963651722, 5469.835904922858, 5475.397706252229, 5595.692236927008, 5599.244102046172, 5605.1872478491205, 5607.186957891165, 5614.017546929189, 5618.747156378055, 5729.3984131665575, 5730.484256416942, 5736.627119237236, 5742.827715168552, 5796.362400135898, 5271.1302635064785, 5368.892622147457, 5374.0864053111845, 5483.424240454695, 5630.23991761107], "unit": "score", "name": "dojo.html", "value": 5292.23277228788}, {"lowerIsBetter": false, "replicates": [556.7216391804095, 590.7902694543437, 597.9790707325242, 598.9431004054615, 602.647451241024, 30073.398532029372, 38185.61814381855, 38730.41904371437, 38748.41877371842, 38780.80609596955, 42192.57807421925, 42600.78699606498, 42767.78616106923, 42802.57197428025, 42887.57112428875, 7598.582077985709, 7738.342240909529, 8763.956180219106, 9018.909810901905, 9023.323250756186, 10369.325993810417, 10578.0, 10592.25854190207, 10608.681739547786, 10611.681649550526, 10451.790964180711, 10460.215483838743, 10528.315659482108, 10552.683419497389, 10558.736031599195, 7822.804429889241, 8003.719869804587, 8027.397945154137, 10315.174786017138, 10557.577696892115, 10255.384676919408, 10348.482575871252, 10372.481375931173, 10378.273520853543, 10380.636677716318, 39521.60478395208, 40306.79846600748, 40420.393694094615, 40431.7978410109, 40432.19135617271, 3283.5731354923946, 3813.8544506577105, 3832.2910261601414, 3868.729188956774, 3945.28984782739, 30149.381645689424, 30166.095017149302, 30957.0, 31414.371712565848, 31563.52654710181, 3875.922481550353, 3926.096997690547, 3931.213757248533, 3952.288588054149, 3960.2871483133026, 266096.0, 266118.0, 267580.0, 267998.66000670067, 268107.0, 55190.72404637951, 56110.15834762482, 58294.7085264571, 58638.4136158633, 62769.37230627727, 58106.7094664524, 58116.4188358111, 58274.0, 58341.70829145827, 58368.708156458946, 14224.857751422353, 14312.212828294543, 14418.0, 14463.13221206731, 14483.406825249425, 10647.361158330525, 10700.571977120984, 10710.678679639623, 10718.35689858611, 10745.0, 19289.25388642452, 19651.803481965282, 19668.90165549163, 19730.90134549318, 19779.703304450446, 7838.372930165573, 8045.356371490267, 8065.475744076616, 8193.262606365455, 8199.877001844978, 1017.8371460566422, 1021.0147207944221, 1024.9545463627207, 1036.2694300518117, 1050.0339687487376, 24051.27846164583, 26972.190834275003, 27040.18879433581, 28525.14424567266, 29317.120486385444, 986.4525188520297, 1023.9078482936571, 1028.565151613495, 1078.8219943709357, 1113.1150735165563, 14075.648108797157, 14298.784603308628, 14480.0, 14527.0, 14535.0, 313636.0, 316216.0, 316332.0, 316852.0, 317967.0, 49963.0, 50040.49959500358, 50136.0, 50180.74909625429, 50337.496625034015, 1271.4024408527978, 1290.2967882504058, 1353.485675443345, 1361.8706222908809, 1366.5422083602105, 24854.00583976693, 25792.871035645454, 25870.61194082128, 26217.344566385993, 27610.171694849185, 41094.1781164369, 41382.586174137876, 41387.0, 41397.586024140575, 41449.37825932674, 224867.0, 228098.0, 276938.0, 279342.0, 292773.0, 29733.10800675983, 30524.236894076937, 30697.232569185948, 31004.844975774977, 31032.22419439532, 42172.57827421809, 42728.78635606802, 42763.78618106889, 43608.0, 43883.341749873136, 36409.817950910074, 36629.0, 36826.8158659205, 37194.256114878095, 37859.432108517845, 36149.0, 36851.81574092113, 39090.80454597709, 39746.0, 40281.1943761129, 34226.65773342235, 34988.82505587456, 34997.82501087478, 35019.64980350164, 35210.64789352176, 30331.0, 31666.525002125447, 32099.839500802347, 32188.0, 32190.517142242417, 24645.630315544924, 24982.875085624455, 25121.246362609152, 25227.74772252254, 25470.235892923243], "unit": "score", "name": "ext.html", "value": 18506.563623396494}, {"lowerIsBetter": false, "replicates": [354.48668937235, 354.7534463547834, 358.88874448920836, 359.20615439877866, 359.80750298590243, 13971.091879027856, 14399.856001439983, 16194.757078643815, 16463.917680411596, 17195.0, 15801.288941997609, 16206.35174593015, 16624.75062874055, 16952.660946781056, 16969.74545381817, 5412.756425960842, 5540.750666220029, 5541.972290138544, 5545.1682247662975, 5546.417626149257, 4019.2765302245584, 4130.277201489742, 5482.671039737628, 5916.822495325147, 6089.147519347295, 5968.4031596840405, 5992.400759924017, 6005.039193729004, 6017.157597936292, 6023.909641355383, 5169.3279873616375, 5294.205869119663, 5315.096433606296, 5315.3621565412395, 5317.096093664087, 4756.619470442356, 5095.0574143783515, 5211.817586384458, 5215.243789650517, 5220.243064755589, 12221.755564888741, 12403.13178077535, 12570.434330455151, 19547.706784398244, 19803.306884258982, 2029.5433527456353, 2079.147549504711, 2093.099967014183, 2093.2464312847515, 2097.9854571462624, 9103.772405689911, 9248.0, 9591.760205994837, 11934.224275422157, 12558.560450384284, 1626.0812640857996, 1644.5477493689211, 1653.1816750708356, 1673.146695185452, 1685.2247965935685, 59072.0, 61264.69367653133, 61384.69307653478, 61561.6921915392, 61866.38133618696, 9768.90231097694, 9808.950955245178, 9816.607335706634, 9819.754506137404, 9887.80224395508, 12588.0, 12602.684932876751, 12686.682832929251, 12688.619341419771, 12698.174618649758, 7274.563526188445, 7346.045014148127, 7363.852722945511, 7376.299251571092, 7433.85132297351, 7218.67515961783, 7225.132984041844, 7270.0, 7273.709051637875, 7281.1990681025045, 3951.407288906687, 3964.8810535683974, 3976.8011599419915, 4257.723247988871, 4268.573142685706, 1685.991570042142, 1719.9914000430167, 1741.5733145379463, 1765.161548264564, 1775.7691500104904, 921.3274309753783, 928.5171710710528, 964.9951750241345, 991.8165139449225, 1027.1012863744224, 13354.0, 15742.134182619837, 15853.207339633203, 16118.274677639534, 16242.75635865463, 860.655737704923, 932.9626814927327, 936.4007035497287, 949.5584553182803, 984.5520288268821, 8537.359698022548, 9143.13140251675, 9684.41893486379, 10343.741406464747, 10421.062104410488, 463828.0, 470696.0, 492386.0, 555815.0, 562944.0, 78923.60538197387, 79478.60260698659, 81700.59149704213, 82291.0, 83431.58284208662, 1146.507001989136, 1149.40231079838, 1164.4177911044478, 1166.0904494494139, 1167.0371943147106, 14668.0, 14716.484923027643, 14958.476453324081, 15041.548753537412, 15320.31058602388, 34685.826570866986, 34732.82633586917, 34822.30355392928, 35698.929032129075, 35958.46062309015, 45182.0, 45584.54415455803, 45811.31283030824, 46710.76644616755, 47003.52996469991, 9299.488528130747, 9422.623095076395, 9443.338966272295, 9537.284703647116, 9548.713538593853, 16105.597360066093, 16498.17509124563, 17130.48608541746, 17161.485155445356, 17366.826331737026, 13970.0, 14133.363998619881, 14283.64290892736, 14403.279836008367, 14469.638259043608, 14183.574492765234, 14362.712745745235, 14399.640008999859, 14761.55715328542, 14908.0, 11505.42472876336, 12808.423620937267, 14626.780598290821, 14824.110553366832, 14928.552143435714, 9533.856992144985, 9558.522073896416, 9581.952090239503, 9694.709158725249, 9710.951445242728, 9407.85888211691, 9483.620655173716, 11159.665210043711, 14272.072315299472, 14729.558113256191], "unit": "score", "name": "jquery.html", "value": 8649.85186444322}, {"lowerIsBetter": false, "replicates": [1339.3035621476827, 1459.168274083772, 1502.3089378885716, 1658.601935535471, 1791.4715159028078, 6674.8998765018505, 7467.402607791377, 7594.544327340356, 7600.5439673619485, 7619.695212191519, 7305.159906610741, 7483.214262502427, 7485.700571977114, 7485.775426737193, 7489.887651685215, 1939.5539026024023, 1970.4975231315993, 1971.4677037199947, 2235.1953296813135, 2270.126001489422, 2217.1907253852387, 2258.2209137847417, 2260.1750361118156, 2261.1520679745095, 2261.434641339665, 2175.6627722703006, 2202.449387653087, 2254.1096266974537, 2254.4363909022745, 2255.323402979108, 2228.0419419649543, 2254.5908806995626, 2275.340151356105, 2282.2126366403563, 2285.919992800252, 2194.703714998471, 2196.0, 2223.7998580127705, 2224.9666255006186, 2225.688403623494, 7426.443016773764, 7518.060242469692, 7535.171131175621, 7535.849283014364, 7539.132999705049, 4523.163214805239, 4601.539846015406, 4615.515370886043, 4615.792289346954, 4649.558291962258, 2906.0, 2982.328975980409, 3014.954775678367, 3027.1070034339923, 3032.6209223847018, 972.4214092614953, 975.5366201054443, 994.4232345239743, 999.7100840756171, 1036.0054347826097, 10513.52689128991, 10519.84220236697, 10521.210909181766, 10523.263371563993, 10530.210234232387, 4121.773302468393, 4169.749815011109, 4192.601702838226, 4230.048239146229, 4234.428352172479, 8966.86549701755, 8997.64009439615, 9017.909820901707, 9019.774505637411, 9020.954895225614, 4656.231721765938, 4658.091672123971, 4690.202665546797, 4706.317583950308, 4706.623470122382, 4297.806598703066, 4314.848980285675, 4319.049809042006, 4322.978385108117, 4327.653787696977, 3348.28011977426, 3389.18659521713, 3474.3919814032442, 3534.8939531814085, 3553.786772793589, 1148.1274231584057, 1150.8906653867868, 1156.0982433701727, 1159.6694941941507, 1159.8086315757805, 1080.3193987787802, 1084.2843723142687, 1133.9659810205708, 1227.533537255855, 1326.1512631915582, 7082.645867706594, 7090.326418990291, 7135.464840136907, 7159.821004474929, 7219.855602887913, 1091.9672409827717, 1113.6858506961862, 1117.0728295514702, 1121.3832392184265, 1165.4198997938183, 5576.191452239403, 5681.289838770153, 5695.7152142392715, 5697.344805347355, 5704.087346024699, 8455.49267043967, 8568.742937711879, 8746.606402711894, 8781.868271975925, 8869.512176830336, 8624.223819856243, 8680.001799792979, 8764.78088047804, 8766.868496972551, 8879.24526415262, 6455.0, 6621.238557565845, 6678.3989440950545, 6713.194416669933, 6739.764108256188, 6644.036614690746, 6693.531452798257, 6745.123133992746, 6752.493562982894, 6775.62734049632, 7810.531368117931, 7987.081485629227, 7998.280154786097, 8029.197080292158, 8031.237032481905, 7997.480163789335, 8191.180881911761, 8242.917570824215, 8256.958715206385, 8296.543690097102, 5969.343372228965, 6291.245050593958, 6688.3646053624825, 6760.830979225362, 6781.796546103625, 6596.274409815012, 6697.196336439659, 7060.399866011447, 7163.7492687755675, 7205.747798827016, 6579.046038324321, 6638.634875081917, 6707.295733947865, 6756.560823546453, 6833.077534532973, 6630.53586248958, 6698.56459330142, 6726.125603671491, 6814.318568143146, 6834.829129271808, 6873.759418420531, 6915.619640919797, 6918.93081069203, 6930.203026652, 6932.930670693228, 6065.272167339947, 6246.437820596168, 6275.309715931336, 6286.748530058747, 6299.307076221704, 6142.293636231711, 6390.073439351361, 6390.424861762278, 6396.360363963567, 6421.036844473367], "unit": "score", "name": "mootools.html", "value": 4350.315053550906}, {"lowerIsBetter": false, "replicates": [321.9323941972185, 325.76382122960854, 327.78202495340605, 328.65819547670424, 334.46151695769805, 6066.757329706812, 6097.512199024079, 6139.754409823608, 6153.077038444236, 6179.66011869347, 5744.741486633101, 5846.707664616773, 5900.29196496421, 6024.066269728188, 6030.517558595313, 4593.1961906666365, 4605.332226827108, 4628.444586649607, 4638.420197475316, 4638.4665763437215, 4402.647788176954, 4625.421822272216, 4634.142683603527, 4635.791389387468, 4639.559241872033, 4443.688941774077, 4482.708623939449, 4565.018521017981, 4569.748663823489, 4600.7929643166135, 4553.157665831832, 4582.1064892346, 4587.7017993830295, 4599.816007359702, 4606.815727370935, 4027.234825383168, 4028.0, 4029.6171863672903, 4029.6776257899296, 4033.092554175287, 5573.470520300565, 5725.026745453283, 5725.570582206351, 5729.885402291972, 5739.225204597367, 5256.658317209369, 5269.841904742825, 5274.973625131888, 5286.841394758163, 5291.497307755757, 6384.265809431929, 6387.041943708435, 6389.297177310492, 6390.840228994266, 6392.904106438407, 4320.891977700583, 4325.091730736518, 4326.6538676905775, 4334.32817913224, 4335.1979883721615, 6518.0, 6579.2104947406615, 6588.0, 6608.471322294205, 6626.171728533934, 4425.269830478, 4441.600255976978, 4446.221911165533, 4453.109378124388, 4457.955420445754, 4471.23988921884, 4495.64034877209, 4507.706999045052, 4513.661475389359, 4520.208963431386, 5225.895482090413, 5241.580673546107, 5252.319257837532, 5257.395399529103, 5257.4742525747115, 6309.305976342599, 6431.549791514549, 6454.580452270588, 6461.0631458438265, 6463.612183269019, 1579.9526014219591, 1601.4234875444831, 1601.735713607265, 1601.871850251977, 1602.7115119278642, 1046.890076541952, 1057.7249915021996, 1058.047757018674, 1072.5280876414354, 1077.7197928538637, 6147.600405973598, 6152.0156774915795, 6160.476359509492, 6163.322034576193, 6172.8765424691255, 6389.840253993594, 6631.403173714389, 6646.136002319764, 6648.069270302161, 6658.267590565034, 6077.635341879413, 6089.0, 6201.534884883652, 6203.751849926042, 6210.130581718563, 3560.5549306336707, 3609.9819500902327, 3611.1694310308776, 3613.4218525035867, 3619.040954147153, 6699.196096468455, 6826.146731658543, 6835.487338449636, 6839.760608378683, 6845.178578570504, 6819.829504262334, 6851.2806155353965, 6857.211420686585, 6859.2454829968665, 6869.072675188885, 6807.0, 6841.657917104125, 6854.760083397057, 6856.142982127134, 6869.656517174121, 6586.901196481961, 6642.900356494753, 6700.530962832555, 6708.0, 6716.932830671826, 6596.70314835824, 6600.438962688226, 6609.041688955171, 6609.339066093545, 6610.8347291318105, 6804.829879253059, 6809.69356378974, 6810.31896810315, 6814.420774234048, 6819.795406137824, 4377.649788016887, 4441.4892287387365, 4445.0, 4458.643308535245, 4464.218761716752, 6652.434543063894, 6670.266270710315, 6675.432588229861, 6678.499112566674, 6686.431653309329, 6494.253160886558, 6494.383033611799, 6494.960806270974, 6505.121808555974, 6514.0880276760345, 6320.0, 6464.676766161767, 6483.902741458976, 6490.610563366213, 6500.512461565307, 6304.369563043659, 6306.337834527309, 6310.05349197624, 6311.147995020797, 6311.652859092794, 6488.967555162194, 6502.284748677547, 6505.934940650723, 6508.739650413931, 6509.7396104155305, 6175.289841668266, 6301.4328710416285, 6342.429181373698, 6356.841078973062, 6359.904601431075], "unit": "score", "name": "prototype.html", "value": 4812.492900210085}, {"lowerIsBetter": false, "replicates": [818.8433094751871, 819.3977426591455, 825.5524354789096, 838.6771093129144, 857.2242120880603, 12576.874231257685, 12665.430055647495, 12677.429515671794, 12855.35723213839, 12873.098883078188, 12468.937655311733, 14779.187144707037, 15123.24383780812, 15150.848491515082, 15160.317785699643, 659.1036190780535, 667.8497338098913, 798.3453568074196, 807.9717209897655, 809.2554849538438, 795.3557618329172, 803.5901690138043, 812.7968007998, 814.0597609760706, 815.0097631377874, 837.1084794693662, 845.2266176448542, 846.1327139681814, 846.2130218896424, 846.4159729786459, 686.6086330791451, 696.4846013949641, 696.6342670098163, 697.870893884633, 839.1105428246049, 612.1124369664005, 622.0886401421939, 624.1667374055642, 624.2602516018487, 624.3849807939176, 12705.428255728515, 12824.166429182073, 12832.0, 12872.0, 12912.225266483947, 10962.397068161248, 11337.0, 11376.943115284454, 11498.597549085825, 11695.415229238504, 9205.935642304155, 9430.10414010668, 9430.10414010668, 9541.0, 9716.659916902945, 3499.61504234534, 3520.7887526748477, 3563.893083207508, 3635.363811333006, 3637.3089113068695, 47168.29247561289, 47386.52613473855, 47389.28916066227, 47513.28730069086, 47671.76164119192, 8505.74482765518, 8731.912680873236, 8834.734957951272, 9029.729108126767, 9100.544972751468, 16984.49046528606, 17027.40404085851, 17038.06290654026, 17047.48857534276, 17056.829431705773, 6897.896531552031, 6929.029935808991, 6942.375186233263, 7168.88827269307, 7188.353048225685, 4112.547619761824, 4120.484939382577, 4151.7924103794685, 4159.209750147463, 4164.37534369847, 2845.8292502449917, 2869.153599688097, 2875.6549214094443, 2877.309445733051, 2886.1197334812664, 497.40311626048884, 518.1761000010002, 528.6378830501119, 534.593708781329, 534.6391185949468, 485.6333468231533, 608.3551435478407, 628.7233617208414, 645.6965226343611, 687.52560733094, 7727.459077864495, 7994.560299183485, 8043.316318112909, 8300.916990830136, 8351.29014033814, 512.2521119165984, 655.9376859198369, 661.6823924516259, 663.134609334813, 678.1861765880963, 3773.7735735855936, 3814.504114465102, 3832.136721581732, 3834.084046923691, 3841.327767640652, 59132.0, 59676.0, 60050.699746500984, 60169.097463538084, 60336.396636033955, 52888.20667689988, 53399.733001334745, 53417.46582534203, 53453.465465345624, 53539.464605353445, 47441.76279118582, 48008.5199148004, 48236.0, 48314.516854831, 48332.0, 7804.765857024071, 7866.567338796421, 7985.560794156378, 8092.595370231583, 8094.959525202336, 34256.48615270723, 34521.482177766855, 34525.48211776775, 34911.47632785561, 35736.28527429385, 43136.0, 43159.568404315556, 43176.0, 45131.54868451274, 46199.3070103942, 11251.212415130862, 11478.311301321948, 11502.53989840397, 11595.884041159481, 11749.76500470003, 11144.609938652433, 11185.21703480781, 11351.943240283746, 11845.348505832262, 12176.695582610151, 10316.587336506456, 10537.736556586147, 10596.364218146937, 11191.944040279746, 11436.485358158736, 10598.947005264925, 10842.620508282173, 10853.620123295646, 11029.503672334604, 11261.605843795427, 10318.17454603645, 10580.206484513847, 10614.522346494272, 10637.680869573926, 10715.624953126604, 8970.775730606787, 9202.493862837608, 9498.430094194371, 9500.90499095028, 9530.95234523823, 8637.265832404064, 8709.738707838775, 8767.044411021487, 8908.688195913111, 9399.154076133182], "unit": "score", "name": "yui.html", "value": 6083.8405679145135}], "name": "dromaeo_css", "value": 6899.965632102729}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 105.0, 112.0, 111.0, 112.0, 101.0, 111.0, 110.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 157.0, 172.0, 127.0, 150.0, 163.0, 129.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 96.0, 70.0, 70.0, 72.0, 97.0, 92.0, 70.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 148.0, 92.0, 92.0, 93.0, 141.0, 92.0, 92.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 59.0, 58.0, 58.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 87.0, 94.0, 85.0, 85.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 122.0, 112.0, 119.0, 122.0, 120.0, 122.0, 133.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [145.0, 141.0, 160.0, 149.0, 155.0, 139.0, 146.0, 149.0, 156.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 69.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1503.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [2079.002079002079], "unit": "score", "name": "RayTrace", "value": 355.9347089999998}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [25769.23076923077], "unit": "score", "name": "RegExp", "value": 35.3516567164179}, {"lowerIsBetter": false, "replicates": [689.5133653187114], "unit": "score", "name": "Splay", "value": 118.18625149105372}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19521.28702015633}]} 17:10:43 INFO - RETURN: dromaeo_css: 6899.97 17:10:43 INFO - RETURN: kraken: 1503.60 17:10:43 INFO - RETURN: v8_7: 19521.29 17:10:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19521.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6899.97"}}} 17:10:43 INFO - Return code: 0 17:10:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:10:43 ERROR - # TBPL SUCCESS # 17:10:43 INFO - Running post-action listener: _resource_record_post_action 17:10:43 INFO - Running post-run listener: _resource_record_post_run 17:10:44 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 73728; Write bytes: 525504512; Read time: 36; Write time: 944800 17:10:44 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 247160832; Read time: 0; Write time: 636108 17:10:44 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 73728; Write bytes: 278343680; Read time: 36; Write time: 308692 17:10:44 INFO - Running post-run listener: _upload_blobber_files 17:10:44 INFO - Blob upload gear active. 17:10:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:10:44 INFO - Copying logs to upload dir... 17:10:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.663452 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-16 17:10:44.253038) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:44.256519) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/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-16 17:10:44.307803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:44.308199) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450312538.786661-1361153400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:44.357771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 17:10:44.358121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 17:10:44.358422) ========= ========= Total master_lag: 0.30 =========