builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1457074888.29 results: success (0) buildid: 20160303204104 builduid: 072c4692317c4e48a45581b1be4d41b9 revision: cc69b98ccbdb9e7a21e224207eff40e590407433 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.286189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.286569) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.286854) ========= 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.299676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.299996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.307674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.307956) ========= 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002206 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.354133) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.354469) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.354842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.355133) ========= 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 23:01:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.8M=0.001s 2016-03-03 23:01:28 (16.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.485228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.485522) ========= 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009479 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.553097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:28.553440) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cc69b98ccbdb9e7a21e224207eff40e590407433 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cc69b98ccbdb9e7a21e224207eff40e590407433 --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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 23:01:28,746 truncating revision to first 12 chars 2016-03-03 23:01:28,746 Setting DEBUG logging. 2016-03-03 23:01:28,746 attempt 1/10 2016-03-03 23:01:28,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cc69b98ccbdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 23:01:29,013 unpacking tar archive at: mozilla-aurora-cc69b98ccbdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:29.107348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:29.107669) ========= echo cc69b98ccbdb9e7a21e224207eff40e590407433 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cc69b98ccbdb9e7a21e224207eff40e590407433'] 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False cc69b98ccbdb9e7a21e224207eff40e590407433 program finished with exit code 0 elapsedTime=0.004336 script_repo_revision: 'cc69b98ccbdb9e7a21e224207eff40e590407433' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:29.156248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:29.156561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 23:01:29.167347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-03-03 23:01:29.167613) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:01:29 INFO - MultiFileLogger online at 20160303 23:01:29 in /builds/slave/test-pgo 23:01:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:01:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:01:29 INFO - {'append_to_log': False, 23:01:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:01:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:01:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:01:29 INFO - 'branch': 'Mozilla-Aurora', 23:01:29 INFO - 'buildbot_json_path': 'buildprops.json', 23:01:29 INFO - 'config_files': ('talos/linux_config.py',), 23:01:29 INFO - 'default_actions': ('clobber', 23:01:29 INFO - 'read-buildbot-config', 23:01:29 INFO - 'download-and-extract', 23:01:29 INFO - 'populate-webroot', 23:01:29 INFO - 'create-virtualenv', 23:01:29 INFO - 'install', 23:01:29 INFO - 'run-tests'), 23:01:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:01:29 INFO - 'download_minidump_stackwalk': True, 23:01:29 INFO - 'download_symbols': 'ondemand', 23:01:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:01:29 INFO - 'tooltool.py': '/tools/tooltool.py', 23:01:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:01:29 INFO - '/tools/misc-python/virtualenv.py')}, 23:01:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:01:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:01:29 INFO - 'installer_path': 'installer.exe', 23:01:29 INFO - 'log_level': 'info', 23:01:29 INFO - 'log_name': 'talos', 23:01:29 INFO - 'log_to_console': True, 23:01:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:01:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:01:29 INFO - 'opt_config_files': (), 23:01:29 INFO - 'pip_index': False, 23:01:29 INFO - 'sps_profile': False, 23:01:29 INFO - 'sps_profile_interval': 0, 23:01:29 INFO - 'suite': 'dromaeojs-e10s', 23:01:29 INFO - 'system_bits': '32', 23:01:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:01:29 INFO - 'title': 'talos-linux64-ix-038', 23:01:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:01:29 INFO - 'use_talos_json': True, 23:01:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:01:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:01:29 INFO - 'work_dir': 'build'} 23:01:29 INFO - ##### 23:01:29 INFO - ##### Running clobber step. 23:01:29 INFO - ##### 23:01:29 INFO - Running pre-action listener: _resource_record_pre_action 23:01:29 INFO - Running main action method: clobber 23:01:29 INFO - rmtree: /builds/slave/test-pgo/build 23:01:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:01:29 INFO - Running post-action listener: _resource_record_post_action 23:01:29 INFO - ##### 23:01:29 INFO - ##### Running read-buildbot-config step. 23:01:29 INFO - ##### 23:01:29 INFO - Running pre-action listener: _resource_record_pre_action 23:01:29 INFO - Running main action method: read_buildbot_config 23:01:29 INFO - Using buildbot properties: 23:01:29 INFO - { 23:01:29 INFO - "project": "", 23:01:29 INFO - "product": "firefox", 23:01:29 INFO - "script_repo_revision": "production", 23:01:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:01:29 INFO - "repository": "", 23:01:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:01:29 INFO - "buildid": "20160303204104", 23:01:29 INFO - "pgo_build": "True", 23:01:29 INFO - "basedir": "/builds/slave/test-pgo", 23:01:29 INFO - "buildnumber": 178, 23:01:29 INFO - "slavename": "talos-linux64-ix-038", 23:01:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:01:29 INFO - "platform": "ubuntu64_hw", 23:01:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:01:29 INFO - "branch": "mozilla-aurora", 23:01:29 INFO - "repo_path": "releases/mozilla-aurora", 23:01:29 INFO - "revision": "cc69b98ccbdb9e7a21e224207eff40e590407433", 23:01:29 INFO - "stage_platform": "linux64-pgo", 23:01:29 INFO - "builduid": "072c4692317c4e48a45581b1be4d41b9", 23:01:29 INFO - "slavebuilddir": "test" 23:01:29 INFO - } 23:01:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 23:01:29 INFO - Running post-action listener: _resource_record_post_action 23:01:29 INFO - ##### 23:01:29 INFO - ##### Running download-and-extract step. 23:01:29 INFO - ##### 23:01:29 INFO - Running pre-action listener: _resource_record_pre_action 23:01:29 INFO - Running main action method: download_and_extract 23:01:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:01: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')]} 23:01:29 INFO - https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/test_packages.json 23:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/test_packages.json 23:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:01:31 INFO - Downloaded 1448 bytes. 23:01:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:01:31 INFO - Using the following test package requirements: 23:01:31 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 23:01:31 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:01:31 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:01:31 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'jsshell-linux-x86_64.zip'], 23:01:31 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:01:31 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 23:01:31 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:01:31 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:01:31 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:01:31 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 23:01:31 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 23:01:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:01:31 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:01:31 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')]} 23:01:31 INFO - https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 23:01:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 23:01:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 23:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:01:33 INFO - Downloaded 23089524 bytes. 23:01:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:01:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:01:35 INFO - Return code: 0 23:01:35 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:35 INFO - https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 23:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 23:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 23:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:01:36 INFO - Downloaded 23089524 bytes. 23:01:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:01:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:01:37 INFO - Return code: 0 23:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:37 INFO - https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 23:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 23:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 23:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:01:38 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip: [Errno 104] Connection reset by peer 23:01:38 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 23:01:38 INFO - retry: Failed, sleeping 30 seconds before retrying 23:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 23:02:09 INFO - Downloaded 10801536 bytes. 23:02:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:02:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:02:10 INFO - Return code: 0 23:02: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')]} 23:02:10 INFO - https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:02:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 23:02:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 23:02:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 23:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:02:11 INFO - Downloaded 59967987 bytes. 23:02:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 23:02:11 INFO - mkdir: /builds/slave/test-pgo/properties 23:02:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:02:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:02:11 INFO - Contents: 23:02:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 23:02:11 INFO - Running post-action listener: _resource_record_post_action 23:02:11 INFO - Running post-action listener: set_extra_try_arguments 23:02:11 INFO - ##### 23:02:11 INFO - ##### Running populate-webroot step. 23:02:11 INFO - ##### 23:02:11 INFO - Running pre-action listener: _resource_record_pre_action 23:02:11 INFO - Running main action method: populate_webroot 23:02:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:02:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:02:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:02:11 INFO - '--tppagecycles', 23:02:11 INFO - '7'], 23:02:11 INFO - 'tests': ['tsvgm']}}, 23:02:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:02:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:02:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:02:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:02:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'tests': ['damp', 'tps']}, 23:02:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['damp', 'tps']}, 23:02:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:02:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:02:11 INFO - 'other': {'tests': ['a11yr', 23:02:11 INFO - 'ts_paint', 23:02:11 INFO - 'tpaint', 23:02:11 INFO - 'sessionrestore', 23:02:11 INFO - 'sessionrestore_no_auto_restore']}, 23:02:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['a11yr', 23:02:11 INFO - 'ts_paint', 23:02:11 INFO - 'tpaint', 23:02:11 INFO - 'sessionrestore', 23:02:11 INFO - 'sessionrestore_no_auto_restore']}, 23:02:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['a11yr', 23:02:11 INFO - 'ts_paint', 23:02:11 INFO - 'tpaint', 23:02:11 INFO - 'sessionrestore', 23:02:11 INFO - 'sessionrestore_no_auto_restore']}, 23:02:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['a11yr', 23:02:11 INFO - 'ts_paint', 23:02:11 INFO - 'tpaint', 23:02:11 INFO - 'sessionrestore', 23:02:11 INFO - 'sessionrestore_no_auto_restore']}, 23:02:11 INFO - 'other_l64': {'tests': ['a11yr', 23:02:11 INFO - 'ts_paint', 23:02:11 INFO - 'tpaint', 23:02:11 INFO - 'sessionrestore', 23:02:11 INFO - 'sessionrestore_no_auto_restore']}, 23:02:11 INFO - 'other_nol64': {'tests': ['a11yr', 23:02:11 INFO - 'ts_paint', 23:02:11 INFO - 'tpaint', 23:02:11 INFO - 'sessionrestore', 23:02:11 INFO - 'sessionrestore_no_auto_restore']}, 23:02:11 INFO - 'svgr': {'tests': ['tsvgx', 23:02:11 INFO - 'tsvgr_opacity', 23:02:11 INFO - 'tart', 23:02:11 INFO - 'tscrollx', 23:02:11 INFO - 'cart']}, 23:02:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['tsvgx', 23:02:11 INFO - 'tsvgr_opacity', 23:02:11 INFO - 'tart', 23:02:11 INFO - 'tscrollx', 23:02:11 INFO - 'cart']}, 23:02:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'tests': ['tp5o']}, 23:02:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'talos_options': ['--e10s'], 23:02:11 INFO - 'tests': ['tp5o']}, 23:02:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'talos_options': ['--xperf_path', 23:02:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:11 INFO - 'tests': ['tp5n']}, 23:02:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:11 INFO - 'talos_options': ['--e10s', 23:02:11 INFO - '--xperf_path', 23:02:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:11 INFO - 'tests': ['tp5n']}}, 23:02:11 INFO - 'talos.zip': {'path': '', 23:02:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:02:11 INFO - Running post-action listener: _resource_record_post_action 23:02:11 INFO - ##### 23:02:11 INFO - ##### Running create-virtualenv step. 23:02:11 INFO - ##### 23:02:11 INFO - Running pre-action listener: _resource_record_pre_action 23:02:11 INFO - Running main action method: create_virtualenv 23:02:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:02:11 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 23:02:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:02:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:02:12 INFO - Using real prefix '/usr' 23:02:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:02:12 INFO - Installing distribute.............................................................................................................................................................................................done. 23:02:14 INFO - Installing pip.................done. 23:02:14 INFO - Return code: 0 23:02:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:02:14 INFO - Using env: {'DISPLAY': ':0', 23:02:14 INFO - 'HOME': '/home/cltbld', 23:02:14 INFO - 'LANG': 'en_US.UTF-8', 23:02:14 INFO - 'LANGUAGE': 'en_US:en', 23:02:14 INFO - 'LOGNAME': 'cltbld', 23:02:14 INFO - 'MAIL': '/var/mail/cltbld', 23:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:14 INFO - 'MOZ_NO_REMOTE': '1', 23:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:14 INFO - 'NO_EM_RESTART': '1', 23:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:14 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:14 INFO - 'SHELL': '/bin/bash', 23:02:14 INFO - 'SHLVL': '1', 23:02:14 INFO - 'TERM': 'linux', 23:02:14 INFO - 'TMOUT': '86400', 23:02:14 INFO - 'USER': 'cltbld', 23:02:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:14 INFO - '_': '/tools/buildbot/bin/python'} 23:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:14 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 23:02:14 INFO - Cleaning up... 23:02:14 INFO - Return code: 0 23:02:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:02:14 INFO - Using env: {'DISPLAY': ':0', 23:02:14 INFO - 'HOME': '/home/cltbld', 23:02:14 INFO - 'LANG': 'en_US.UTF-8', 23:02:14 INFO - 'LANGUAGE': 'en_US:en', 23:02:14 INFO - 'LOGNAME': 'cltbld', 23:02:14 INFO - 'MAIL': '/var/mail/cltbld', 23:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:14 INFO - 'MOZ_NO_REMOTE': '1', 23:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:14 INFO - 'NO_EM_RESTART': '1', 23:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:14 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:14 INFO - 'SHELL': '/bin/bash', 23:02:14 INFO - 'SHLVL': '1', 23:02:14 INFO - 'TERM': 'linux', 23:02:14 INFO - 'TMOUT': '86400', 23:02:14 INFO - 'USER': 'cltbld', 23:02:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:14 INFO - '_': '/tools/buildbot/bin/python'} 23:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:15 INFO - Downloading/unpacking psutil>=0.7.1 23:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:02:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:17 INFO - Installing collected packages: psutil 23:02:17 INFO - Running setup.py install for psutil 23:02:17 INFO - building 'psutil._psutil_linux' extension 23:02:17 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 23:02:17 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 23:02:17 INFO - building 'psutil._psutil_posix' extension 23:02:17 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 23:02:17 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 23:02:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:17 INFO - Successfully installed psutil 23:02:17 INFO - Cleaning up... 23:02:17 INFO - Return code: 0 23:02:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:02:17 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')]} 23:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:17 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')]} 23:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:02:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:02:17 INFO - Using env: {'DISPLAY': ':0', 23:02:17 INFO - 'HOME': '/home/cltbld', 23:02:17 INFO - 'LANG': 'en_US.UTF-8', 23:02:17 INFO - 'LANGUAGE': 'en_US:en', 23:02:17 INFO - 'LOGNAME': 'cltbld', 23:02:17 INFO - 'MAIL': '/var/mail/cltbld', 23:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:17 INFO - 'MOZ_NO_REMOTE': '1', 23:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:17 INFO - 'NO_EM_RESTART': '1', 23:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:17 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:17 INFO - 'SHELL': '/bin/bash', 23:02:17 INFO - 'SHLVL': '1', 23:02:17 INFO - 'TERM': 'linux', 23:02:17 INFO - 'TMOUT': '86400', 23:02:17 INFO - 'USER': 'cltbld', 23:02:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:17 INFO - '_': '/tools/buildbot/bin/python'} 23:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:02:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:02:19 INFO - Installing collected packages: mozsystemmonitor 23:02:19 INFO - Running setup.py install for mozsystemmonitor 23:02:19 INFO - Successfully installed mozsystemmonitor 23:02:19 INFO - Cleaning up... 23:02:19 INFO - Return code: 0 23:02:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:02:19 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')]} 23:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:19 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')]} 23:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 23:02:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:02:19 INFO - Using env: {'DISPLAY': ':0', 23:02:19 INFO - 'HOME': '/home/cltbld', 23:02:19 INFO - 'LANG': 'en_US.UTF-8', 23:02:19 INFO - 'LANGUAGE': 'en_US:en', 23:02:19 INFO - 'LOGNAME': 'cltbld', 23:02:19 INFO - 'MAIL': '/var/mail/cltbld', 23:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:19 INFO - 'MOZ_NO_REMOTE': '1', 23:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:19 INFO - 'NO_EM_RESTART': '1', 23:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:19 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:19 INFO - 'SHELL': '/bin/bash', 23:02:19 INFO - 'SHLVL': '1', 23:02:19 INFO - 'TERM': 'linux', 23:02:19 INFO - 'TMOUT': '86400', 23:02:19 INFO - 'USER': 'cltbld', 23:02:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:19 INFO - '_': '/tools/buildbot/bin/python'} 23:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:19 INFO - Downloading/unpacking blobuploader==1.2.4 23:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:21 INFO - Downloading blobuploader-1.2.4.tar.gz 23:02:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:02:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:02:21 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 23:02:21 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 23:02:21 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 23:02:21 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 23:02:21 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 23:02:21 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 23:02:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:02:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:02:22 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 23:02:22 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 23:02:22 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 23:02:22 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 23:02:22 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 23:02:22 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 23:02:22 INFO - Downloading docopt-0.6.1.tar.gz 23:02:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:02:22 INFO - Installing collected packages: blobuploader, requests, docopt 23:02:22 INFO - Running setup.py install for blobuploader 23:02:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:02:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:02:22 INFO - Running setup.py install for requests 23:02:22 INFO - Running setup.py install for docopt 23:02:22 INFO - Successfully installed blobuploader requests docopt 23:02:22 INFO - Cleaning up... 23:02:22 INFO - Return code: 0 23:02:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 23:02:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:02:22 INFO - Using env: {'DISPLAY': ':0', 23:02:22 INFO - 'HOME': '/home/cltbld', 23:02:22 INFO - 'LANG': 'en_US.UTF-8', 23:02:22 INFO - 'LANGUAGE': 'en_US:en', 23:02:22 INFO - 'LOGNAME': 'cltbld', 23:02:22 INFO - 'MAIL': '/var/mail/cltbld', 23:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:22 INFO - 'MOZ_NO_REMOTE': '1', 23:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:22 INFO - 'NO_EM_RESTART': '1', 23:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:22 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:22 INFO - 'SHELL': '/bin/bash', 23:02:22 INFO - 'SHLVL': '1', 23:02:22 INFO - 'TERM': 'linux', 23:02:22 INFO - 'TMOUT': '86400', 23:02:22 INFO - 'USER': 'cltbld', 23:02:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:22 INFO - '_': '/tools/buildbot/bin/python'} 23:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:23 INFO - Running setup.py (path:/tmp/pip-2d86nz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:23 INFO - Running setup.py (path:/tmp/pip-DV6gNy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:23 INFO - Running setup.py (path:/tmp/pip-hhiA0K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:23 INFO - Running setup.py (path:/tmp/pip-v80lsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:23 INFO - Running setup.py (path:/tmp/pip-onqn3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:23 INFO - Running setup.py (path:/tmp/pip-r76YjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:23 INFO - Running setup.py (path:/tmp/pip-2GbXEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:23 INFO - Running setup.py (path:/tmp/pip-ozIUD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:23 INFO - Running setup.py (path:/tmp/pip-DfiRZA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:23 INFO - Running setup.py (path:/tmp/pip-go4cEM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:23 INFO - Running setup.py (path:/tmp/pip-HAYoBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:23 INFO - Running setup.py (path:/tmp/pip-KYPrf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:23 INFO - Running setup.py (path:/tmp/pip-PcwtvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:23 INFO - Running setup.py (path:/tmp/pip-KkSpDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:23 INFO - Running setup.py (path:/tmp/pip-iiVJ7f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:23 INFO - Running setup.py (path:/tmp/pip-ZEiMCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:23 INFO - Running setup.py (path:/tmp/pip-qDJzbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:02:23 INFO - Running setup.py install for manifestparser 23:02:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Running setup.py install for mozcrash 23:02:24 INFO - Running setup.py install for mozdebug 23:02:24 INFO - Running setup.py install for mozdevice 23:02:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Running setup.py install for mozfile 23:02:24 INFO - Running setup.py install for mozhttpd 23:02:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Running setup.py install for mozinfo 23:02:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Running setup.py install for mozInstall 23:02:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Running setup.py install for mozleak 23:02:24 INFO - Running setup.py install for mozlog 23:02:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:02:24 INFO - Running setup.py install for moznetwork 23:02:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:02:25 INFO - Running setup.py install for mozprocess 23:02:25 INFO - Running setup.py install for mozprofile 23:02:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:02:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:02:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:02:25 INFO - Running setup.py install for mozrunner 23:02:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:02:25 INFO - Running setup.py install for mozscreenshot 23:02:25 INFO - Running setup.py install for moztest 23:02:25 INFO - Running setup.py install for mozversion 23:02:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:02:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:02:25 INFO - Cleaning up... 23:02:25 INFO - Return code: 0 23:02:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:02:25 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')]} 23:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:25 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')]} 23:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 23:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:02:25 INFO - Using env: {'DISPLAY': ':0', 23:02:25 INFO - 'HOME': '/home/cltbld', 23:02:25 INFO - 'LANG': 'en_US.UTF-8', 23:02:25 INFO - 'LANGUAGE': 'en_US:en', 23:02:25 INFO - 'LOGNAME': 'cltbld', 23:02:25 INFO - 'MAIL': '/var/mail/cltbld', 23:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:25 INFO - 'MOZ_NO_REMOTE': '1', 23:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:25 INFO - 'NO_EM_RESTART': '1', 23:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:25 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:25 INFO - 'SHELL': '/bin/bash', 23:02:25 INFO - 'SHLVL': '1', 23:02:25 INFO - 'TERM': 'linux', 23:02:25 INFO - 'TMOUT': '86400', 23:02:25 INFO - 'USER': 'cltbld', 23:02:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:25 INFO - '_': '/tools/buildbot/bin/python'} 23:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:25 INFO - Running setup.py (path:/tmp/pip-zyuFRp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:25 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)) 23:02:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:25 INFO - Running setup.py (path:/tmp/pip-jN_5ts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:25 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)) 23:02:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:25 INFO - Running setup.py (path:/tmp/pip-9dxLE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:25 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)) 23:02:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:25 INFO - Running setup.py (path:/tmp/pip-nz7jUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:26 INFO - Running setup.py (path:/tmp/pip-yDQVlw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:26 INFO - Running setup.py (path:/tmp/pip-G5Ujbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:26 INFO - Running setup.py (path:/tmp/pip-25ODtC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:26 INFO - Running setup.py (path:/tmp/pip-sGVivd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:26 INFO - Running setup.py (path:/tmp/pip-boiJee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:26 INFO - Running setup.py (path:/tmp/pip-vchM3Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:26 INFO - Running setup.py (path:/tmp/pip-Sb7Mxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:26 INFO - Running setup.py (path:/tmp/pip-quJSUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:26 INFO - Running setup.py (path:/tmp/pip-gGSais-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:26 INFO - Running setup.py (path:/tmp/pip-oOWveG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:26 INFO - Running setup.py (path:/tmp/pip-EQk4NH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:26 INFO - Running setup.py (path:/tmp/pip-Nvmj0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:26 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)) 23:02:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:26 INFO - Running setup.py (path:/tmp/pip-3JcmBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 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)) 23:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:02:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:02:26 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 23:02:26 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 23:02:26 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 23:02:26 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 23:02:26 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 23:02:26 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 23:02:28 INFO - Downloading blessings-1.6.tar.gz 23:02:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:02:28 INFO - Installing collected packages: blessings 23:02:28 INFO - Running setup.py install for blessings 23:02:28 INFO - Successfully installed blessings 23:02:28 INFO - Cleaning up... 23:02:28 INFO - Return code: 0 23:02:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:02:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:02:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:02:29 INFO - Reading from file tmpfile_stdout 23:02:29 INFO - Current package versions: 23:02:29 INFO - argparse == 1.2.1 23:02:29 INFO - blessings == 1.6 23:02:29 INFO - blobuploader == 1.2.4 23:02:29 INFO - docopt == 0.6.1 23:02:29 INFO - manifestparser == 1.1 23:02:29 INFO - mozInstall == 1.12 23:02:29 INFO - mozcrash == 0.16 23:02:29 INFO - mozdebug == 0.1 23:02:29 INFO - mozdevice == 0.48 23:02:29 INFO - mozfile == 1.2 23:02:29 INFO - mozhttpd == 0.7 23:02:29 INFO - mozinfo == 0.9 23:02:29 INFO - mozleak == 0.1 23:02:29 INFO - mozlog == 3.1 23:02:29 INFO - moznetwork == 0.27 23:02:29 INFO - mozprocess == 0.22 23:02:29 INFO - mozprofile == 0.28 23:02:29 INFO - mozrunner == 6.11 23:02:29 INFO - mozscreenshot == 0.1 23:02:29 INFO - mozsystemmonitor == 0.0 23:02:29 INFO - moztest == 0.7 23:02:29 INFO - mozversion == 1.4 23:02:29 INFO - psutil == 3.1.1 23:02:29 INFO - requests == 1.2.3 23:02:29 INFO - wsgiref == 0.1.2 23:02:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:02: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')]} 23:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 23:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:02:29 INFO - Using env: {'DISPLAY': ':0', 23:02:29 INFO - 'HOME': '/home/cltbld', 23:02:29 INFO - 'LANG': 'en_US.UTF-8', 23:02:29 INFO - 'LANGUAGE': 'en_US:en', 23:02:29 INFO - 'LOGNAME': 'cltbld', 23:02:29 INFO - 'MAIL': '/var/mail/cltbld', 23:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:29 INFO - 'MOZ_NO_REMOTE': '1', 23:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:29 INFO - 'NO_EM_RESTART': '1', 23:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:29 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:29 INFO - 'SHELL': '/bin/bash', 23:02:29 INFO - 'SHLVL': '1', 23:02:29 INFO - 'TERM': 'linux', 23:02:29 INFO - 'TMOUT': '86400', 23:02:29 INFO - 'USER': 'cltbld', 23:02:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:29 INFO - '_': '/tools/buildbot/bin/python'} 23:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 23:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 23:02:29 INFO - Cleaning up... 23:02:29 INFO - Return code: 0 23:02:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:02: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')]} 23:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:02:29 INFO - Using env: {'DISPLAY': ':0', 23:02:29 INFO - 'HOME': '/home/cltbld', 23:02:29 INFO - 'LANG': 'en_US.UTF-8', 23:02:29 INFO - 'LANGUAGE': 'en_US:en', 23:02:29 INFO - 'LOGNAME': 'cltbld', 23:02:29 INFO - 'MAIL': '/var/mail/cltbld', 23:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:29 INFO - 'MOZ_NO_REMOTE': '1', 23:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:29 INFO - 'NO_EM_RESTART': '1', 23:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:29 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:29 INFO - 'SHELL': '/bin/bash', 23:02:29 INFO - 'SHLVL': '1', 23:02:29 INFO - 'TERM': 'linux', 23:02:29 INFO - 'TMOUT': '86400', 23:02:29 INFO - 'USER': 'cltbld', 23:02:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:29 INFO - '_': '/tools/buildbot/bin/python'} 23:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:29 INFO - Downloading/unpacking jsonschema 23:02:29 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 23:02:29 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 23:02:29 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 23:02:29 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 23:02:29 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 23:02:29 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 23:02:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:02:31 INFO - Downloading/unpacking functools32 (from jsonschema) 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 INFO - Downloading functools32-3.2.3-2.tar.gz 23:02:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:02:31 INFO - warning: no files found matching '*.txt' 23:02:31 INFO - no previously-included directories found matching 'build' 23:02:31 INFO - no previously-included directories found matching 'dist' 23:02:31 INFO - no previously-included directories found matching '.git*' 23:02:31 INFO - Installing collected packages: jsonschema, functools32 23:02:31 INFO - Running setup.py install for functools32 23:02:31 INFO - warning: no files found matching '*.txt' 23:02:31 INFO - no previously-included directories found matching 'build' 23:02:31 INFO - no previously-included directories found matching 'dist' 23:02:31 INFO - no previously-included directories found matching '.git*' 23:02:31 INFO - Successfully installed jsonschema functools32 23:02:31 INFO - Cleaning up... 23:02:31 INFO - Return code: 0 23:02:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:02:31 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')]} 23:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:31 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')]} 23:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95eebdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, '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': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', '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 23:02:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 23:02:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:02:31 INFO - Using env: {'DISPLAY': ':0', 23:02:31 INFO - 'HOME': '/home/cltbld', 23:02:31 INFO - 'LANG': 'en_US.UTF-8', 23:02:31 INFO - 'LANGUAGE': 'en_US:en', 23:02:31 INFO - 'LOGNAME': 'cltbld', 23:02:31 INFO - 'MAIL': '/var/mail/cltbld', 23:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:31 INFO - 'MOZ_NO_REMOTE': '1', 23:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:31 INFO - 'NO_EM_RESTART': '1', 23:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:31 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:31 INFO - 'SHELL': '/bin/bash', 23:02:31 INFO - 'SHLVL': '1', 23:02:31 INFO - 'TERM': 'linux', 23:02:31 INFO - 'TMOUT': '86400', 23:02:31 INFO - 'USER': 'cltbld', 23:02:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:31 INFO - '_': '/tools/buildbot/bin/python'} 23:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:31 INFO - Downloading/unpacking flake8 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:31 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 23:02:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:02:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:02:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:02:34 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 23:02:34 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 23:02:34 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 23:02:34 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 23:02:34 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 23:02:34 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 23:02:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:34 INFO - no previously-included directories found matching 'docs/_build' 23:02:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:02:34 INFO - Running setup.py install for pep8 23:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:34 INFO - no previously-included directories found matching 'docs/_build' 23:02:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:02:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:02:34 INFO - Cleaning up... 23:02:34 INFO - Return code: 0 23:02:34 INFO - Running post-action listener: _resource_record_post_action 23:02:34 INFO - Running post-action listener: _start_resource_monitoring 23:02:34 INFO - Starting resource monitoring. 23:02:34 INFO - ##### 23:02:34 INFO - ##### Running install step. 23:02:34 INFO - ##### 23:02:34 INFO - Running pre-action listener: _resource_record_pre_action 23:02:34 INFO - Running main action method: install 23:02:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:02:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:02:34 INFO - Reading from file tmpfile_stdout 23:02:34 INFO - Detecting whether we're running mozinstall >=1.0... 23:02:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:02:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:02:34 INFO - Reading from file tmpfile_stdout 23:02:34 INFO - Output received: 23:02:34 INFO - Usage: mozinstall [options] installer 23:02:34 INFO - Options: 23:02:34 INFO - -h, --help show this help message and exit 23:02:34 INFO - -d DEST, --destination=DEST 23:02:34 INFO - Directory to install application into. [default: 23:02:34 INFO - "/builds/slave/test-pgo"] 23:02:34 INFO - --app=APP Application being installed. [default: firefox] 23:02:34 INFO - mkdir: /builds/slave/test-pgo/build/application 23:02:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:02:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:02:50 INFO - Reading from file tmpfile_stdout 23:02:50 INFO - Output received: 23:02:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:02:50 INFO - Running post-action listener: _resource_record_post_action 23:02:50 INFO - ##### 23:02:50 INFO - ##### Running run-tests step. 23:02:50 INFO - ##### 23:02:50 INFO - Running pre-action listener: _resource_record_pre_action 23:02:50 INFO - Running main action method: run_tests 23:02:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:02:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:02:50 INFO - Python 2.7.3 23:02:50 INFO - Return code: 0 23:02:50 INFO - grabbing minidump binary from tooltool 23:02:50 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')]} 23:02:50 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 0x1ede850>, '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 0x1e4a330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4a7c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:02:50 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 23:02:50 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 23:02:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:02:50 INFO - Return code: 0 23:02:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:02:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:02:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:02:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:02:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:02:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:02:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:02:51 INFO - Return code: 0 23:02:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 23:02:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:02:51 INFO - Using env: {'DISPLAY': ':0', 23:02:51 INFO - 'HOME': '/home/cltbld', 23:02:51 INFO - 'LANG': 'en_US.UTF-8', 23:02:51 INFO - 'LANGUAGE': 'en_US:en', 23:02:51 INFO - 'LOGNAME': 'cltbld', 23:02:51 INFO - 'MAIL': '/var/mail/cltbld', 23:02:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:02:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:51 INFO - 'MOZ_NO_REMOTE': '1', 23:02:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:51 INFO - 'NO_EM_RESTART': '1', 23:02:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:51 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:02:51 INFO - 'SHELL': '/bin/bash', 23:02:51 INFO - 'SHLVL': '1', 23:02:51 INFO - 'TERM': 'linux', 23:02:51 INFO - 'TMOUT': '86400', 23:02:51 INFO - 'USER': 'cltbld', 23:02:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520', 23:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:51 INFO - '_': '/tools/buildbot/bin/python'} 23:02:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:02:51 INFO - mozversion application_buildid: 20160303204104 23:02:51 INFO - mozversion application_changeset: cc69b98ccbdb9e7a21e224207eff40e590407433 23:02:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:02:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:02:51 INFO - mozversion application_name: Firefox 23:02:51 INFO - mozversion application_remotingname: firefox-dev 23:02:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:02:51 INFO - mozversion application_vendor: Mozilla 23:02:51 INFO - mozversion application_version: 46.0a2 23:02:51 INFO - mozversion platform_buildid: 20160303204104 23:02:51 INFO - mozversion platform_changeset: cc69b98ccbdb9e7a21e224207eff40e590407433 23:02:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:02:51 INFO - mozversion platform_version: 46.0a2 23:02:51 INFO - using testdate: 1457074971 23:02:51 INFO - actual date: 1457074971 23:02:51 INFO - starting webserver on 'localhost:52909' 23:02:51 INFO - SUITE-START | Running 3 tests 23:02:51 INFO - TEST-START | dromaeo_css 23:02:51 INFO - operating with platform_type : linux_ 23:02:51 INFO - Initialising browser for dromaeo_css test... 23:02:51 INFO - TEST-INFO | started process 2713 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLRn3EF/profile http://localhost:52909/getInfo.html) 23:02:54 INFO - PROCESS | 2713 | 23:02:54 INFO - PROCESS | 2713 | (process:2872): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:02:55 INFO - PROCESS | 2713 | __metrics Screen width/height:1600/1200 23:02:55 INFO - PROCESS | 2713 | colorDepth:24 23:02:55 INFO - PROCESS | 2713 | Browser inner width/height: 1024/697 23:02:55 INFO - PROCESS | 2713 | __metrics 23:02:56 INFO - TEST-INFO | 2713: exit 0 23:02:56 INFO - Browser initialized. 23:02:56 INFO - Running cycle 1/1 for dromaeo_css test... 23:02:56 INFO - TEST-INFO | started process 2939 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLRn3EF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:57 INFO - PROCESS | 2939 | 23:02:57 INFO - PROCESS | 2939 | (process:3004): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:03:07 INFO - PROCESS | 2939 | RSS: Main: 141451264 23:03:07 INFO - PROCESS | 2939 | 23:03:57 INFO - PROCESS | 2939 | 1457075037463 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] 23:06:05 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:52909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52909/tests/dromaeo/cssquery-ext.html) 23:06:06 INFO - PROCESS | 2939 | RSS: Main: 144998400 23:06:06 INFO - PROCESS | 2939 | 23:09:08 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:52909/tests/dromaeo/cssquery-ext.html (next: http://localhost:52909/tests/dromaeo/cssquery-jquery.html) 23:09:08 INFO - PROCESS | 2939 | RSS: Main: 144302080 23:09:08 INFO - PROCESS | 2939 | 23:12:10 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:52909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52909/tests/dromaeo/cssquery-mootools.html) 23:12:10 INFO - PROCESS | 2939 | RSS: Main: 142815232 23:12:10 INFO - PROCESS | 2939 | 23:15:12 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:52909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52909/tests/dromaeo/cssquery-prototype.html) 23:15:12 INFO - PROCESS | 2939 | RSS: Main: 143568896 23:15:12 INFO - PROCESS | 2939 | 23:18:15 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:52909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52909/tests/dromaeo/cssquery-yui.html) 23:18:15 INFO - PROCESS | 2939 | RSS: Main: 142614528 23:18:15 INFO - PROCESS | 2939 | 23:21:17 INFO - PROCESS | 2939 | Cycle 1(1): loaded http://localhost:52909/tests/dromaeo/cssquery-yui.html (next: http://localhost:52909/tests/dromaeo/cssquery-dojo.html) 23:21:18 INFO - PROCESS | 2939 | RSS: Main: 145887232 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | __start_tp_report 23:21:18 INFO - PROCESS | 2939 | _x_x_mozilla_page_load 23:21:18 INFO - PROCESS | 2939 | _x_x_mozilla_page_load_details 23:21:18 INFO - PROCESS | 2939 | |i|pagename|runs| 23:21:18 INFO - PROCESS | 2939 | |0;dojo.html;3320.8837690680825;3335.6164041135276;3342;3362.8150451725146;3368.8147151906637;5412.512873841353;5428.995635807373;5433.347998240211;5464.9180262296095;5465.972670136649;5425.810096646618;5453.509184173424;5475.151351540508;5494.2582751328555;5503.642263252886;4899.877503062434;4939.2344186651035;4970.627202959774;5031.069252188338;5073.340465739467;4923.704577725348;4982.853943592976;5010.0981823271795;5054.317667114948;5087.49125087492;5056.823011194609;5071.1886098224295;5086.084504789136;5112.258722485256;5114.053900028507;5046.5710414614805;5051.26756620288;5064.139096353592;5074.467180946003;5081.390233172043;4843.9031219375765;4928.33467481889;4953.133201689726;5006.649534532584;5024.84925452237;5246.501582349671;5267.078261304295;5320.840374788762;5339.599530035263;5343.251944727741;5878.676672782995;5918.556108291896;5923.496502797268;5931.021381472052;5952.761889524414;5794.275715535558;5807.622504537234;5877.764889404419;5965.522758179335;5995;5554.000279949608;5557.444255574451;5559.972200139014;5561.916571251434;5569.8607534811545;5778.942210577925;5981.940180598225;5984.431479009487;6001.609895356788;6004.969975150097;5731.541476681856;5804.506616937523;5860.970695146497;5866.882662346729;5937.287525496968;5710.885782284331;5827.679477628772;5831.416858314219;5840.1531777892815;5857.945569797392;5676.233708449389;5778.191053252548;5807;5817.127430885401;5818.796342128006;5791.594588378773;5820.417958204231;5871.236739223959;5877.706114694248;5900.409959004065;4414.09511050234;4436.511983681792;4453.087117140978;4484.618807401343;4520.932186017212;3925.0187453136714;4007.4189242559664;4025.3156963316305;4036;4070.653994410449;5471.753771080311;5532.363778165482;5538.584606154474;5550.389457159709;5583.302087239095;5971;6004.369541198112;6012.218411606463;6012.699365031731;6014.969925150346;5288.709120998382;5381.973090134525;5460;5560.304961879765;5576.776928922879;4986.177280748709;5010.3737032870895;5032.521910418504;5043.722595257296;5067.619928505377;5670;6018.337982821886;6030.065339872239;6049.364816694272;6075.48358389533;5791.218185544982;5817.825465236049;5899.351071382231;5910.202122713551;5925.229720136354;6008.939910600838;6019.4883434908525;6050.788222412194;6062.878742425039;6086.482648974709;5642.774289028393;5762.625429347079;5776.960147173381;5798;5826.242588463472;5818.127280907728;5819.476247137778;5912.763489460373;5927.347991720821;5948.672822994777;5648.378678345461;5654.575906806924;5670.8015219467125;5701.572382071444;5717.8570535736935;5598.020346439275;5685.488306052475;5686.118651609007;5717;5726.255586773693;5581.665100094007;5636.802711905064;5639.661620302795;5645.096784514458;5656.830295091154;5687.1753595729215;5692.516136128475;5745.913811292918;5776.162456443708;5800.100984347433;5395.136778115482;5515.145152501369;5526;5625.268715067015;5643.943560564506 23:21:18 INFO - PROCESS | 2939 | |1;ext.html;511.9001794650042;517.3326408932477;518.9506996835304;538.3701069748396;566.7761234312446;28861.711382886166;30071.849640751792;37755.62244377552;37990.4301435478;37991.62008379916;41754.37368439468;42134;42400.787996059975;42423.15153696924;42444.363334550006;8706.216440520368;8814.382993190478;8819.691310804123;8894.11058894112;8923.15230053144;8586.957065214665;8691.739247822576;8697.739067827975;8705.042445331008;8721.738347849574;8685.392022558424;8810.929431583572;8999;9012.459252444874;9026.774330641721;8709.564521773886;8887.733367998939;8948.686795962143;8969.551522423886;9014.053524379977;8661;8839.779005524913;8850.645974161025;8861.778455538599;8878.778030549223;39855;40331.193376132316;40440.39339409911;40485.39271910924;40521.392179117334;3402.166469215058;3552.3250582389264;3586.569611646593;3783.621637836222;3919.3729003359326;32003.83998079995;32029.839850800596;32244;32469.350612987608;32528.512072318936;4124.752514849119;4160.875173744793;4178.227027999799;4189.832406703728;4248.766317852517;293838;295512;296009;296490;351886.2405687981;65445.67277163679;66384.66807666028;66393;66638.33361666418;66698.66650666716;69514.30485695078;69637;69661.65169174223;69785.65107174432;70030.29969700238;17173.914130429268;17456.127193640266;17485.562860928578;17548.82451175472;17551.297948081934;12337.383130843422;12503;12592.87407125917;12628.684282892817;12635.873641263654;21576.78423215748;22000.119995200013;22062.22782202615;22063.448413789785;22098.889505552368;8206.917930820615;8355.95822020886;8380.832383352421;8424;8486.40595158333;1024.2318261304022;1092.7377429417043;1133.7789131119519;1145.66202970124;1149.7298134938283;29871;29987.250318741768;30573.38853222923;30851.845740771154;30907.69092309093;1164.371239530661;1191.18999080626;1193.9343336116597;1204.3797444316185;1232.8458942632171;15685.13731744765;15876.52370428889;16000.079612288231;16100.033997959925;16134.75797863033;352168;533460;534502;535441;551871;51438.48561514337;53618.73190634022;54659.45340546623;54725.45274547283;54779.80880764725;1471.2055490035475;1476.4020571668277;1484.398818478518;1484.6585285384206;1567.1067491529946;28424;29291;29513.557296640138;29863.70136298696;30002.399952001273;48433;48785.268220976;48861.2670809931;48975;49124.75437622789;333854;336574;336898;337432;337727;31770.523442147925;31985;32036.67963320337;33468.33063338768;44570.55429445664;42225.78887105545;42348;42479.7876010618;48310.75844620895;49972.250416243056;37648.811755941046;38028.61971380251;38412.61587384202;38440;38748.225035499694;37871.24257514889;38249.808750956065;38839.41740873833;38988.80505597454;39114;38335.61664383321;38569.6143038566;38768.22463550769;38924.41613375745;39248.41127383149;33493.497597536545;33939.4909076369;34102.48846267258;34114.48828267528;34566;26677.46645067049;26806.594306369607;27030.459390812466;27161.456770864075;27184.184474465797 23:21:18 INFO - PROCESS | 2939 | |2;jquery.html;386.09846009567656;386.33357458384285;387.9534455865296;389.6103896103898;392.3056190542738;15925.601859953493;16966;18034.36879709212;18130.18414171364;18337;10451.947740261288;11008.724781880457;11069.557217711303;11332;11847.348395838226;5069.873253168664;5240.3187585614005;5247.2653828464045;5250.4487028861995;5262.526372626463;5172.612054095939;5274.81538146165;5526.668399895999;5528.55771538276;5532.944670553283;5270.710110943896;5513.2005859150395;5524.640898341615;5532.1425179097105;5536.778528858861;5130.71781052042;5344.091504444254;5452.127659574468;5459.372172200208;5501.119820828668;5144;5166.948330516684;5169;5173.224016397533;5175.508326708957;13571.117877337942;13805.309734513234;13808.447662093504;15454.845451545565;21412;2120.7879212078824;2143.871367717942;2226.6882636430914;2233.609118404273;2258.6386178211574;10069.395836249849;10213.33613315132;10224.182065434747;12026;13346.466141354334;1917;1977.9703304450445;1984.8709833860753;1994.222253321206;1998.950026249341;59464;60797;61346;61957;62759.37240627581;10590.881823635304;10828.620998265023;10902.836457453144;10928.344299342065;11010.724731881606;14156.221407822668;14209.85790142106;14302.928485357716;14383.28083595816;14398.568042958728;7964.123946365895;7980.920190798134;8137.104918458965;8165.346772258205;8195.139510351446;7889.644965976545;7900.644470998819;7942.404319675932;7954.164812694699;8013.679452821939;4209.97895010523;4469.888252793706;4487.775611219426;4677.134730074947;4815.109204797123;1933.139752809986;2017.2536161620294;2018.7072874433125;2022.4438279473263;2036.093938197488;931.9021502742114;950.9919485345556;1004.1063453526367;1036.0571879589688;1036.4506811389974;14049.611357868029;15824;16107.677846443006;16923.238454269587;17544.473665790047;966.7438128895848;982.3516479123743;1015.619142821442;1078.978420431587;1103.2442776697826;9775.51122443875;9863.901360986441;9864.802703945881;9879.357841740264;9949.204063675033;148762;149044;149524;150090;151198;71621.6418917902;74583.25416745871;76926;76986.6150669243;77615.61192194003;1154.261272785418;1155.7861795567678;1195.8146487294484;1201.3152503073165;1207.7946749052505;15328.846711533188;15502.612434689223;15601.609959751097;15936.840631594;15941.68116637684;30962;31072.68927310698;32373.838130809196;33971.83014084914;34763.13092172716;35900.82049589735;37153.25693486169;37203.255934881694;37584.812075939444;37588.436173457965;7630.656620451982;7911.604419779103;8021.077576078826;8091.959540202261;8179.631916563888;11172.553097875994;11472.82790758156;11534.13493987971;11988.940055299669;11990.820137697767;9938.900610994087;10156.695299141038;10431.061204491632;10599.47002649849;10672.786544269227;10004.349717268355;10232.334898231591;10768.300060496043;10882.945585272022;10992.17558683118;10535;10645.201609879136;10713;10829.187810914056;11073.335599864035;7947.562884041433;8131.983502062242;8178.386621003329;8179.877301840596;8276.172382761675;9204.677836275698;11002.724931876766;11071.5571377144;11252.26860254081;11291 23:21:18 INFO - PROCESS | 2939 | |3;mootools.html;1513.5686329396124;1523.0633160606228;1724.9827501724988;1837.0998210876674;1867.5144462439762;7970.721024764134;8078.71724489643;8183.836323273531;8270.255676989069;8291.751247462578;8119.431639785203;8194.180581941802;8260.132686067967;8323.33413326934;8355.83288334233;2404.8677322747285;2421.709394872618;2424.5878200705924;2426.8907899144583;2428.4778772563895;2379.202967006055;2395.8442701224367;2401.5677178107935;2424.854508729482;2425.163318655061;2375.964360534593;2429.161939131006;2442.3894026493376;2452.681151450309;2465.0879174705383;2318.13070098713;2361.1381845626393;2367.3963139399343;2371.513839662865;2377.583922813518;2356.7761062699014;2407.446287353901;2422.7213870404953;2424.818138639609;2431.659567660529;7935;8011.839763204762;8040.959795201045;8043.678252869879;8051.315638170762;4872.731999740013;4979.800807967713;4980.153373926441;5020.046191223656;5021.874453138665;3169.904902852918;3247.675232476757;3319.1204330852343;3320.8173550454717;3335.7664963452567;1126.0822429719751;1141.6403832792728;1144.3991904250252;1153.2388623508443;1163.3194581170026;11497.080233581293;11599.536018559247;11716.179867409284;11748.941255293668;11750.471228794639;4517.983453722952;4551.748269225989;4559.316102584638;4566.794494247767;4591.265397536378;10100.989901009987;10121;10158.39049657023;10173.796524069625;10187.796244075225;5081.9745901271;5082.822101226513;5097.108006098918;5122.974385128051;5133.4096578893905;4546.863594092182;4571.839985600488;4598;4625;4650.465196502446;3762.7554208976876;3768.962310376916;3799.2021675447913;3803.0492376905772;3819.3316169670197;1155.2086820527966;1185.5554167187304;1206.8853458921387;1207.3600991474532;1213.9757204855853;1035.570238351076;1047.1413440978324;1063.2291588598205;1232.168286406672;1385.1135273425016;7410.592417416986;7421.517601355895;7423;7495.475316727777;7532.887006694904;1082.4695899009428;1095.5179720922768;1121.770037142384;1181.7400171962154;1199.6101267088056;5834.38738932406;5898.026825573818;5928.407159284124;5977.611455255482;5980.611260268069;9569.3779904306;9806.509674516246;10000.649977250761;10067.144292735053;10152.847707284396;9732.464714440774;9903.60385584583;9917.553710083064;9932.056454636799;9989.700308990741;7536.359409450149;7555.9244407555225;7569.318761311399;7622.085349757954;7631.54210747357;7389.96305018493;7410.703571857065;7473.663685134074;7557.924420755942;7567.735129270449;8700.56497175126;8864.645414183618;8888.377813553248;8917.509536975529;9087.2730181584;8923.438398280145;9056.728298151065;9080.182783549511;9090.863637045582;9383.108604682544;7092.929070709433;7237.203907570058;7257.383122434652;7263.854722905407;7273.818154546178;7498.512596681198;7689.384849211938;7737.264959828807;7881.172476890073;8002.51984880909;6750.831229219309;7319.2314806944505;7386.372158366599;7388.667509961957;7495.325420711944;6899.793006209822;7179.246179151114;7347;7369.742059027908;7410.96294518524;7446.813829654302;7450.254974502506;7466.4026877848555;7487.6630551626395;7501.249875012455;6437.903431448625;6556.147700798866;6605.603663779996;6606.537542371988;6621.172353455818;6861.313868613299;6915.585064896122;6918.446524277945;6932.7226910923;6934 23:21:18 INFO - PROCESS | 2939 | |4;prototype.html;362.7225172742851;369.70054256052583;370.05451072509743;373.03942348452733;378.42857285498906;6241.563090583661;6278.560500764948;6304.747810087597;6338.591335292594;6389.5527313088105;6112;6226.719797609107;6243.125962365272;6259.624422534651;6288.213973253343;4886.144924638192;4886.682365646222;4893.755312234383;4898.167311557044;4922.261660750898;4894.632902532307;4904.411470623512;4904.4605093439695;4917.901641967159;4918.434380046305;4761.40482439695;4814.35006274152;4857.684250523705;4871.171900776876;4877.195262781637;4823.951760482403;4825.203841366188;4825.372701548811;4827.372441582589;4849.078675051729;4290.935635965463;4296.957030429687;4312.202242585132;4314.050908800059;4325.52419233884;5447.210154527611;5948.405159484017;6037.094435834616;6041.214642096544;6063.9090413643835;5686.857828554278;5691.288588926384;5695.259616249902;5703.173039909231;5711.371749107595;6673.332666733288;6694;6695.665216739192;6704.899426508607;6713.664316784141;4790.257510085908;4799.992001679651;4804.231322988305;4806.807727690888;4808.855734327975;6856.588604683735;6989.685464154074;6998.125234345707;7063.328983746587;7083.86658134696;4910.631702622246;4915.877103072452;4917.360743103373;4940.011997600423;4940.357753492095;5009;5011.0980023595375;5016.698998060128;5024.547790698854;5030.119729047476;5443.836684899459;5684;5713.885722285614;5716.857078572986;5730.111832665943;6684.86630267392;6710.798676039727;6733.0237115617965;6748.325167483311;6759.628220447824;1679.1939868863014;1714.862810975119;1716.064744714134;1730.0484733396581;1733.8612910967092;1160.8897154770284;1164.342146687119;1166.4634268236537;1169.9005584525241;1175.5709166154293;6293.244810622755;6330.39861213184;6344.651044192614;6359.332270111664;6373.330800265998;6857.691403886837;6862.794116176523;6880.724771009103;6885.277045910208;6893.310668933066;6255.6872156392;6310.769399967055;6315.936840631627;6316.968415157895;6327.651979141099;3767.8869633911027;3804.4673745675627;3821.8280177392085;3834.2906562286066;3835.5972622874756;7242.529235599669;7246.673899674527;7270.563766174047;7271.272872712686;7278.381337586365;7060.682269297791;7235.167955685059;7238.384737297283;7256.1655409628565;7258.346748792634;7225;7247.456440766963;7247.565146091251;7274.854502910018;7297.635118244067;7056.964715176391;7072.398846098139;7077.681504332214;7079.469039822137;7100.573965562083;6654.700538475877;6875.862482750417;6882.8967565485555;6911.516193866381;6961.860762784615;7232.349088582053;7248.818779530554;7262.709491620276;7271.981922530744;7278.927210728037;4883.438404583519;4939.901201976012;4957.983613359324;4960.107180707508;4967.875803104951;6869.003994420681;6920.792376228721;6950.270221626656;6964.199117101598;7190.424766018601;6865.313468653095;6866.107406037183;6876.793696189123;6896.689648965909;6906.896396554156;6846.4522838173825;6846.931530684629;6852.897206541807;6854.794356169323;6919.861602768017;6562.146920900253;6702;6703.530752847254;6727.663616819237;6746.359095885883;6872.62200578973;6885.621290828852;6896.896546551706;6899.413549848319;6912.792616221522;6720.966395167993;6724.562903411263;6749.865002700017;6754.527183097136;6760.492963027891 23:21:18 INFO - PROCESS | 2939 | |5;yui.html;801.8917446144773;868.7784614923194;907.1472815553379;915.2312057871387;934.5467448287582;13712;13810.240436775974;13933.93033034836;13969.860301396982;14052.64868378291;13528.729425411511;13600.387982540784;13614.319284035808;13618.182909025441;13634.659133521642;878.5958459108817;883.218351758695;895.1361935732017;908.927285817133;913.1781396742919;910.9089091090871;911.9603651836911;913.1462082952461;916.880805495288;917.8714979902819;958;958.6596758150861;958.7267628725815;961.1781926452887;963;951.2104952889085;956.1729104324744;958.065885761384;958.0898146760605;960.9087136722001;698.0611078099947;699.2413231643673;704.9118860142482;705.9647017649097;706.1808302369227;14014.22921739304;14452.349644266033;14468.98717089804;14475.203863787487;14559.272036398137;13505.797413038812;13677.31613419335;13685.178889266675;13701.177929324273;13739;10790.028897399194;10895.891041089646;10940.617078402298;11335.603253886156;11444.771104577945;3931.0761970936805;3960.2673505401594;4014.41790940312;4027.8993025174314;4063.5936406359424;51526;52221.47778522242;52255.73872130653;52296.47703522954;52744.47255527434;10786.622468213733;10809.56761729522;10953.507092180871;10972.835407468894;11198.104151667847;19030.143643536074;19089.331873384643;19105.331313403964;19123.71314430285;19126.904365478083;7960.323372513285;7987.400944929153;8108.635111420001;8112.43212975086;8225.300849427746;4689.531046895283;4726.929096063562;4735.573798358164;4763.190257656207;4799.6400269979895;3165.7309128724314;3191.9042428727175;3193.3294008258063;3203.47142721453;3208.8876889308763;548.9094299440627;557.4926816596877;558.0680263959198;559.5998860814537;567.1266249975075;638.2022471910112;655.1384928818588;729.4201110117469;743.6319022084103;750.2609929219714;7912.802179945547;7936.761897143095;8177.182281771775;8206.876896846552;8535.95732021336;509.7349378323251;538.4741249795476;600.9759609615567;672.351181110231;724.0117239967511;4226.894327641833;4350.869473915787;4361.498427680857;4402.691811573159;4435.6229720473475;63779.68110159419;64076.67961660162;64367.356326437075;64560;64573.67713161498;55485;56058.159127613115;56848.715756420956;57160.42839571634;58350;49877.25184122241;51000.74499627478;51328.74335628298;51529.6811643477;51819.96360072853;8562.957185214034;8668.566571671518;8735.344849136467;8772.254358379609;8859.468431894107;36407.27185456329;37188.6281137196;38230.808845955595;38648.42027369535;39534;47301.52698472971;48433;48798.26802597893;48813;49070.75464622654;11955.820662690241;12286.139970202357;12431.818977197152;12439.689007774878;12477.625671229514;13466.259355735529;13476.191428514321;13706.862931370559;13780.173189608655;14107.576772696835;10976.725581860517;11073.50169242402;11253.549858005916;11455.312681239153;11888.167828251939;12690.682732931751;12722.427490763122;12802.743945121232;12875.227486350848;13120;11542.884571154182;11599.8260026098;12043.638690839289;12568.622941311774;12674.873251267369;10180.592776288866;10187;10302.381857088598;10433.63482278147;10643.201759868196;10383.844242336521;10569;10673;10715.410652414192;10749.14006879432 23:21:18 INFO - PROCESS | 2939 | __end_tp_report 23:21:18 INFO - PROCESS | 2939 | __start_cc_report 23:21:18 INFO - PROCESS | 2939 | _x_x_mozilla_cycle_collect,274 23:21:18 INFO - PROCESS | 2939 | __end_cc_report 23:21:18 INFO - PROCESS | 2939 | __startTimestamp1457076078098__endTimestamp 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | ------- Summary: start ------- 23:21:18 INFO - PROCESS | 2939 | Number of tests: 6 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | [#0] dojo.html Cycles:165 Average:5441.31 Median:5639.66 stddev:594.01 (10.5%) stddev-sans-first:572.07 23:21:18 INFO - PROCESS | 2939 | Values: 3320.9 3335.6 3342.0 3362.8 3368.8 5412.5 5429.0 5433.3 5464.9 5466.0 5425.8 5453.5 5475.2 5494.3 5503.6 4899.9 4939.2 4970.6 5031.1 5073.3 4923.7 4982.9 5010.1 5054.3 5087.5 5056.8 5071.2 5086.1 5112.3 5114.1 5046.6 5051.3 5064.1 5074.5 5081.4 4843.9 4928.3 4953.1 5006.6 5024.8 5246.5 5267.1 5320.8 5339.6 5343.3 5878.7 5918.6 5923.5 5931.0 5952.8 5794.3 5807.6 5877.8 5965.5 5995.0 5554.0 5557.4 5560.0 5561.9 5569.9 5778.9 5981.9 5984.4 6001.6 6005.0 5731.5 5804.5 5861.0 5866.9 5937.3 5710.9 5827.7 5831.4 5840.2 5857.9 5676.2 5778.2 5807.0 5817.1 5818.8 5791.6 5820.4 5871.2 5877.7 5900.4 4414.1 4436.5 4453.1 4484.6 4520.9 3925.0 4007.4 4025.3 4036.0 4070.7 5471.8 5532.4 5538.6 5550.4 5583.3 5971.0 6004.4 6012.2 6012.7 6015.0 5288.7 5382.0 5460.0 5560.3 5576.8 4986.2 5010.4 5032.5 5043.7 5067.6 5670.0 6018.3 6030.1 6049.4 6075.5 5791.2 5817.8 5899.4 5910.2 5925.2 6008.9 6019.5 6050.8 6062.9 6086.5 5642.8 5762.6 5777.0 5798.0 5826.2 5818.1 5819.5 5912.8 5927.3 5948.7 5648.4 5654.6 5670.8 5701.6 5717.9 5598.0 5685.5 5686.1 5717.0 5726.3 5581.7 5636.8 5639.7 5645.1 5656.8 5687.2 5692.5 5745.9 5776.2 5800.1 5395.1 5515.1 5526.0 5625.3 5643.9 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | [#1] ext.html Cycles:180 Average:55047.81 Median:38504.81 stddev:104262.43 (270.8%) stddev-sans-first:104474.51 23:21:18 INFO - PROCESS | 2939 | Values: 511.9 517.3 519.0 538.4 566.8 28861.7 30071.8 37755.6 37990.4 37991.6 41754.4 42134.0 42400.8 42423.2 42444.4 8706.2 8814.4 8819.7 8894.1 8923.2 8587.0 8691.7 8697.7 8705.0 8721.7 8685.4 8810.9 8999.0 9012.5 9026.8 8709.6 8887.7 8948.7 8969.6 9014.1 8661.0 8839.8 8850.6 8861.8 8878.8 39855.0 40331.2 40440.4 40485.4 40521.4 3402.2 3552.3 3586.6 3783.6 3919.4 32003.8 32029.8 32244.0 32469.4 32528.5 4124.8 4160.9 4178.2 4189.8 4248.8 293838.0 295512.0 296009.0 296490.0 351886.2 65445.7 66384.7 66393.0 66638.3 66698.7 69514.3 69637.0 69661.7 69785.7 70030.3 17173.9 17456.1 17485.6 17548.8 17551.3 12337.4 12503.0 12592.9 12628.7 12635.9 21576.8 22000.1 22062.2 22063.4 22098.9 8206.9 8356.0 8380.8 8424.0 8486.4 1024.2 1092.7 1133.8 1145.7 1149.7 29871.0 29987.3 30573.4 30851.8 30907.7 1164.4 1191.2 1193.9 1204.4 1232.8 15685.1 15876.5 16000.1 16100.0 16134.8 352168.0 533460.0 534502.0 535441.0 551871.0 51438.5 53618.7 54659.5 54725.5 54779.8 1471.2 1476.4 1484.4 1484.7 1567.1 28424.0 29291.0 29513.6 29863.7 30002.4 48433.0 48785.3 48861.3 48975.0 49124.8 333854.0 336574.0 336898.0 337432.0 337727.0 31770.5 31985.0 32036.7 33468.3 44570.6 42225.8 42348.0 42479.8 48310.8 49972.3 37648.8 38028.6 38412.6 38440.0 38748.2 37871.2 38249.8 38839.4 38988.8 39114.0 38335.6 38569.6 38768.2 38924.4 39248.4 33493.5 33939.5 34102.5 34114.5 34566.0 26677.5 26806.6 27030.5 27161.5 27184.2 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | [#2] jquery.html Cycles:180 Average:16821.91 Median:2185.28 stddev:27411.37 (1254.4%) stddev-sans-first:27460.49 23:21:18 INFO - PROCESS | 2939 | Values: 386.1 386.3 388.0 389.6 392.3 15925.6 16966.0 18034.4 18130.2 18337.0 10451.9 11008.7 11069.6 11332.0 11847.3 5069.9 5240.3 5247.3 5250.4 5262.5 5172.6 5274.8 5526.7 5528.6 5532.9 5270.7 5513.2 5524.6 5532.1 5536.8 5130.7 5344.1 5452.1 5459.4 5501.1 5144.0 5166.9 5169.0 5173.2 5175.5 13571.1 13805.3 13808.4 15454.8 21412.0 2120.8 2143.9 2226.7 2233.6 2258.6 10069.4 10213.3 10224.2 12026.0 13346.5 1917.0 1978.0 1984.9 1994.2 1999.0 59464.0 60797.0 61346.0 61957.0 62759.4 10590.9 10828.6 10902.8 10928.3 11010.7 14156.2 14209.9 14302.9 14383.3 14398.6 7964.1 7980.9 8137.1 8165.3 8195.1 7889.6 7900.6 7942.4 7954.2 8013.7 4210.0 4469.9 4487.8 4677.1 4815.1 1933.1 2017.3 2018.7 2022.4 2036.1 931.9 951.0 1004.1 1036.1 1036.5 14049.6 15824.0 16107.7 16923.2 17544.5 966.7 982.4 1015.6 1079.0 1103.2 9775.5 9863.9 9864.8 9879.4 9949.2 148762.0 149044.0 149524.0 150090.0 151198.0 71621.6 74583.3 76926.0 76986.6 77615.6 1154.3 1155.8 1195.8 1201.3 1207.8 15328.8 15502.6 15601.6 15936.8 15941.7 30962.0 31072.7 32373.8 33971.8 34763.1 35900.8 37153.3 37203.3 37584.8 37588.4 7630.7 7911.6 8021.1 8092.0 8179.6 11172.6 11472.8 11534.1 11988.9 11990.8 9938.9 10156.7 10431.1 10599.5 10672.8 10004.3 10232.3 10768.3 10882.9 10992.2 10535.0 10645.2 10713.0 10829.2 11073.3 7947.6 8132.0 8178.4 8179.9 8276.2 9204.7 11002.7 11071.6 11252.3 11291.0 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | [#3] mootools.html Cycles:180 Average:5766.42 Median:5110.04 stddev:3003.88 (58.8%) stddev-sans-first:2995.30 23:21:18 INFO - PROCESS | 2939 | Values: 1513.6 1523.1 1725.0 1837.1 1867.5 7970.7 8078.7 8183.8 8270.3 8291.8 8119.4 8194.2 8260.1 8323.3 8355.8 2404.9 2421.7 2424.6 2426.9 2428.5 2379.2 2395.8 2401.6 2424.9 2425.2 2376.0 2429.2 2442.4 2452.7 2465.1 2318.1 2361.1 2367.4 2371.5 2377.6 2356.8 2407.4 2422.7 2424.8 2431.7 7935.0 8011.8 8041.0 8043.7 8051.3 4872.7 4979.8 4980.2 5020.0 5021.9 3169.9 3247.7 3319.1 3320.8 3335.8 1126.1 1141.6 1144.4 1153.2 1163.3 11497.1 11599.5 11716.2 11748.9 11750.5 4518.0 4551.7 4559.3 4566.8 4591.3 10101.0 10121.0 10158.4 10173.8 10187.8 5082.0 5082.8 5097.1 5123.0 5133.4 4546.9 4571.8 4598.0 4625.0 4650.5 3762.8 3769.0 3799.2 3803.0 3819.3 1155.2 1185.6 1206.9 1207.4 1214.0 1035.6 1047.1 1063.2 1232.2 1385.1 7410.6 7421.5 7423.0 7495.5 7532.9 1082.5 1095.5 1121.8 1181.7 1199.6 5834.4 5898.0 5928.4 5977.6 5980.6 9569.4 9806.5 10000.6 10067.1 10152.8 9732.5 9903.6 9917.6 9932.1 9989.7 7536.4 7555.9 7569.3 7622.1 7631.5 7390.0 7410.7 7473.7 7557.9 7567.7 8700.6 8864.6 8888.4 8917.5 9087.3 8923.4 9056.7 9080.2 9090.9 9383.1 7092.9 7237.2 7257.4 7263.9 7273.8 7498.5 7689.4 7737.3 7881.2 8002.5 6750.8 7319.2 7386.4 7388.7 7495.3 6899.8 7179.2 7347.0 7369.7 7411.0 7446.8 7450.3 7466.4 7487.7 7501.2 6437.9 6556.1 6605.6 6606.5 6621.2 6861.3 6915.6 6918.4 6932.7 6934.0 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | [#4] prototype.html Cycles:180 Average:5673.58 Median:6313.35 stddev:1695.55 (26.9%) stddev-sans-first:1652.79 23:21:18 INFO - PROCESS | 2939 | Values: 362.7 369.7 370.1 373.0 378.4 6241.6 6278.6 6304.7 6338.6 6389.6 6112.0 6226.7 6243.1 6259.6 6288.2 4886.1 4886.7 4893.8 4898.2 4922.3 4894.6 4904.4 4904.5 4917.9 4918.4 4761.4 4814.4 4857.7 4871.2 4877.2 4824.0 4825.2 4825.4 4827.4 4849.1 4290.9 4297.0 4312.2 4314.1 4325.5 5447.2 5948.4 6037.1 6041.2 6063.9 5686.9 5691.3 5695.3 5703.2 5711.4 6673.3 6694.0 6695.7 6704.9 6713.7 4790.3 4800.0 4804.2 4806.8 4808.9 6856.6 6989.7 6998.1 7063.3 7083.9 4910.6 4915.9 4917.4 4940.0 4940.4 5009.0 5011.1 5016.7 5024.5 5030.1 5443.8 5684.0 5713.9 5716.9 5730.1 6684.9 6710.8 6733.0 6748.3 6759.6 1679.2 1714.9 1716.1 1730.0 1733.9 1160.9 1164.3 1166.5 1169.9 1175.6 6293.2 6330.4 6344.7 6359.3 6373.3 6857.7 6862.8 6880.7 6885.3 6893.3 6255.7 6310.8 6315.9 6317.0 6327.7 3767.9 3804.5 3821.8 3834.3 3835.6 7242.5 7246.7 7270.6 7271.3 7278.4 7060.7 7235.2 7238.4 7256.2 7258.3 7225.0 7247.5 7247.6 7274.9 7297.6 7057.0 7072.4 7077.7 7079.5 7100.6 6654.7 6875.9 6882.9 6911.5 6961.9 7232.3 7248.8 7262.7 7272.0 7278.9 4883.4 4939.9 4958.0 4960.1 4967.9 6869.0 6920.8 6950.3 6964.2 7190.4 6865.3 6866.1 6876.8 6896.7 6906.9 6846.5 6846.9 6852.9 6854.8 6919.9 6562.1 6702.0 6703.5 6727.7 6746.4 6872.6 6885.6 6896.9 6899.4 6912.8 6721.0 6724.6 6749.9 6754.5 6760.5 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - PROCESS | 2939 | [#5] yui.html Cycles:180 Average:14978.00 Median:4708.23 stddev:17588.34 (373.6%) stddev-sans-first:17605.47 23:21:18 INFO - PROCESS | 2939 | Values: 801.9 868.8 907.1 915.2 934.5 13712.0 13810.2 13933.9 13969.9 14052.6 13528.7 13600.4 13614.3 13618.2 13634.7 878.6 883.2 895.1 908.9 913.2 910.9 912.0 913.1 916.9 917.9 958.0 958.7 958.7 961.2 963.0 951.2 956.2 958.1 958.1 960.9 698.1 699.2 704.9 706.0 706.2 14014.2 14452.3 14469.0 14475.2 14559.3 13505.8 13677.3 13685.2 13701.2 13739.0 10790.0 10895.9 10940.6 11335.6 11444.8 3931.1 3960.3 4014.4 4027.9 4063.6 51526.0 52221.5 52255.7 52296.5 52744.5 10786.6 10809.6 10953.5 10972.8 11198.1 19030.1 19089.3 19105.3 19123.7 19126.9 7960.3 7987.4 8108.6 8112.4 8225.3 4689.5 4726.9 4735.6 4763.2 4799.6 3165.7 3191.9 3193.3 3203.5 3208.9 548.9 557.5 558.1 559.6 567.1 638.2 655.1 729.4 743.6 750.3 7912.8 7936.8 8177.2 8206.9 8536.0 509.7 538.5 601.0 672.4 724.0 4226.9 4350.9 4361.5 4402.7 4435.6 63779.7 64076.7 64367.4 64560.0 64573.7 55485.0 56058.2 56848.7 57160.4 58350.0 49877.3 51000.7 51328.7 51529.7 51820.0 8563.0 8668.6 8735.3 8772.3 8859.5 36407.3 37188.6 38230.8 38648.4 39534.0 47301.5 48433.0 48798.3 48813.0 49070.8 11955.8 12286.1 12431.8 12439.7 12477.6 13466.3 13476.2 13706.9 13780.2 14107.6 10976.7 11073.5 11253.5 11455.3 11888.2 12690.7 12722.4 12802.7 12875.2 13120.0 11542.9 11599.8 12043.6 12568.6 12674.9 10180.6 10187.0 10302.4 10433.6 10643.2 10383.8 10569.0 10673.0 10715.4 10749.1 23:21:18 INFO - PROCESS | 2939 | -------- Summary: end -------- 23:21:18 INFO - PROCESS | 2939 | 23:21:18 INFO - TEST-INFO | 2939: exit 0 23:21:18 INFO - TEST-OK | dromaeo_css | took 1107363ms 23:21:18 INFO - TEST-START | kraken 23:21:18 INFO - operating with platform_type : linux_ 23:21:18 INFO - Initialising browser for kraken test... 23:21:18 INFO - TEST-INFO | started process 3191 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp51dMA2/profile http://localhost:52909/getInfo.html) 23:21:22 INFO - PROCESS | 3191 | 23:21:22 INFO - PROCESS | 3191 | (process:3269): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:21:23 INFO - PROCESS | 3191 | __metrics Screen width/height:1600/1200 23:21:23 INFO - PROCESS | 3191 | colorDepth:24 23:21:23 INFO - PROCESS | 3191 | Browser inner width/height: 1024/697 23:21:23 INFO - PROCESS | 3191 | __metrics 23:21:23 INFO - TEST-INFO | 3191: exit 0 23:21:23 INFO - Browser initialized. 23:21:23 INFO - Running cycle 1/1 for kraken test... 23:21:23 INFO - TEST-INFO | started process 3318 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp51dMA2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:21:24 INFO - PROCESS | 3318 | 23:21:24 INFO - PROCESS | 3318 | (process:3380): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:21:35 INFO - PROCESS | 3318 | RSS: Main: 141008896 23:21:35 INFO - PROCESS | 3318 | 23:21:37 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52909/tests/kraken/driver.html?testName=audio-beat-detection) 23:21:38 INFO - PROCESS | 3318 | RSS: Main: 146022400 23:21:38 INFO - PROCESS | 3318 | 23:21:40 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52909/tests/kraken/driver.html?testName=audio-dft) 23:21:41 INFO - PROCESS | 3318 | RSS: Main: 144396288 23:21:41 INFO - PROCESS | 3318 | 23:21:44 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52909/tests/kraken/driver.html?testName=audio-fft) 23:21:44 INFO - PROCESS | 3318 | RSS: Main: 146792448 23:21:44 INFO - PROCESS | 3318 | 23:21:46 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52909/tests/kraken/driver.html?testName=audio-oscillator) 23:21:47 INFO - PROCESS | 3318 | RSS: Main: 144482304 23:21:47 INFO - PROCESS | 3318 | 23:21:49 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:21:50 INFO - PROCESS | 3318 | RSS: Main: 146804736 23:21:50 INFO - PROCESS | 3318 | 23:21:53 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52909/tests/kraken/driver.html?testName=imaging-darkroom) 23:21:53 INFO - PROCESS | 3318 | RSS: Main: 145551360 23:21:53 INFO - PROCESS | 3318 | 23:21:56 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52909/tests/kraken/driver.html?testName=imaging-desaturate) 23:21:57 INFO - PROCESS | 3318 | RSS: Main: 145518592 23:21:57 INFO - PROCESS | 3318 | 23:22:00 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52909/tests/kraken/driver.html?testName=json-parse-financial) 23:22:00 INFO - PROCESS | 3318 | RSS: Main: 146173952 23:22:00 INFO - PROCESS | 3318 | 23:22:02 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:22:02 INFO - PROCESS | 3318 | RSS: Main: 146587648 23:22:02 INFO - PROCESS | 3318 | 23:22:04 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:22:05 INFO - PROCESS | 3318 | RSS: Main: 146128896 23:22:05 INFO - PROCESS | 3318 | 23:22:07 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:22:07 INFO - PROCESS | 3318 | RSS: Main: 144564224 23:22:07 INFO - PROCESS | 3318 | 23:22:10 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:22:10 INFO - PROCESS | 3318 | RSS: Main: 146808832 23:22:10 INFO - PROCESS | 3318 | 23:22:13 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:22:13 INFO - PROCESS | 3318 | RSS: Main: 146206720 23:22:13 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | Cycle 1(1): loaded http://localhost:52909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52909/tests/kraken/driver.html?testName=ai-astar) 23:22:15 INFO - PROCESS | 3318 | RSS: Main: 148045824 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | __start_tp_report 23:22:15 INFO - PROCESS | 3318 | _x_x_mozilla_page_load 23:22:15 INFO - PROCESS | 3318 | _x_x_mozilla_page_load_details 23:22:15 INFO - PROCESS | 3318 | |i|pagename|runs| 23:22:15 INFO - PROCESS | 3318 | |0;ai-astar;113;107;112;112;112;120;111;112;111;112 23:22:15 INFO - PROCESS | 3318 | |1;audio-beat-detection;159;128;152;162;133;150;157;133;165;136 23:22:15 INFO - PROCESS | 3318 | |2;audio-dft;164;164;163;167;163;162;161;163;166;163 23:22:15 INFO - PROCESS | 3318 | |3;audio-fft;74;77;76;156;77;77;73;75;159;77 23:22:15 INFO - PROCESS | 3318 | |4;audio-oscillator;98;97;136;96;97;96;134;95;96;135 23:22:15 INFO - PROCESS | 3318 | |5;imaging-gaussian-blur;110;110;111;109;111;110;113;110;111;110 23:22:15 INFO - PROCESS | 3318 | |6;imaging-darkroom;148;148;148;148;147;149;147;151;148;148 23:22:15 INFO - PROCESS | 3318 | |7;imaging-desaturate;96;96;97;97;96;99;96;97;98;100 23:22:15 INFO - PROCESS | 3318 | |8;json-parse-financial;53;55;55;56;56;56;55;56;53;55 23:22:15 INFO - PROCESS | 3318 | |9;json-stringify-tinderbox;64;64;64;65;64;64;64;65;65;65 23:22:15 INFO - PROCESS | 3318 | |10;stanford-crypto-aes;83;81;90;90;87;87;85;85;85;83 23:22:15 INFO - PROCESS | 3318 | |11;stanford-crypto-ccm;122;131;119;123;118;117;118;121;115;130 23:22:15 INFO - PROCESS | 3318 | |12;stanford-crypto-pbkdf2;153;130;142;140;137;138;137;137;140;138 23:22:15 INFO - PROCESS | 3318 | |13;stanford-crypto-sha256-iterative;65;69;66;68;65;66;65;66;65;65 23:22:15 INFO - PROCESS | 3318 | __end_tp_report 23:22:15 INFO - PROCESS | 3318 | __start_cc_report 23:22:15 INFO - PROCESS | 3318 | _x_x_mozilla_cycle_collect,657 23:22:15 INFO - PROCESS | 3318 | __end_cc_report 23:22:15 INFO - PROCESS | 3318 | __startTimestamp1457076135637__endTimestamp 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | ------- Summary: start ------- 23:22:15 INFO - PROCESS | 3318 | Number of tests: 14 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:3.19 (2.8%) stddev-sans-first:3.37 23:22:15 INFO - PROCESS | 3318 | Values: 113.0 107.0 112.0 112.0 112.0 120.0 111.0 112.0 111.0 112.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:154.50 stddev:13.74 (8.9%) stddev-sans-first:13.93 23:22:15 INFO - PROCESS | 3318 | Values: 159.0 128.0 152.0 162.0 133.0 150.0 157.0 133.0 165.0 136.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 23:22:15 INFO - PROCESS | 3318 | Values: 164.0 164.0 163.0 167.0 163.0 162.0 161.0 163.0 166.0 163.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.50 stddev:34.50 (45.1%) stddev-sans-first:35.97 23:22:15 INFO - PROCESS | 3318 | Values: 74.0 77.0 76.0 156.0 77.0 77.0 73.0 75.0 159.0 77.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:96.00 stddev:18.65 (19.4%) stddev-sans-first:19.43 23:22:15 INFO - PROCESS | 3318 | Values: 98.0 97.0 136.0 96.0 97.0 96.0 134.0 95.0 96.0 135.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:1.08 (1.0%) stddev-sans-first:1.13 23:22:15 INFO - PROCESS | 3318 | Values: 110.0 110.0 111.0 109.0 111.0 110.0 113.0 110.0 111.0 110.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 23:22:15 INFO - PROCESS | 3318 | Values: 148.0 148.0 148.0 148.0 147.0 149.0 147.0 151.0 148.0 148.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:1.40 (1.4%) stddev-sans-first:1.41 23:22:15 INFO - PROCESS | 3318 | Values: 96.0 96.0 97.0 97.0 96.0 99.0 96.0 97.0 98.0 100.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.15 (2.1%) stddev-sans-first:0.97 23:22:15 INFO - PROCESS | 3318 | Values: 53.0 55.0 55.0 56.0 56.0 56.0 55.0 56.0 53.0 55.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 23:22:15 INFO - PROCESS | 3318 | Values: 64.0 64.0 64.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:2.95 (3.4%) stddev-sans-first:2.98 23:22:15 INFO - PROCESS | 3318 | Values: 83.0 81.0 90.0 90.0 87.0 87.0 85.0 85.0 85.0 83.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:121.50 stddev:5.36 (4.4%) stddev-sans-first:5.68 23:22:15 INFO - PROCESS | 3318 | Values: 122.0 131.0 119.0 123.0 118.0 117.0 118.0 121.0 115.0 130.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:139.00 stddev:5.79 (4.2%) stddev-sans-first:3.35 23:22:15 INFO - PROCESS | 3318 | Values: 153.0 130.0 142.0 140.0 137.0 138.0 137.0 137.0 140.0 138.0 23:22:15 INFO - PROCESS | 3318 | 23:22:15 INFO - PROCESS | 3318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.41 (2.1%) stddev-sans-first:1.45 23:22:15 INFO - PROCESS | 3318 | Values: 65.0 69.0 66.0 68.0 65.0 66.0 65.0 66.0 65.0 65.0 23:22:15 INFO - PROCESS | 3318 | -------- Summary: end -------- 23:22:15 INFO - PROCESS | 3318 | 23:22:16 INFO - TEST-INFO | 3318: exit 0 23:22:16 INFO - TEST-OK | kraken | took 57819ms 23:22:16 INFO - TEST-START | v8_7 23:22:16 INFO - operating with platform_type : linux_ 23:22:16 INFO - Initialising browser for v8_7 test... 23:22:16 INFO - TEST-INFO | started process 3609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmSKNTs/profile http://localhost:52909/getInfo.html) 23:22:20 INFO - PROCESS | 3609 | 23:22:20 INFO - PROCESS | 3609 | (process:3689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:22:21 INFO - PROCESS | 3609 | __metrics Screen width/height:1600/1200 23:22:21 INFO - PROCESS | 3609 | colorDepth:24 23:22:21 INFO - PROCESS | 3609 | Browser inner width/height: 1024/697 23:22:21 INFO - PROCESS | 3609 | __metrics 23:22:21 INFO - TEST-INFO | 3609: exit 0 23:22:21 INFO - Browser initialized. 23:22:21 INFO - Running cycle 1/1 for v8_7 test... 23:22:21 INFO - TEST-INFO | started process 3738 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmSKNTs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:22 INFO - PROCESS | 3738 | 23:22:22 INFO - PROCESS | 3738 | (process:3803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:22:33 INFO - PROCESS | 3738 | RSS: Main: 140959744 23:22:33 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | Cycle 1(1): loaded http://localhost:52909/tests/v8_7/run.html (next: http://localhost:52909/tests/v8_7/run.html) 23:22:55 INFO - PROCESS | 3738 | RSS: Main: 144158720 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | __start_tp_report 23:22:55 INFO - PROCESS | 3738 | _x_x_mozilla_page_load 23:22:55 INFO - PROCESS | 3738 | _x_x_mozilla_page_load_details 23:22:55 INFO - PROCESS | 3738 | |i|pagename|runs| 23:22:55 INFO - PROCESS | 3738 | |0;Richards;167.78523489932886 23:22:55 INFO - PROCESS | 3738 | |1;DeltaBlue;171.05713308244952 23:22:55 INFO - PROCESS | 3738 | |2;Encrypt;281.45229383619477 23:22:55 INFO - PROCESS | 3738 | |3;Decrypt;5469.945355191257 23:22:55 INFO - PROCESS | 3738 | |4;RayTrace;922.509225092251 23:22:55 INFO - PROCESS | 3738 | |5;Earley;577.3672055427252 23:22:55 INFO - PROCESS | 3738 | |6;Boyer;11375 23:22:55 INFO - PROCESS | 3738 | |7;RegExp;40740 23:22:55 INFO - PROCESS | 3738 | |8;Splay;499.5004995004995 23:22:55 INFO - PROCESS | 3738 | |9;NavierStokes;4892.682926829269 23:22:55 INFO - PROCESS | 3738 | __end_tp_report 23:22:55 INFO - PROCESS | 3738 | __startTimestamp1457076175872__endTimestamp 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | ------- Summary: start ------- 23:22:55 INFO - PROCESS | 3738 | Number of tests: 10 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 167.8 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#1] DeltaBlue Cycles:1 Average:171.06 Median:171.06 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 171.1 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 281.5 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#3] Decrypt Cycles:1 Average:5469.95 Median:5469.95 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 5469.9 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#4] RayTrace Cycles:1 Average:922.51 Median:922.51 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 922.5 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#5] Earley Cycles:1 Average:577.37 Median:577.37 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 577.4 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#6] Boyer Cycles:1 Average:11375.00 Median:11375.00 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 11375.0 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#7] RegExp Cycles:1 Average:40740.00 Median:40740.00 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 40740.0 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#8] Splay Cycles:1 Average:499.50 Median:499.50 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 499.5 23:22:55 INFO - PROCESS | 3738 | 23:22:55 INFO - PROCESS | 3738 | [#9] NavierStokes Cycles:1 Average:4892.68 Median:4892.68 stddev:0.00 (0.0%) 23:22:55 INFO - PROCESS | 3738 | Values: 4892.7 23:22:55 INFO - PROCESS | 3738 | -------- Summary: end -------- 23:22:55 INFO - PROCESS | 3738 | 23:22:56 INFO - TEST-INFO | 3738: exit 0 23:22:56 INFO - TEST-OK | v8_7 | took 40134ms 23:22:56 INFO - SUITE-END | took 1205s 23:22:56 INFO - Completed test suite (00:20:05) 23:22:56 INFO - Working with test: dromaeo_css 23:22:56 INFO - Generating results file: dromaeo_css 23:22:56 INFO - Working with test: kraken 23:22:56 INFO - Generating results file: kraken 23:22:56 INFO - javascript benchmark 23:22:56 INFO - Working with test: v8_7 23:22:56 INFO - Generating results file: v8_7 23:22:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:22:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 23:22:57 INFO - process_Request line: dromaeo_css 7232.29 graph.html#tests=[[72,52,43]] 23:22:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:22:57 INFO - process_Request line: kraken 1510.90 graph.html#tests=[[232,52,43]] 23:22:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:22:57 INFO - process_Request line: v8_7 21754.30 graph.html#tests=[[230,52,43]] 23:22:57 INFO - RETURN: dromaeo_css: 7232.29 23:22:57 INFO - RETURN: kraken: 1510.90 23:22:57 INFO - RETURN: v8_7: 21754.30 23:22:57 INFO - javascript benchmark 23:22:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3320.8837690680825, 3335.6164041135276, 3342.0, 3362.8150451725146, 3368.8147151906637, 5412.512873841353, 5428.995635807373, 5433.347998240211, 5464.9180262296095, 5465.972670136649, 5425.810096646618, 5453.509184173424, 5475.151351540508, 5494.2582751328555, 5503.642263252886, 4899.877503062434, 4939.2344186651035, 4970.627202959774, 5031.069252188338, 5073.340465739467, 4923.704577725348, 4982.853943592976, 5010.0981823271795, 5054.317667114948, 5087.49125087492, 5056.823011194609, 5071.1886098224295, 5086.084504789136, 5112.258722485256, 5114.053900028507, 5046.5710414614805, 5051.26756620288, 5064.139096353592, 5074.467180946003, 5081.390233172043, 4843.9031219375765, 4928.33467481889, 4953.133201689726, 5006.649534532584, 5024.84925452237, 5246.501582349671, 5267.078261304295, 5320.840374788762, 5339.599530035263, 5343.251944727741, 5878.676672782995, 5918.556108291896, 5923.496502797268, 5931.021381472052, 5952.761889524414, 5794.275715535558, 5807.622504537234, 5877.764889404419, 5965.522758179335, 5995.0, 5554.000279949608, 5557.444255574451, 5559.972200139014, 5561.916571251434, 5569.8607534811545, 5778.942210577925, 5981.940180598225, 5984.431479009487, 6001.609895356788, 6004.969975150097, 5731.541476681856, 5804.506616937523, 5860.970695146497, 5866.882662346729, 5937.287525496968, 5710.885782284331, 5827.679477628772, 5831.416858314219, 5840.1531777892815, 5857.945569797392, 5676.233708449389, 5778.191053252548, 5807.0, 5817.127430885401, 5818.796342128006, 5791.594588378773, 5820.417958204231, 5871.236739223959, 5877.706114694248, 5900.409959004065, 4414.09511050234, 4436.511983681792, 4453.087117140978, 4484.618807401343, 4520.932186017212, 3925.0187453136714, 4007.4189242559664, 4025.3156963316305, 4036.0, 4070.653994410449, 5471.753771080311, 5532.363778165482, 5538.584606154474, 5550.389457159709, 5583.302087239095, 5971.0, 6004.369541198112, 6012.218411606463, 6012.699365031731, 6014.969925150346, 5288.709120998382, 5381.973090134525, 5460.0, 5560.304961879765, 5576.776928922879, 4986.177280748709, 5010.3737032870895, 5032.521910418504, 5043.722595257296, 5067.619928505377, 5670.0, 6018.337982821886, 6030.065339872239, 6049.364816694272, 6075.48358389533, 5791.218185544982, 5817.825465236049, 5899.351071382231, 5910.202122713551, 5925.229720136354, 6008.939910600838, 6019.4883434908525, 6050.788222412194, 6062.878742425039, 6086.482648974709, 5642.774289028393, 5762.625429347079, 5776.960147173381, 5798.0, 5826.242588463472, 5818.127280907728, 5819.476247137778, 5912.763489460373, 5927.347991720821, 5948.672822994777, 5648.378678345461, 5654.575906806924, 5670.8015219467125, 5701.572382071444, 5717.8570535736935, 5598.020346439275, 5685.488306052475, 5686.118651609007, 5717.0, 5726.255586773693, 5581.665100094007, 5636.802711905064, 5639.661620302795, 5645.096784514458, 5656.830295091154, 5687.1753595729215, 5692.516136128475, 5745.913811292918, 5776.162456443708, 5800.100984347433, 5395.136778115482, 5515.145152501369, 5526.0, 5625.268715067015, 5643.943560564506], "unit": "score", "name": "dojo.html", "value": 5403.71611442737}, {"lowerIsBetter": false, "replicates": [511.9001794650042, 517.3326408932477, 518.9506996835304, 538.3701069748396, 566.7761234312446, 28861.711382886166, 30071.849640751792, 37755.62244377552, 37990.4301435478, 37991.62008379916, 41754.37368439468, 42134.0, 42400.787996059975, 42423.15153696924, 42444.363334550006, 8706.216440520368, 8814.382993190478, 8819.691310804123, 8894.11058894112, 8923.15230053144, 8586.957065214665, 8691.739247822576, 8697.739067827975, 8705.042445331008, 8721.738347849574, 8685.392022558424, 8810.929431583572, 8999.0, 9012.459252444874, 9026.774330641721, 8709.564521773886, 8887.733367998939, 8948.686795962143, 8969.551522423886, 9014.053524379977, 8661.0, 8839.779005524913, 8850.645974161025, 8861.778455538599, 8878.778030549223, 39855.0, 40331.193376132316, 40440.39339409911, 40485.39271910924, 40521.392179117334, 3402.166469215058, 3552.3250582389264, 3586.569611646593, 3783.621637836222, 3919.3729003359326, 32003.83998079995, 32029.839850800596, 32244.0, 32469.350612987608, 32528.512072318936, 4124.752514849119, 4160.875173744793, 4178.227027999799, 4189.832406703728, 4248.766317852517, 293838.0, 295512.0, 296009.0, 296490.0, 351886.2405687981, 65445.67277163679, 66384.66807666028, 66393.0, 66638.33361666418, 66698.66650666716, 69514.30485695078, 69637.0, 69661.65169174223, 69785.65107174432, 70030.29969700238, 17173.914130429268, 17456.127193640266, 17485.562860928578, 17548.82451175472, 17551.297948081934, 12337.383130843422, 12503.0, 12592.87407125917, 12628.684282892817, 12635.873641263654, 21576.78423215748, 22000.119995200013, 22062.22782202615, 22063.448413789785, 22098.889505552368, 8206.917930820615, 8355.95822020886, 8380.832383352421, 8424.0, 8486.40595158333, 1024.2318261304022, 1092.7377429417043, 1133.7789131119519, 1145.66202970124, 1149.7298134938283, 29871.0, 29987.250318741768, 30573.38853222923, 30851.845740771154, 30907.69092309093, 1164.371239530661, 1191.18999080626, 1193.9343336116597, 1204.3797444316185, 1232.8458942632171, 15685.13731744765, 15876.52370428889, 16000.079612288231, 16100.033997959925, 16134.75797863033, 352168.0, 533460.0, 534502.0, 535441.0, 551871.0, 51438.48561514337, 53618.73190634022, 54659.45340546623, 54725.45274547283, 54779.80880764725, 1471.2055490035475, 1476.4020571668277, 1484.398818478518, 1484.6585285384206, 1567.1067491529946, 28424.0, 29291.0, 29513.557296640138, 29863.70136298696, 30002.399952001273, 48433.0, 48785.268220976, 48861.2670809931, 48975.0, 49124.75437622789, 333854.0, 336574.0, 336898.0, 337432.0, 337727.0, 31770.523442147925, 31985.0, 32036.67963320337, 33468.33063338768, 44570.55429445664, 42225.78887105545, 42348.0, 42479.7876010618, 48310.75844620895, 49972.250416243056, 37648.811755941046, 38028.61971380251, 38412.61587384202, 38440.0, 38748.225035499694, 37871.24257514889, 38249.808750956065, 38839.41740873833, 38988.80505597454, 39114.0, 38335.61664383321, 38569.6143038566, 38768.22463550769, 38924.41613375745, 39248.41127383149, 33493.497597536545, 33939.4909076369, 34102.48846267258, 34114.48828267528, 34566.0, 26677.46645067049, 26806.594306369607, 27030.459390812466, 27161.456770864075, 27184.184474465797], "unit": "score", "name": "ext.html", "value": 19812.836676656196}, {"lowerIsBetter": false, "replicates": [386.09846009567656, 386.33357458384285, 387.9534455865296, 389.6103896103898, 392.3056190542738, 15925.601859953493, 16966.0, 18034.36879709212, 18130.18414171364, 18337.0, 10451.947740261288, 11008.724781880457, 11069.557217711303, 11332.0, 11847.348395838226, 5069.873253168664, 5240.3187585614005, 5247.2653828464045, 5250.4487028861995, 5262.526372626463, 5172.612054095939, 5274.81538146165, 5526.668399895999, 5528.55771538276, 5532.944670553283, 5270.710110943896, 5513.2005859150395, 5524.640898341615, 5532.1425179097105, 5536.778528858861, 5130.71781052042, 5344.091504444254, 5452.127659574468, 5459.372172200208, 5501.119820828668, 5144.0, 5166.948330516684, 5169.0, 5173.224016397533, 5175.508326708957, 13571.117877337942, 13805.309734513234, 13808.447662093504, 15454.845451545565, 21412.0, 2120.7879212078824, 2143.871367717942, 2226.6882636430914, 2233.609118404273, 2258.6386178211574, 10069.395836249849, 10213.33613315132, 10224.182065434747, 12026.0, 13346.466141354334, 1917.0, 1977.9703304450445, 1984.8709833860753, 1994.222253321206, 1998.950026249341, 59464.0, 60797.0, 61346.0, 61957.0, 62759.37240627581, 10590.881823635304, 10828.620998265023, 10902.836457453144, 10928.344299342065, 11010.724731881606, 14156.221407822668, 14209.85790142106, 14302.928485357716, 14383.28083595816, 14398.568042958728, 7964.123946365895, 7980.920190798134, 8137.104918458965, 8165.346772258205, 8195.139510351446, 7889.644965976545, 7900.644470998819, 7942.404319675932, 7954.164812694699, 8013.679452821939, 4209.97895010523, 4469.888252793706, 4487.775611219426, 4677.134730074947, 4815.109204797123, 1933.139752809986, 2017.2536161620294, 2018.7072874433125, 2022.4438279473263, 2036.093938197488, 931.9021502742114, 950.9919485345556, 1004.1063453526367, 1036.0571879589688, 1036.4506811389974, 14049.611357868029, 15824.0, 16107.677846443006, 16923.238454269587, 17544.473665790047, 966.7438128895848, 982.3516479123743, 1015.619142821442, 1078.978420431587, 1103.2442776697826, 9775.51122443875, 9863.901360986441, 9864.802703945881, 9879.357841740264, 9949.204063675033, 148762.0, 149044.0, 149524.0, 150090.0, 151198.0, 71621.6418917902, 74583.25416745871, 76926.0, 76986.6150669243, 77615.61192194003, 1154.261272785418, 1155.7861795567678, 1195.8146487294484, 1201.3152503073165, 1207.7946749052505, 15328.846711533188, 15502.612434689223, 15601.609959751097, 15936.840631594, 15941.68116637684, 30962.0, 31072.68927310698, 32373.838130809196, 33971.83014084914, 34763.13092172716, 35900.82049589735, 37153.25693486169, 37203.255934881694, 37584.812075939444, 37588.436173457965, 7630.656620451982, 7911.604419779103, 8021.077576078826, 8091.959540202261, 8179.631916563888, 11172.553097875994, 11472.82790758156, 11534.13493987971, 11988.940055299669, 11990.820137697767, 9938.900610994087, 10156.695299141038, 10431.061204491632, 10599.47002649849, 10672.786544269227, 10004.349717268355, 10232.334898231591, 10768.300060496043, 10882.945585272022, 10992.17558683118, 10535.0, 10645.201609879136, 10713.0, 10829.187810914056, 11073.335599864035, 7947.562884041433, 8131.983502062242, 8178.386621003329, 8179.877301840596, 8276.172382761675, 9204.677836275698, 11002.724931876766, 11071.5571377144, 11252.26860254081, 11291.0], "unit": "score", "name": "jquery.html", "value": 8113.455632118922}, {"lowerIsBetter": false, "replicates": [1513.5686329396124, 1523.0633160606228, 1724.9827501724988, 1837.0998210876674, 1867.5144462439762, 7970.721024764134, 8078.71724489643, 8183.836323273531, 8270.255676989069, 8291.751247462578, 8119.431639785203, 8194.180581941802, 8260.132686067967, 8323.33413326934, 8355.83288334233, 2404.8677322747285, 2421.709394872618, 2424.5878200705924, 2426.8907899144583, 2428.4778772563895, 2379.202967006055, 2395.8442701224367, 2401.5677178107935, 2424.854508729482, 2425.163318655061, 2375.964360534593, 2429.161939131006, 2442.3894026493376, 2452.681151450309, 2465.0879174705383, 2318.13070098713, 2361.1381845626393, 2367.3963139399343, 2371.513839662865, 2377.583922813518, 2356.7761062699014, 2407.446287353901, 2422.7213870404953, 2424.818138639609, 2431.659567660529, 7935.0, 8011.839763204762, 8040.959795201045, 8043.678252869879, 8051.315638170762, 4872.731999740013, 4979.800807967713, 4980.153373926441, 5020.046191223656, 5021.874453138665, 3169.904902852918, 3247.675232476757, 3319.1204330852343, 3320.8173550454717, 3335.7664963452567, 1126.0822429719751, 1141.6403832792728, 1144.3991904250252, 1153.2388623508443, 1163.3194581170026, 11497.080233581293, 11599.536018559247, 11716.179867409284, 11748.941255293668, 11750.471228794639, 4517.983453722952, 4551.748269225989, 4559.316102584638, 4566.794494247767, 4591.265397536378, 10100.989901009987, 10121.0, 10158.39049657023, 10173.796524069625, 10187.796244075225, 5081.9745901271, 5082.822101226513, 5097.108006098918, 5122.974385128051, 5133.4096578893905, 4546.863594092182, 4571.839985600488, 4598.0, 4625.0, 4650.465196502446, 3762.7554208976876, 3768.962310376916, 3799.2021675447913, 3803.0492376905772, 3819.3316169670197, 1155.2086820527966, 1185.5554167187304, 1206.8853458921387, 1207.3600991474532, 1213.9757204855853, 1035.570238351076, 1047.1413440978324, 1063.2291588598205, 1232.168286406672, 1385.1135273425016, 7410.592417416986, 7421.517601355895, 7423.0, 7495.475316727777, 7532.887006694904, 1082.4695899009428, 1095.5179720922768, 1121.770037142384, 1181.7400171962154, 1199.6101267088056, 5834.38738932406, 5898.026825573818, 5928.407159284124, 5977.611455255482, 5980.611260268069, 9569.3779904306, 9806.509674516246, 10000.649977250761, 10067.144292735053, 10152.847707284396, 9732.464714440774, 9903.60385584583, 9917.553710083064, 9932.056454636799, 9989.700308990741, 7536.359409450149, 7555.9244407555225, 7569.318761311399, 7622.085349757954, 7631.54210747357, 7389.96305018493, 7410.703571857065, 7473.663685134074, 7557.924420755942, 7567.735129270449, 8700.56497175126, 8864.645414183618, 8888.377813553248, 8917.509536975529, 9087.2730181584, 8923.438398280145, 9056.728298151065, 9080.182783549511, 9090.863637045582, 9383.108604682544, 7092.929070709433, 7237.203907570058, 7257.383122434652, 7263.854722905407, 7273.818154546178, 7498.512596681198, 7689.384849211938, 7737.264959828807, 7881.172476890073, 8002.51984880909, 6750.831229219309, 7319.2314806944505, 7386.372158366599, 7388.667509961957, 7495.325420711944, 6899.793006209822, 7179.246179151114, 7347.0, 7369.742059027908, 7410.96294518524, 7446.813829654302, 7450.254974502506, 7466.4026877848555, 7487.6630551626395, 7501.249875012455, 6437.903431448625, 6556.147700798866, 6605.603663779996, 6606.537542371988, 6621.172353455818, 6861.313868613299, 6915.585064896122, 6918.446524277945, 6932.7226910923, 6934.0], "unit": "score", "name": "mootools.html", "value": 4735.752754994869}, {"lowerIsBetter": false, "replicates": [362.7225172742851, 369.70054256052583, 370.05451072509743, 373.03942348452733, 378.42857285498906, 6241.563090583661, 6278.560500764948, 6304.747810087597, 6338.591335292594, 6389.5527313088105, 6112.0, 6226.719797609107, 6243.125962365272, 6259.624422534651, 6288.213973253343, 4886.144924638192, 4886.682365646222, 4893.755312234383, 4898.167311557044, 4922.261660750898, 4894.632902532307, 4904.411470623512, 4904.4605093439695, 4917.901641967159, 4918.434380046305, 4761.40482439695, 4814.35006274152, 4857.684250523705, 4871.171900776876, 4877.195262781637, 4823.951760482403, 4825.203841366188, 4825.372701548811, 4827.372441582589, 4849.078675051729, 4290.935635965463, 4296.957030429687, 4312.202242585132, 4314.050908800059, 4325.52419233884, 5447.210154527611, 5948.405159484017, 6037.094435834616, 6041.214642096544, 6063.9090413643835, 5686.857828554278, 5691.288588926384, 5695.259616249902, 5703.173039909231, 5711.371749107595, 6673.332666733288, 6694.0, 6695.665216739192, 6704.899426508607, 6713.664316784141, 4790.257510085908, 4799.992001679651, 4804.231322988305, 4806.807727690888, 4808.855734327975, 6856.588604683735, 6989.685464154074, 6998.125234345707, 7063.328983746587, 7083.86658134696, 4910.631702622246, 4915.877103072452, 4917.360743103373, 4940.011997600423, 4940.357753492095, 5009.0, 5011.0980023595375, 5016.698998060128, 5024.547790698854, 5030.119729047476, 5443.836684899459, 5684.0, 5713.885722285614, 5716.857078572986, 5730.111832665943, 6684.86630267392, 6710.798676039727, 6733.0237115617965, 6748.325167483311, 6759.628220447824, 1679.1939868863014, 1714.862810975119, 1716.064744714134, 1730.0484733396581, 1733.8612910967092, 1160.8897154770284, 1164.342146687119, 1166.4634268236537, 1169.9005584525241, 1175.5709166154293, 6293.244810622755, 6330.39861213184, 6344.651044192614, 6359.332270111664, 6373.330800265998, 6857.691403886837, 6862.794116176523, 6880.724771009103, 6885.277045910208, 6893.310668933066, 6255.6872156392, 6310.769399967055, 6315.936840631627, 6316.968415157895, 6327.651979141099, 3767.8869633911027, 3804.4673745675627, 3821.8280177392085, 3834.2906562286066, 3835.5972622874756, 7242.529235599669, 7246.673899674527, 7270.563766174047, 7271.272872712686, 7278.381337586365, 7060.682269297791, 7235.167955685059, 7238.384737297283, 7256.1655409628565, 7258.346748792634, 7225.0, 7247.456440766963, 7247.565146091251, 7274.854502910018, 7297.635118244067, 7056.964715176391, 7072.398846098139, 7077.681504332214, 7079.469039822137, 7100.573965562083, 6654.700538475877, 6875.862482750417, 6882.8967565485555, 6911.516193866381, 6961.860762784615, 7232.349088582053, 7248.818779530554, 7262.709491620276, 7271.981922530744, 7278.927210728037, 4883.438404583519, 4939.901201976012, 4957.983613359324, 4960.107180707508, 4967.875803104951, 6869.003994420681, 6920.792376228721, 6950.270221626656, 6964.199117101598, 7190.424766018601, 6865.313468653095, 6866.107406037183, 6876.793696189123, 6896.689648965909, 6906.896396554156, 6846.4522838173825, 6846.931530684629, 6852.897206541807, 6854.794356169323, 6919.861602768017, 6562.146920900253, 6702.0, 6703.530752847254, 6727.663616819237, 6746.359095885883, 6872.62200578973, 6885.621290828852, 6896.896546551706, 6899.413549848319, 6912.792616221522, 6720.966395167993, 6724.562903411263, 6749.865002700017, 6754.527183097136, 6760.492963027891], "unit": "score", "name": "prototype.html", "value": 5126.680193405357}, {"lowerIsBetter": false, "replicates": [801.8917446144773, 868.7784614923194, 907.1472815553379, 915.2312057871387, 934.5467448287582, 13712.0, 13810.240436775974, 13933.93033034836, 13969.860301396982, 14052.64868378291, 13528.729425411511, 13600.387982540784, 13614.319284035808, 13618.182909025441, 13634.659133521642, 878.5958459108817, 883.218351758695, 895.1361935732017, 908.927285817133, 913.1781396742919, 910.9089091090871, 911.9603651836911, 913.1462082952461, 916.880805495288, 917.8714979902819, 958.0, 958.6596758150861, 958.7267628725815, 961.1781926452887, 963.0, 951.2104952889085, 956.1729104324744, 958.065885761384, 958.0898146760605, 960.9087136722001, 698.0611078099947, 699.2413231643673, 704.9118860142482, 705.9647017649097, 706.1808302369227, 14014.22921739304, 14452.349644266033, 14468.98717089804, 14475.203863787487, 14559.272036398137, 13505.797413038812, 13677.31613419335, 13685.178889266675, 13701.177929324273, 13739.0, 10790.028897399194, 10895.891041089646, 10940.617078402298, 11335.603253886156, 11444.771104577945, 3931.0761970936805, 3960.2673505401594, 4014.41790940312, 4027.8993025174314, 4063.5936406359424, 51526.0, 52221.47778522242, 52255.73872130653, 52296.47703522954, 52744.47255527434, 10786.622468213733, 10809.56761729522, 10953.507092180871, 10972.835407468894, 11198.104151667847, 19030.143643536074, 19089.331873384643, 19105.331313403964, 19123.71314430285, 19126.904365478083, 7960.323372513285, 7987.400944929153, 8108.635111420001, 8112.43212975086, 8225.300849427746, 4689.531046895283, 4726.929096063562, 4735.573798358164, 4763.190257656207, 4799.6400269979895, 3165.7309128724314, 3191.9042428727175, 3193.3294008258063, 3203.47142721453, 3208.8876889308763, 548.9094299440627, 557.4926816596877, 558.0680263959198, 559.5998860814537, 567.1266249975075, 638.2022471910112, 655.1384928818588, 729.4201110117469, 743.6319022084103, 750.2609929219714, 7912.802179945547, 7936.761897143095, 8177.182281771775, 8206.876896846552, 8535.95732021336, 509.7349378323251, 538.4741249795476, 600.9759609615567, 672.351181110231, 724.0117239967511, 4226.894327641833, 4350.869473915787, 4361.498427680857, 4402.691811573159, 4435.6229720473475, 63779.68110159419, 64076.67961660162, 64367.356326437075, 64560.0, 64573.67713161498, 55485.0, 56058.159127613115, 56848.715756420956, 57160.42839571634, 58350.0, 49877.25184122241, 51000.74499627478, 51328.74335628298, 51529.6811643477, 51819.96360072853, 8562.957185214034, 8668.566571671518, 8735.344849136467, 8772.254358379609, 8859.468431894107, 36407.27185456329, 37188.6281137196, 38230.808845955595, 38648.42027369535, 39534.0, 47301.52698472971, 48433.0, 48798.26802597893, 48813.0, 49070.75464622654, 11955.820662690241, 12286.139970202357, 12431.818977197152, 12439.689007774878, 12477.625671229514, 13466.259355735529, 13476.191428514321, 13706.862931370559, 13780.173189608655, 14107.576772696835, 10976.725581860517, 11073.50169242402, 11253.549858005916, 11455.312681239153, 11888.167828251939, 12690.682732931751, 12722.427490763122, 12802.743945121232, 12875.227486350848, 13120.0, 11542.884571154182, 11599.8260026098, 12043.638690839289, 12568.622941311774, 12674.873251267369, 10180.592776288866, 10187.0, 10302.381857088598, 10433.63482278147, 10643.201759868196, 10383.844242336521, 10569.0, 10673.0, 10715.410652414192, 10749.14006879432], "unit": "score", "name": "yui.html", "value": 6784.955101354078}], "name": "dromaeo_css", "value": 7232.285062344153}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 112.0, 112.0, 112.0, 120.0, 111.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [159.0, 128.0, 152.0, 162.0, 133.0, 150.0, 157.0, 133.0, 165.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 167.0, 163.0, 162.0, 161.0, 163.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 76.0, 156.0, 77.0, 77.0, 73.0, 75.0, 159.0, 77.0], "unit": "score", "name": "audio-fft", "value": 92.1}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 136.0, 96.0, 97.0, 96.0, 134.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 109.0, 111.0, 110.0, 113.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 147.0, 151.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 99.0, 96.0, 97.0, 98.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 90.0, 90.0, 87.0, 87.0, 85.0, 85.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [122.0, 131.0, 119.0, 123.0, 118.0, 117.0, 118.0, 121.0, 115.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 142.0, 140.0, 137.0, 138.0, 137.0, 137.0, 140.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 66.0, 68.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1510.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [171.05713308244952], "unit": "score", "name": "DeltaBlue", "value": 386.5258280000001}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5469.945355191257], "unit": "score", "name": "Decrypt", "value": 48.66246053946057}, {"lowerIsBetter": false, "replicates": [922.509225092251], "unit": "score", "name": "RayTrace", "value": 802.1480759999998}, {"lowerIsBetter": false, "replicates": [577.3672055427252], "unit": "score", "name": "Earley", "value": 1154.3139159999996}, {"lowerIsBetter": false, "replicates": [11375.0], "unit": "score", "name": "Boyer", "value": 58.59015384615384}, {"lowerIsBetter": false, "replicates": [40740.0], "unit": "score", "name": "RegExp", "value": 22.360947471772207}, {"lowerIsBetter": false, "replicates": [499.5004995004995], "unit": "score", "name": "Splay", "value": 163.14498199999997}, {"lowerIsBetter": false, "replicates": [4892.682926829269], "unit": "score", "name": "NavierStokes", "value": 303.3100697906281}], "name": "v8_7", "value": 21754.302261918736}]} 23:22:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21754.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1510.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7232.29"}}} 23:22:57 INFO - Return code: 0 23:22:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:22:57 INFO - # TBPL SUCCESS # 23:22:57 INFO - Running post-action listener: _resource_record_post_action 23:22:57 INFO - Running post-run listener: _resource_record_post_run 23:22:58 INFO - Total resource usage - Wall time: 1222s; CPU: 25.0%; Read bytes: 4096; Write bytes: 360673280; Read time: 4; Write time: 442932 23:22:58 INFO - install - Wall time: 15s; CPU: 25.0%; Read bytes: 0; Write bytes: 105545728; Read time: 0; Write time: 122352 23:22:58 INFO - run-tests - Wall time: 1207s; CPU: 25.0%; Read bytes: 4096; Write bytes: 255127552; Read time: 4; Write time: 320580 23:22:58 INFO - Running post-run listener: _upload_blobber_files 23:22:58 INFO - Blob upload gear active. 23:22:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:22:58 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:22:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:22:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:22:58 INFO - (blobuploader) - INFO - Open directory for files ... 23:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:22:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:22:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:22:59 INFO - (blobuploader) - INFO - Done attempting. 23:22:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:22:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:22:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:23:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:00 INFO - (blobuploader) - INFO - Done attempting. 23:23:00 INFO - (blobuploader) - INFO - Iteration through files over. 23:23:00 INFO - Return code: 0 23:23:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:23:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:23:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba503ddb39492f5035eae20ea77379341d0bf02cd4cc7c9225506c56ac6ae587fd26a95e590c66089619ea354528918cbc305228ef98a7f7b9d800be5121187", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/579701912456f6ffd7534b3bb38fc7631d4c2c9723be8275cfbb05821e869d1b3fff3fe58c8e1a4be9fbbfbe708778843067ea3547e12ae97d827552626e6f3f"} 23:23:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:23:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:23:00 INFO - Contents: 23:23:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba503ddb39492f5035eae20ea77379341d0bf02cd4cc7c9225506c56ac6ae587fd26a95e590c66089619ea354528918cbc305228ef98a7f7b9d800be5121187", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/579701912456f6ffd7534b3bb38fc7631d4c2c9723be8275cfbb05821e869d1b3fff3fe58c8e1a4be9fbbfbe708778843067ea3547e12ae97d827552626e6f3f"} 23:23:00 INFO - Running post-run listener: copy_logs_to_upload_dir 23:23:00 INFO - Copying logs to upload dir... 23:23:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:23:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.976177 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-03-03 23:23:00.158491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 23:23:00.162345) ========= 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba503ddb39492f5035eae20ea77379341d0bf02cd4cc7c9225506c56ac6ae587fd26a95e590c66089619ea354528918cbc305228ef98a7f7b9d800be5121187", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/579701912456f6ffd7534b3bb38fc7631d4c2c9723be8275cfbb05821e869d1b3fff3fe58c8e1a4be9fbbfbe708778843067ea3547e12ae97d827552626e6f3f"} build_url:https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005466 build_url: 'https://queue.taskcluster.net/v1/task/Q2wtwrD_Q7uXT4Rxy9j6tw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba503ddb39492f5035eae20ea77379341d0bf02cd4cc7c9225506c56ac6ae587fd26a95e590c66089619ea354528918cbc305228ef98a7f7b9d800be5121187", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/579701912456f6ffd7534b3bb38fc7631d4c2c9723be8275cfbb05821e869d1b3fff3fe58c8e1a4be9fbbfbe708778843067ea3547e12ae97d827552626e6f3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 23:23:00.176589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:23:00.177006) ========= 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=8783db0840cc980e80bb0bd400000236-1457069603.732934-1722061520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002136 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:23:00.259099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 23:23:00.259426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 23:23:00.259757) ========= ========= Total master_lag: 0.29 =========