builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1452242964.94 results: success (0) buildid: 20160107223016 builduid: faed33b1dec44c96b22ff93d4962a751 revision: 512d9c5b57888d40416f091b4ceda78496005499 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:24.944003) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:24.944388) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:24.944659) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006340 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:24.972874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:24.973179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.016129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.016387) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.067134) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.067425) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.067785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.068065) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 00:49:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-01-08 00:49:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.183657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.183940) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020180 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.233620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.234002) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 512d9c5b57888d40416f091b4ceda78496005499 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 512d9c5b57888d40416f091b4ceda78496005499 --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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 00:49:25,601 truncating revision to first 12 chars 2016-01-08 00:49:25,601 Setting DEBUG logging. 2016-01-08 00:49:25,602 attempt 1/10 2016-01-08 00:49:25,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/512d9c5b5788?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 00:49:25,849 unpacking tar archive at: mozilla-inbound-512d9c5b5788/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.798317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.798613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.805644) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.805934) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 00:49:25.806338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-08 00:49:25.806622) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:49:26 INFO - MultiFileLogger online at 20160108 00:49:26 in /builds/slave/test-pgo 00:49:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:49:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:49:26 INFO - {'append_to_log': False, 00:49:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:49:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:49:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:49:26 INFO - 'branch': 'Mozilla-Inbound', 00:49:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:49:26 INFO - 'config_files': ('talos/linux_config.py',), 00:49:26 INFO - 'default_actions': ('clobber', 00:49:26 INFO - 'read-buildbot-config', 00:49:26 INFO - 'download-and-extract', 00:49:26 INFO - 'populate-webroot', 00:49:26 INFO - 'create-virtualenv', 00:49:26 INFO - 'install', 00:49:26 INFO - 'run-tests'), 00:49:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:49:26 INFO - 'download_minidump_stackwalk': True, 00:49:26 INFO - 'download_symbols': 'ondemand', 00:49:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:49:26 INFO - 'tooltool.py': '/tools/tooltool.py', 00:49:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:49:26 INFO - '/tools/misc-python/virtualenv.py')}, 00:49:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:49:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:49:26 INFO - 'installer_path': 'installer.exe', 00:49:26 INFO - 'log_level': 'info', 00:49:26 INFO - 'log_name': 'talos', 00:49:26 INFO - 'log_to_console': True, 00:49:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:49:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:49:26 INFO - 'opt_config_files': (), 00:49:26 INFO - 'pip_index': False, 00:49:26 INFO - 'sps_profile': False, 00:49:26 INFO - 'sps_profile_interval': 0, 00:49:26 INFO - 'suite': 'dromaeojs-e10s', 00:49:26 INFO - 'system_bits': '32', 00:49:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:49:26 INFO - 'title': 'talos-linux64-ix-036', 00:49:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:49:26 INFO - 'use_talos_json': True, 00:49:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:49:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:49:26 INFO - 'work_dir': 'build'} 00:49:26 INFO - ##### 00:49:26 INFO - ##### Running clobber step. 00:49:26 INFO - ##### 00:49:26 INFO - Running pre-action listener: _resource_record_pre_action 00:49:26 INFO - Running main action method: clobber 00:49:26 INFO - rmtree: /builds/slave/test-pgo/build 00:49:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:49:27 INFO - Running post-action listener: _resource_record_post_action 00:49:27 INFO - ##### 00:49:27 INFO - ##### Running read-buildbot-config step. 00:49:27 INFO - ##### 00:49:27 INFO - Running pre-action listener: _resource_record_pre_action 00:49:27 INFO - Running main action method: read_buildbot_config 00:49:27 INFO - Using buildbot properties: 00:49:27 INFO - { 00:49:27 INFO - "project": "", 00:49:27 INFO - "product": "firefox", 00:49:27 INFO - "script_repo_revision": "production", 00:49:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 00:49:27 INFO - "repository": "", 00:49:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 00:49:27 INFO - "buildid": "20160107223016", 00:49:27 INFO - "pgo_build": "True", 00:49:27 INFO - "basedir": "/builds/slave/test-pgo", 00:49:27 INFO - "buildnumber": 599, 00:49:27 INFO - "slavename": "talos-linux64-ix-036", 00:49:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:49:27 INFO - "platform": "ubuntu64_hw", 00:49:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:49:27 INFO - "branch": "mozilla-inbound", 00:49:27 INFO - "repo_path": "integration/mozilla-inbound", 00:49:27 INFO - "revision": "512d9c5b57888d40416f091b4ceda78496005499", 00:49:27 INFO - "stage_platform": "linux64-pgo", 00:49:27 INFO - "builduid": "faed33b1dec44c96b22ff93d4962a751", 00:49:27 INFO - "slavebuilddir": "test" 00:49:27 INFO - } 00:49:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:49:27 INFO - Running post-action listener: _resource_record_post_action 00:49:27 INFO - ##### 00:49:27 INFO - ##### Running download-and-extract step. 00:49:27 INFO - ##### 00:49:27 INFO - Running pre-action listener: _resource_record_pre_action 00:49:27 INFO - Running main action method: download_and_extract 00:49:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:49:27 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')]} 00:49:27 INFO - https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/test_packages.json 00:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/test_packages.json 00:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:49:28 INFO - Downloaded 1302 bytes. 00:49:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:49:28 INFO - Using the following test package requirements: 00:49:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:49:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'jsshell-linux-x86_64.zip'], 00:49:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:49:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:49:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:49:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:49:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:49:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:49:28 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')]} 00:49:28 INFO - https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:49:31 INFO - Downloaded 24028338 bytes. 00:49:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:49:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:49:32 INFO - Return code: 0 00:49:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:49:32 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')]} 00:49:32 INFO - https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:49:33 INFO - Downloaded 24028338 bytes. 00:49:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:49:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:49:35 INFO - Return code: 0 00:49: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')]} 00:49:35 INFO - https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:49:37 INFO - Downloaded 11132285 bytes. 00:49:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:49:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:49:37 INFO - Return code: 0 00:49: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')]} 00:49:37 INFO - https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:49:39 INFO - Downloaded 55896828 bytes. 00:49:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:39 INFO - mkdir: /builds/slave/test-pgo/properties 00:49:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:49:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:49:39 INFO - Contents: 00:49:39 INFO - build_url:https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:39 INFO - Running post-action listener: _resource_record_post_action 00:49:39 INFO - Running post-action listener: set_extra_try_arguments 00:49:39 INFO - ##### 00:49:39 INFO - ##### Running populate-webroot step. 00:49:39 INFO - ##### 00:49:39 INFO - Running pre-action listener: _resource_record_pre_action 00:49:39 INFO - Running main action method: populate_webroot 00:49:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:39 INFO - '--tppagecycles', 00:49:39 INFO - '7'], 00:49:39 INFO - 'tests': ['tsvgm']}}, 00:49:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:49:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'tests': ['damp', 'tps']}, 00:49:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['damp', 'tps']}, 00:49:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:49:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:39 INFO - 'other': {'tests': ['a11yr', 00:49:39 INFO - 'ts_paint', 00:49:39 INFO - 'tpaint', 00:49:39 INFO - 'sessionrestore', 00:49:39 INFO - 'sessionrestore_no_auto_restore']}, 00:49:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['a11yr', 00:49:39 INFO - 'ts_paint', 00:49:39 INFO - 'tpaint', 00:49:39 INFO - 'sessionrestore', 00:49:39 INFO - 'sessionrestore_no_auto_restore']}, 00:49:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['a11yr', 00:49:39 INFO - 'ts_paint', 00:49:39 INFO - 'tpaint', 00:49:39 INFO - 'sessionrestore', 00:49:39 INFO - 'sessionrestore_no_auto_restore']}, 00:49:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['a11yr', 00:49:39 INFO - 'ts_paint', 00:49:39 INFO - 'tpaint', 00:49:39 INFO - 'sessionrestore', 00:49:39 INFO - 'sessionrestore_no_auto_restore']}, 00:49:39 INFO - 'other_l64': {'tests': ['a11yr', 00:49:39 INFO - 'ts_paint', 00:49:39 INFO - 'tpaint', 00:49:39 INFO - 'sessionrestore', 00:49:39 INFO - 'sessionrestore_no_auto_restore']}, 00:49:39 INFO - 'other_nol64': {'tests': ['a11yr', 00:49:39 INFO - 'ts_paint', 00:49:39 INFO - 'tpaint', 00:49:39 INFO - 'sessionrestore', 00:49:39 INFO - 'sessionrestore_no_auto_restore']}, 00:49:39 INFO - 'svgr': {'tests': ['tsvgx', 00:49:39 INFO - 'tsvgr_opacity', 00:49:39 INFO - 'tart', 00:49:39 INFO - 'tscrollx', 00:49:39 INFO - 'cart']}, 00:49:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['tsvgx', 00:49:39 INFO - 'tsvgr_opacity', 00:49:39 INFO - 'tart', 00:49:39 INFO - 'tscrollx', 00:49:39 INFO - 'cart']}, 00:49:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'tests': ['tp5o']}, 00:49:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'talos_options': ['--e10s'], 00:49:39 INFO - 'tests': ['tp5o']}, 00:49:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'talos_options': ['--xperf_path', 00:49:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:39 INFO - 'tests': ['tp5n']}, 00:49:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:39 INFO - 'talos_options': ['--e10s', 00:49:39 INFO - '--xperf_path', 00:49:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:39 INFO - 'tests': ['tp5n']}}, 00:49:39 INFO - 'talos.zip': {'path': '', 00:49:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:39 INFO - Running post-action listener: _resource_record_post_action 00:49:39 INFO - ##### 00:49:39 INFO - ##### Running create-virtualenv step. 00:49:39 INFO - ##### 00:49:39 INFO - Running pre-action listener: _resource_record_pre_action 00:49:39 INFO - Running main action method: create_virtualenv 00:49:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:49:39 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 00:49:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:49:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:39 INFO - Using real prefix '/usr' 00:49:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:49:40 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:42 INFO - Installing pip.................done. 00:49:42 INFO - Return code: 0 00:49:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:49:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:49:42 INFO - Using env: {'DISPLAY': ':0', 00:49:42 INFO - 'HOME': '/home/cltbld', 00:49:42 INFO - 'LANG': 'en_US.UTF-8', 00:49:42 INFO - 'LANGUAGE': 'en_US:en', 00:49:42 INFO - 'LOGNAME': 'cltbld', 00:49:42 INFO - 'MAIL': '/var/mail/cltbld', 00:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:42 INFO - 'MOZ_NO_REMOTE': '1', 00:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:42 INFO - 'NO_EM_RESTART': '1', 00:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:42 INFO - 'SHELL': '/bin/bash', 00:49:42 INFO - 'SHLVL': '1', 00:49:42 INFO - 'TERM': 'linux', 00:49:42 INFO - 'TMOUT': '86400', 00:49:42 INFO - 'USER': 'cltbld', 00:49:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:42 INFO - '_': '/tools/buildbot/bin/python'} 00:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:42 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 00:49:42 INFO - Cleaning up... 00:49:42 INFO - Return code: 0 00:49:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:49:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:49:42 INFO - Using env: {'DISPLAY': ':0', 00:49:42 INFO - 'HOME': '/home/cltbld', 00:49:42 INFO - 'LANG': 'en_US.UTF-8', 00:49:42 INFO - 'LANGUAGE': 'en_US:en', 00:49:42 INFO - 'LOGNAME': 'cltbld', 00:49:42 INFO - 'MAIL': '/var/mail/cltbld', 00:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:42 INFO - 'MOZ_NO_REMOTE': '1', 00:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:42 INFO - 'NO_EM_RESTART': '1', 00:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:42 INFO - 'SHELL': '/bin/bash', 00:49:42 INFO - 'SHLVL': '1', 00:49:42 INFO - 'TERM': 'linux', 00:49:42 INFO - 'TMOUT': '86400', 00:49:42 INFO - 'USER': 'cltbld', 00:49:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:42 INFO - '_': '/tools/buildbot/bin/python'} 00:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:42 INFO - Downloading/unpacking psutil>=0.7.1 00:49:42 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 00:49:42 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 00:49:42 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 00:49:42 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 00:49:42 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 00:49:42 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 00:49:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:44 INFO - Installing collected packages: psutil 00:49:44 INFO - Running setup.py install for psutil 00:49:44 INFO - building 'psutil._psutil_linux' extension 00:49:44 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 00:49:44 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 00:49:44 INFO - building 'psutil._psutil_posix' extension 00:49:44 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 00:49:44 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 00:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:44 INFO - Successfully installed psutil 00:49:44 INFO - Cleaning up... 00:49:44 INFO - Return code: 0 00:49:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:49:44 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')]} 00:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:44 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')]} 00:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 00:49:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:49:44 INFO - Using env: {'DISPLAY': ':0', 00:49:44 INFO - 'HOME': '/home/cltbld', 00:49:44 INFO - 'LANG': 'en_US.UTF-8', 00:49:44 INFO - 'LANGUAGE': 'en_US:en', 00:49:44 INFO - 'LOGNAME': 'cltbld', 00:49:44 INFO - 'MAIL': '/var/mail/cltbld', 00:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:44 INFO - 'MOZ_NO_REMOTE': '1', 00:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:44 INFO - 'NO_EM_RESTART': '1', 00:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:44 INFO - 'SHELL': '/bin/bash', 00:49:44 INFO - 'SHLVL': '1', 00:49:44 INFO - 'TERM': 'linux', 00:49:44 INFO - 'TMOUT': '86400', 00:49:44 INFO - 'USER': 'cltbld', 00:49:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:44 INFO - '_': '/tools/buildbot/bin/python'} 00:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:49:45 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 00:49:45 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 00:49:45 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 00:49:45 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 00:49:45 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 00:49:45 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 00:49:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:49:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:49:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:49:46 INFO - Installing collected packages: mozsystemmonitor 00:49:46 INFO - Running setup.py install for mozsystemmonitor 00:49:46 INFO - Successfully installed mozsystemmonitor 00:49:46 INFO - Cleaning up... 00:49:47 INFO - Return code: 0 00:49:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:49:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:49:47 INFO - Using env: {'DISPLAY': ':0', 00:49:47 INFO - 'HOME': '/home/cltbld', 00:49:47 INFO - 'LANG': 'en_US.UTF-8', 00:49:47 INFO - 'LANGUAGE': 'en_US:en', 00:49:47 INFO - 'LOGNAME': 'cltbld', 00:49:47 INFO - 'MAIL': '/var/mail/cltbld', 00:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:47 INFO - 'MOZ_NO_REMOTE': '1', 00:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:47 INFO - 'NO_EM_RESTART': '1', 00:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:47 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:47 INFO - 'SHELL': '/bin/bash', 00:49:47 INFO - 'SHLVL': '1', 00:49:47 INFO - 'TERM': 'linux', 00:49:47 INFO - 'TMOUT': '86400', 00:49:47 INFO - 'USER': 'cltbld', 00:49:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:47 INFO - '_': '/tools/buildbot/bin/python'} 00:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:47 INFO - Downloading/unpacking blobuploader==1.2.4 00:49:47 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 00:49:47 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 00:49:47 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 00:49:47 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 00:49:47 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 00:49:47 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 00:49:48 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:49:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:49:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:49:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 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 00:49:49 INFO - Downloading docopt-0.6.1.tar.gz 00:49:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:49:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:49 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:49 INFO - Running setup.py install for blobuploader 00:49:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:49:49 INFO - Running setup.py install for requests 00:49:50 INFO - Running setup.py install for docopt 00:49:50 INFO - Successfully installed blobuploader requests docopt 00:49:50 INFO - Cleaning up... 00:49:50 INFO - Return code: 0 00:49:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:49:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:49:50 INFO - Using env: {'DISPLAY': ':0', 00:49:50 INFO - 'HOME': '/home/cltbld', 00:49:50 INFO - 'LANG': 'en_US.UTF-8', 00:49:50 INFO - 'LANGUAGE': 'en_US:en', 00:49:50 INFO - 'LOGNAME': 'cltbld', 00:49:50 INFO - 'MAIL': '/var/mail/cltbld', 00:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:50 INFO - 'MOZ_NO_REMOTE': '1', 00:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:50 INFO - 'NO_EM_RESTART': '1', 00:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:50 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:50 INFO - 'SHELL': '/bin/bash', 00:49:50 INFO - 'SHLVL': '1', 00:49:50 INFO - 'TERM': 'linux', 00:49:50 INFO - 'TMOUT': '86400', 00:49:50 INFO - 'USER': 'cltbld', 00:49:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:50 INFO - '_': '/tools/buildbot/bin/python'} 00:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:50 INFO - Running setup.py (path:/tmp/pip-eMjHab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:50 INFO - Running setup.py (path:/tmp/pip-_huvZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:50 INFO - Running setup.py (path:/tmp/pip-v32kOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:50 INFO - Running setup.py (path:/tmp/pip-0W82Ux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:50 INFO - Running setup.py (path:/tmp/pip-SNTQZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:50 INFO - Running setup.py (path:/tmp/pip-IO5UBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:50 INFO - Running setup.py (path:/tmp/pip-tobyfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:50 INFO - Running setup.py (path:/tmp/pip-hyYi01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:51 INFO - Running setup.py (path:/tmp/pip-11gfUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:51 INFO - Running setup.py (path:/tmp/pip-hXQeyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:51 INFO - Running setup.py (path:/tmp/pip-9ssyyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:51 INFO - Running setup.py (path:/tmp/pip-IBLE4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:51 INFO - Running setup.py (path:/tmp/pip-iYAqYM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:51 INFO - Running setup.py (path:/tmp/pip-KFr3Fr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:51 INFO - Running setup.py (path:/tmp/pip-bywqFG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:51 INFO - Running setup.py (path:/tmp/pip-_zCExl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:51 INFO - Running setup.py (path:/tmp/pip-f7NU8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:51 INFO - Running setup.py install for manifestparser 00:49:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:49:51 INFO - Running setup.py install for mozcrash 00:49:51 INFO - Running setup.py install for mozdebug 00:49:51 INFO - Running setup.py install for mozdevice 00:49:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Running setup.py install for mozfile 00:49:52 INFO - Running setup.py install for mozhttpd 00:49:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Running setup.py install for mozinfo 00:49:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Running setup.py install for mozInstall 00:49:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Running setup.py install for mozleak 00:49:52 INFO - Running setup.py install for mozlog 00:49:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Running setup.py install for moznetwork 00:49:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:49:52 INFO - Running setup.py install for mozprocess 00:49:52 INFO - Running setup.py install for mozprofile 00:49:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:49:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:49:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:49:53 INFO - Running setup.py install for mozrunner 00:49:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:49:53 INFO - Running setup.py install for mozscreenshot 00:49:53 INFO - Running setup.py install for moztest 00:49:53 INFO - Running setup.py install for mozversion 00:49:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:49:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:53 INFO - Cleaning up... 00:49:53 INFO - Return code: 0 00:49:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 00:49:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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 00:49:53 INFO - Using env: {'DISPLAY': ':0', 00:49:53 INFO - 'HOME': '/home/cltbld', 00:49:53 INFO - 'LANG': 'en_US.UTF-8', 00:49:53 INFO - 'LANGUAGE': 'en_US:en', 00:49:53 INFO - 'LOGNAME': 'cltbld', 00:49:53 INFO - 'MAIL': '/var/mail/cltbld', 00:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:53 INFO - 'MOZ_NO_REMOTE': '1', 00:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:53 INFO - 'NO_EM_RESTART': '1', 00:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:53 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:53 INFO - 'SHELL': '/bin/bash', 00:49:53 INFO - 'SHLVL': '1', 00:49:53 INFO - 'TERM': 'linux', 00:49:53 INFO - 'TMOUT': '86400', 00:49:53 INFO - 'USER': 'cltbld', 00:49:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:53 INFO - '_': '/tools/buildbot/bin/python'} 00:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:53 INFO - Running setup.py (path:/tmp/pip-_d_kqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:53 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)) 00:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:53 INFO - Running setup.py (path:/tmp/pip-FZmg1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:53 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)) 00:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:53 INFO - Running setup.py (path:/tmp/pip-nzV8cC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:53 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)) 00:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:53 INFO - Running setup.py (path:/tmp/pip-VP8pOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:54 INFO - Running setup.py (path:/tmp/pip-Kv7Lh0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:54 INFO - Running setup.py (path:/tmp/pip-DdkX0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:54 INFO - Running setup.py (path:/tmp/pip-z4WwLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:54 INFO - Running setup.py (path:/tmp/pip-iO8yj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:54 INFO - Running setup.py (path:/tmp/pip-Uos0YU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:54 INFO - Running setup.py (path:/tmp/pip-803XzT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:54 INFO - Running setup.py (path:/tmp/pip-tWO53F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:54 INFO - Running setup.py (path:/tmp/pip-fFEf__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:54 INFO - Running setup.py (path:/tmp/pip-bRre3R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:54 INFO - Running setup.py (path:/tmp/pip-a0OHtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:54 INFO - Running setup.py (path:/tmp/pip-tgCAJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:54 INFO - Running setup.py (path:/tmp/pip-fQKBmJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:54 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)) 00:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:54 INFO - Running setup.py (path:/tmp/pip-CBTQWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:54 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)) 00:49:54 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)) 00:49:54 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)) 00:49:54 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)) 00:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:49:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:54 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 00:49:54 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 00:49:54 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 00:49:54 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 00:49:54 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 00:49:54 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 00:49:56 INFO - Downloading blessings-1.5.1.tar.gz 00:49:56 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:49:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:56 INFO - Installing collected packages: blessings 00:49:56 INFO - Running setup.py install for blessings 00:49:56 INFO - Successfully installed blessings 00:49:56 INFO - Cleaning up... 00:49:56 INFO - Return code: 0 00:49:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:49:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:57 INFO - Reading from file tmpfile_stdout 00:49:57 INFO - Current package versions: 00:49:57 INFO - argparse == 1.2.1 00:49:57 INFO - blessings == 1.5.1 00:49:57 INFO - blobuploader == 1.2.4 00:49:57 INFO - docopt == 0.6.1 00:49:57 INFO - manifestparser == 1.1 00:49:57 INFO - mozInstall == 1.12 00:49:57 INFO - mozcrash == 0.16 00:49:57 INFO - mozdebug == 0.1 00:49:57 INFO - mozdevice == 0.47 00:49:57 INFO - mozfile == 1.2 00:49:57 INFO - mozhttpd == 0.7 00:49:57 INFO - mozinfo == 0.9 00:49:57 INFO - mozleak == 0.1 00:49:57 INFO - mozlog == 3.1 00:49:57 INFO - moznetwork == 0.27 00:49:57 INFO - mozprocess == 0.22 00:49:57 INFO - mozprofile == 0.28 00:49:57 INFO - mozrunner == 6.11 00:49:57 INFO - mozscreenshot == 0.1 00:49:57 INFO - mozsystemmonitor == 0.0 00:49:57 INFO - moztest == 0.7 00:49:57 INFO - mozversion == 1.4 00:49:57 INFO - psutil == 3.1.1 00:49:57 INFO - requests == 1.2.3 00:49:57 INFO - wsgiref == 0.1.2 00:49:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 00:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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 00:49:57 INFO - Using env: {'DISPLAY': ':0', 00:49:57 INFO - 'HOME': '/home/cltbld', 00:49:57 INFO - 'LANG': 'en_US.UTF-8', 00:49:57 INFO - 'LANGUAGE': 'en_US:en', 00:49:57 INFO - 'LOGNAME': 'cltbld', 00:49:57 INFO - 'MAIL': '/var/mail/cltbld', 00:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:57 INFO - 'MOZ_NO_REMOTE': '1', 00:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:57 INFO - 'NO_EM_RESTART': '1', 00:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:57 INFO - 'SHELL': '/bin/bash', 00:49:57 INFO - 'SHLVL': '1', 00:49:57 INFO - 'TERM': 'linux', 00:49:57 INFO - 'TMOUT': '86400', 00:49:57 INFO - 'USER': 'cltbld', 00:49:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:57 INFO - '_': '/tools/buildbot/bin/python'} 00:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 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)) 00:49:57 INFO - Cleaning up... 00:49:57 INFO - Return code: 0 00:49:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 00:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:49:57 INFO - Using env: {'DISPLAY': ':0', 00:49:57 INFO - 'HOME': '/home/cltbld', 00:49:57 INFO - 'LANG': 'en_US.UTF-8', 00:49:57 INFO - 'LANGUAGE': 'en_US:en', 00:49:57 INFO - 'LOGNAME': 'cltbld', 00:49:57 INFO - 'MAIL': '/var/mail/cltbld', 00:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:57 INFO - 'MOZ_NO_REMOTE': '1', 00:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:57 INFO - 'NO_EM_RESTART': '1', 00:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:57 INFO - 'SHELL': '/bin/bash', 00:49:57 INFO - 'SHLVL': '1', 00:49:57 INFO - 'TERM': 'linux', 00:49:57 INFO - 'TMOUT': '86400', 00:49:57 INFO - 'USER': 'cltbld', 00:49:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:57 INFO - '_': '/tools/buildbot/bin/python'} 00:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:57 INFO - Downloading/unpacking jsonschema 00:49:57 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 00:49:57 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 00:49:57 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 00:49:57 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 00:49:57 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 00:49:57 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 00:49:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:49:59 INFO - Downloading/unpacking functools32 (from jsonschema) 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:59 INFO - Downloading functools32-3.2.3-2.tar.gz 00:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:49:59 INFO - warning: no files found matching '*.txt' 00:49:59 INFO - no previously-included directories found matching 'build' 00:49:59 INFO - no previously-included directories found matching 'dist' 00:49:59 INFO - no previously-included directories found matching '.git*' 00:49:59 INFO - Installing collected packages: jsonschema, functools32 00:49:59 INFO - Running setup.py install for functools32 00:49:59 INFO - warning: no files found matching '*.txt' 00:49:59 INFO - no previously-included directories found matching 'build' 00:49:59 INFO - no previously-included directories found matching 'dist' 00:49:59 INFO - no previously-included directories found matching '.git*' 00:49:59 INFO - Successfully installed jsonschema functools32 00:49:59 INFO - Cleaning up... 00:49:59 INFO - Return code: 0 00:49:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26143cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', '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 00:49:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 00:49:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:49:59 INFO - Using env: {'DISPLAY': ':0', 00:49:59 INFO - 'HOME': '/home/cltbld', 00:49:59 INFO - 'LANG': 'en_US.UTF-8', 00:49:59 INFO - 'LANGUAGE': 'en_US:en', 00:49:59 INFO - 'LOGNAME': 'cltbld', 00:49:59 INFO - 'MAIL': '/var/mail/cltbld', 00:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:59 INFO - 'MOZ_NO_REMOTE': '1', 00:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:59 INFO - 'NO_EM_RESTART': '1', 00:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:59 INFO - 'SHELL': '/bin/bash', 00:49:59 INFO - 'SHLVL': '1', 00:49:59 INFO - 'TERM': 'linux', 00:49:59 INFO - 'TMOUT': '86400', 00:49:59 INFO - 'USER': 'cltbld', 00:49:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:59 INFO - '_': '/tools/buildbot/bin/python'} 00:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:59 INFO - Downloading/unpacking flake8 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 00:50:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 00:50:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 00:50:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:50:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:50:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:50:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:50:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:50:02 INFO - no previously-included directories found matching 'docs/_build' 00:50:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:50:02 INFO - Running setup.py install for pep8 00:50:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:50:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:50:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:50:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:50:02 INFO - no previously-included directories found matching 'docs/_build' 00:50:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:50:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:50:02 INFO - Cleaning up... 00:50:02 INFO - Return code: 0 00:50:02 INFO - Running post-action listener: _resource_record_post_action 00:50:02 INFO - Running post-action listener: _start_resource_monitoring 00:50:02 INFO - Starting resource monitoring. 00:50:02 INFO - ##### 00:50:02 INFO - ##### Running install step. 00:50:02 INFO - ##### 00:50:02 INFO - Running pre-action listener: _resource_record_pre_action 00:50:02 INFO - Running main action method: install 00:50:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:50:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:50:02 INFO - Reading from file tmpfile_stdout 00:50:02 INFO - Detecting whether we're running mozinstall >=1.0... 00:50:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:50:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:50:02 INFO - Reading from file tmpfile_stdout 00:50:02 INFO - Output received: 00:50:02 INFO - Usage: mozinstall [options] installer 00:50:02 INFO - Options: 00:50:02 INFO - -h, --help show this help message and exit 00:50:02 INFO - -d DEST, --destination=DEST 00:50:02 INFO - Directory to install application into. [default: 00:50:02 INFO - "/builds/slave/test-pgo"] 00:50:02 INFO - --app=APP Application being installed. [default: firefox] 00:50:02 INFO - mkdir: /builds/slave/test-pgo/build/application 00:50:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:50:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:50:18 INFO - Reading from file tmpfile_stdout 00:50:18 INFO - Output received: 00:50:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:50:18 INFO - Running post-action listener: _resource_record_post_action 00:50:18 INFO - ##### 00:50:18 INFO - ##### Running run-tests step. 00:50:18 INFO - ##### 00:50:18 INFO - Running pre-action listener: _resource_record_pre_action 00:50:18 INFO - Running main action method: run_tests 00:50:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:50:18 INFO - Python 2.7.3 00:50:18 INFO - Return code: 0 00:50:18 INFO - grabbing minidump binary from tooltool 00:50:18 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')]} 00:50:18 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 0xf28660>, '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 0xf29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf29a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:50:18 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 00:50:18 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 00:50:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:50:18 INFO - Return code: 0 00:50:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:50:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:50:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:50:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:50:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:50:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:50:19 INFO - Return code: 0 00:50:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 00:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 00:50:19 INFO - Using env: {'DISPLAY': ':0', 00:50:19 INFO - 'HOME': '/home/cltbld', 00:50:19 INFO - 'LANG': 'en_US.UTF-8', 00:50:19 INFO - 'LANGUAGE': 'en_US:en', 00:50:19 INFO - 'LOGNAME': 'cltbld', 00:50:19 INFO - 'MAIL': '/var/mail/cltbld', 00:50:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:50:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:19 INFO - 'MOZ_NO_REMOTE': '1', 00:50:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:19 INFO - 'NO_EM_RESTART': '1', 00:50:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:50:19 INFO - 'PWD': '/builds/slave/test-pgo', 00:50:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:50:19 INFO - 'SHELL': '/bin/bash', 00:50:19 INFO - 'SHLVL': '1', 00:50:19 INFO - 'TERM': 'linux', 00:50:19 INFO - 'TMOUT': '86400', 00:50:19 INFO - 'USER': 'cltbld', 00:50:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191', 00:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:19 INFO - '_': '/tools/buildbot/bin/python'} 00:50:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 00:50:20 INFO - mozversion application_buildid: 20160107223016 00:50:20 INFO - mozversion application_changeset: 512d9c5b57888d40416f091b4ceda78496005499 00:50:20 INFO - mozversion application_display_name: Nightly 00:50:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:50:20 INFO - mozversion application_name: Firefox 00:50:20 INFO - mozversion application_remotingname: firefox 00:50:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:50:20 INFO - mozversion application_vendor: Mozilla 00:50:20 INFO - mozversion application_version: 46.0a1 00:50:20 INFO - mozversion platform_buildid: 20160107223016 00:50:20 INFO - mozversion platform_changeset: 512d9c5b57888d40416f091b4ceda78496005499 00:50:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:50:20 INFO - mozversion platform_version: 46.0a1 00:50:20 INFO - using testdate: 1452243020 00:50:20 INFO - actual date: 1452243020 00:50:20 INFO - starting webserver on 'localhost:43731' 00:50:20 INFO - SUITE-START | Running 3 tests 00:50:20 INFO - TEST-START | dromaeo_css 00:50:20 INFO - operating with platform_type : linux_ 00:50:20 INFO - Initialising browser for dromaeo_css test... 00:50:20 INFO - TEST-INFO | started process 15634 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAMJWbD/profile http://localhost:43731/getInfo.html) 00:50:24 INFO - PROCESS | 15634 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 00:50:24 INFO - PROCESS | 15634 | __metrics Screen width/height:1600/1200 00:50:24 INFO - PROCESS | 15634 | colorDepth:24 00:50:24 INFO - PROCESS | 15634 | Browser inner width/height: 1024/697 00:50:24 INFO - PROCESS | 15634 | __metrics 00:50:25 INFO - PROCESS | 15634 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:50:25 INFO - TEST-INFO | 15634: exit 0 00:50:25 INFO - Browser initialized. 00:50:25 INFO - Running cycle 1/1 for dromaeo_css test... 00:50:25 INFO - TEST-INFO | started process 15766 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAMJWbD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:50:37 INFO - PROCESS | 15766 | RSS: Main: 150282240 00:50:37 INFO - PROCESS | 15766 | 00:51:27 INFO - PROCESS | 15766 | 1452243087257 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] 00:53:35 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:43731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43731/tests/dromaeo/cssquery-ext.html) 00:53:36 INFO - PROCESS | 15766 | RSS: Main: 157839360 00:53:36 INFO - PROCESS | 15766 | 00:56:38 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:43731/tests/dromaeo/cssquery-ext.html (next: http://localhost:43731/tests/dromaeo/cssquery-jquery.html) 00:56:39 INFO - PROCESS | 15766 | RSS: Main: 153554944 00:56:39 INFO - PROCESS | 15766 | 00:59:41 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:43731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43731/tests/dromaeo/cssquery-mootools.html) 00:59:41 INFO - PROCESS | 15766 | RSS: Main: 153055232 00:59:41 INFO - PROCESS | 15766 | 01:02:43 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:43731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43731/tests/dromaeo/cssquery-prototype.html) 01:02:44 INFO - PROCESS | 15766 | RSS: Main: 152784896 01:02:44 INFO - PROCESS | 15766 | 01:05:46 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:43731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43731/tests/dromaeo/cssquery-yui.html) 01:05:47 INFO - PROCESS | 15766 | RSS: Main: 151834624 01:05:47 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:43731/tests/dromaeo/cssquery-yui.html (next: http://localhost:43731/tests/dromaeo/cssquery-dojo.html) 01:08:49 INFO - PROCESS | 15766 | RSS: Main: 155877376 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | __start_tp_report 01:08:49 INFO - PROCESS | 15766 | _x_x_mozilla_page_load 01:08:49 INFO - PROCESS | 15766 | _x_x_mozilla_page_load_details 01:08:49 INFO - PROCESS | 15766 | |i|pagename|runs| 01:08:49 INFO - PROCESS | 15766 | |0;dojo.html;3118.2827949571597;3144.1039303798407;3153.101366110659;3182.3219866795807;3186.2830863055815;5120.078385890548;5189.896202075961;5207.947920520794;5221.765020574074;5289.259503669489;5241.371035475749;5266.34170728658;5267.47325267473;5284.497972692588;5297.284866543016;4803.159447096753;4818.831340903069;4873.951260487385;4950.678205916622;4952.479989601094;4865.781039853215;4885.828995985141;4890.951090489103;4903.509649035086;4955.752212389366;4539.364488971513;4580.3358513015755;4904.190808516591;4904.239842824368;4909.680870743408;4847.175980083359;4864.075825593126;4867.050925069578;4875.07373599015;4901.705897646153;4824.662273640846;4846.927296090526;4863.781129849165;4875.804967801284;4907.4356449008465;5089.949100508985;5110.97444512775;5166.07010738067;5177.689338639693;5220.738963051832;5729.885402291972;5778.624389414675;5801.506871915893;5802.21670074543;5807.448292412214;5701.14482827575;5821.825345239649;5842.503387212049;5842.591018628697;5849.970750146222;5186.818461353834;5317.787288508455;5374.059539580597;5384.542313903284;5417.322834645669;5836.007878660638;5836.503897168788;5839.474447299678;5852.590318677651;5858.589898707135;5531.308586426697;5613.045782217033;5619.072852979294;5622.606417550814;5625.521830644359;5679.943200568024;5744.195812586241;5756.971215143897;5760.481556659837;5792.739326730307;5592.245046918695;5616.129499927518;5633.295838020247;5633.324001119892;5641.717914104278;5483.75323110461;5562.554995600423;5609.915851262234;5625.578081643893;5678.261825962599;4487.910241795211;4492.730436173774;4493.59557639814;4510.436195475566;4512;3990.700697447703;4013.3979903014197;4027.5771044039952;4039.7374170678813;4062.51249850014;5242.7116508591635;5300.681959082467;5312.867178320495;5462.235287059815;5464.480874316933;5764.884702305931;5774.39368866263;5777.711114444261;5789.623674461147;5794.942050579441;5408.5402740766685;5412.485813847678;5416.539594134464;5425.484578964992;5427.810026649048;4720.811167553328;4817.7350245736825;4819.7108173509705;4864.878378040577;4908.9263661045115;5920.911186332209;5928.466438020599;5954.285485741652;5971.850703732442;5973.432523910222;5555.833325000256;5719.399463056319;5729.341125770589;5731.684757338219;5746.051901436216;5810.360860305447;5815.621984570989;5871.119332100219;5899.321578018411;5948.910766338422;5625.831225063254;5634.380218175916;5656.1798539212405;5657.2079908811975;5658.038133517394;5616.7191640416995;5664.716764161858;5735.082386818256;5755.223044889054;5762.337331206965;5497.230387745639;5567.749451274622;5579.581531385081;5585.636933599303;5640.915386269291;5577.247071645276;5578.721063946705;5587.07813210832;5587.44125587438;5591.832245032656;5417.566594672496;5534.418886017072;5541.9168712470155;5542.057850165401;5584.441555844545;5393.43368946255;5540.113581826889;5540.778368865362;5576.972115139399;5583.35791383996;5422.05114105038;5428.782848686008;5445.428230035789;5456.181572763959;5460.535854452257 01:08:49 INFO - PROCESS | 15766 | |1;ext.html;521.5983692556731;528.6484487815601;551.6359202926068;557.389658324135;560.5319558168932;34496.82751586242;35777.284454310895;35810.10474738133;35822.82088589557;35823.52205974253;36342.273154536895;36541.45187822185;36583.4512482313;37031.629683703155;37064.629353706456;8198.549079800609;8413.957930210341;8431.367647426438;8439.282660973824;8446.282066024396;8123.918760812405;8337.916620833774;8431.578421078952;8453.02790179128;8485.830283394329;8386.161383861627;8519.53142577158;8549.102344253826;8565.871511927326;8567.400281980264;8302.086770455246;8451.661933522682;8470.703525376583;8485.575721213976;8500.532470714108;8252.793680157984;8368.58157092143;8400;8401.327893768485;8404.8319033619;35751.642483575095;36328.27343453116;36333;36371.272574548624;36380.63619363825;3153.7634677399055;3247.1882029492626;3328.367610154063;3336.2660214752714;3552.236269202134;29175.562366564518;29541.556876646653;29787.25531861699;29912.8504357479;30432.69567304343;3182.867478789217;3194.8881789137267;3225.048610659861;3261.4944683574086;3288.128645908836;265586;266896.6655166731;266938;267569;268685;41754.58245417507;47834.521654783704;47918;48083.519164808604;48165.27752083722;34911;34950.650493495246;35086.12284692903;35125.12187195341;35128;12742.10805243624;12884.935575322063;12889.742205155844;12912;12937.870621293667;9610.855837162448;9628.422294662343;9639.855402168972;9653.276004299705;9730.464824434725;13763.655908602364;13821.79267310991;14181.361838717283;14198.787018194735;14300.570982870531;5614.129809879475;5716.42835716425;5726.685032323262;5797.449242321973;5808.941910580925;831.2477208126655;901.8016036471965;927.4945154890601;974.9122578967927;1092.4919912240687;28012.29969250785;28036.85981570079;28061.579076313872;28198.577021344696;28308.85845570759;954.1698722111807;993.3940296419179;1104.0615476844619;1105.7622611138484;1149.4712432281078;14560.126392416489;14626.195559244345;14636.341364638616;14798.778018329735;14993.550193494213;328817;330646;330868;333935;334739;50159.49840501621;50975.235371469455;51032.48967510352;51377.229341559905;51499.82002159765;1139.6922830835795;1329.9867001330056;1333.69991751857;1336.8529461759392;1346.0846624295377;26918;27714;27714.584281235395;27968.580471293353;28270.15189544317;45120.54879451163;45294.77352613216;45413.545864542255;45447;45512.54487455083;291503;295620;296202;297815;299512;31985.36029279355;42855;43334.133317334105;43749;43950.78024609984;37742.24515509729;38957.22085558216;39167;39250.21499569935;39555.40666890056;32865.34269314648;33670.32659346848;36208.27583448369;36793.26413471769;36834.447483288306;36442;36491.270174595826;36576.26847463089;36599.72522430917;36760.44859327059;35525;36014;37901.431478527295;39164.412533811446;39265.80367098146;28797.856010719814;30358.241043973194;30943.535846961862;31172.53241201429;31209.219769505944;23836.16573419922;23865;24020.279391618278;24191.758082419656;25022.249332520052 01:08:49 INFO - PROCESS | 15766 | |2;jquery.html;347.9652034796521;349.51068504094246;350.8859620623297;351.63254399152885;353.588069898568;15786.84213157868;15950.920245398771;16602.25289861956;16664.91667541662;17321.7401738974;10654.987776161272;10684.19868509861;10700.571977120906;12278.447469863855;15288.31202595883;4864.635152363587;4875.926861097078;4990.500949904998;5014.398272207341;5054.039732450841;4881.585065269456;5000;5001.1248031594505;5026.2209357549455;5028.2709007193935;5001.049800537904;5066.341375621182;5067.949320506803;5238.92141617876;5287.312649355578;5125.2312153176945;5153.922691159635;5154.175331946889;5169.819056333029;5463.590230732671;5203.323567936182;5206.76569554371;5238;5265.921011184797;5275.182346736262;17364.91317543417;17712.202950867242;18375.264989400406;18436;18471.16879740415;1960.14733590887;1981.7423734914512;2042.6221149087467;2047.948801279965;2121.321177223289;12441.440135193847;12580.11939164259;12631.368431578476;12760.170588911784;12894.419751111223;1782.5008997480727;1793.3902473159058;1873.7564116664882;1887.7545919030438;1892.2593000525887;52916.735416323056;54379.45620543823;54840.177397339074;54927.450725492636;55361.16958245629;9330.58012389444;9349.859752103725;9359.578818953163;9372.95313523428;9391.483468409304;11842.703932401759;11854.822177667342;11898;11907.821382679267;11942.641720748392;6818.727250910008;6845.760398386033;6891.104156459728;6904.378605925491;6960.199577048603;6555.311692272338;6613.371729685672;6622.569532980341;6636.336366363422;6645.269020407752;3939.054626889526;3948.506436695413;3965.3457179565626;3970.6029397060065;3978.840846366113;1565.4599163288647;1646.4648989078598;1656.6521030583713;1699.9745003824705;1721.888077274973;878.9868151977726;882.7793051737066;943.2736792669606;986.6842610364758;1007.7027276953316;14829.703405931821;14845.777313340308;15517.456889009056;15635.218239088;15656.13891235993;889.958748264532;915.514777168102;929.2194556572376;955.5270141279972;975.5951280218629;8588.742337729878;8893.4663920165;8925.509096999598;9045.231155351737;9266.11971862672;503841;515326;517006;519684;521907;66119.66940165365;67072.3292767066;68900.65549672219;69415;69999;1128.1200663482496;1129.9265547739371;1149.166854030821;1151.5221183209042;1155.820847768597;13784.379702913193;13847.238401887993;14802.185879776285;14965.77551336709;14974.101553906801;24953.500929980935;29154.27114322074;29227.41545169127;30131;30389.696103039572;36591.45112823363;38097;38111.61888381081;38654.6134538651;40466;7132;7230.74692385764;7244.746433875;7321.450891183076;7381.26187381279;10286.2799604027;10760.46197690128;11272.887271127513;11331.830022549504;11468.885311147116;3003;3869.916423401452;9138.543072846463;9579.233661307218;9775.657851975147;9453.858192126985;9904.306698531034;10006.499675016075;10065.144462720458;10219.080282774587;9400;9891.851622225817;9974;10044.849327260243;10062.49687515636;7270.9636451819515;7489.138749043712;7527.397808175442;7637.121731000784;7700.922990770021;9587.376820506644;9758.46328451942;9916.652917147865;9942;10088.798224035625 01:08:49 INFO - PROCESS | 15766 | |3;mootools.html;1353.3639189580897;1443.1629654800213;1546.5205786206277;1734.7051001329773;1743.4333841501516;7441.40468762499;7602.923970760291;7610.771676849697;7612.5432474051595;7823.647935842887;7570.12943511495;7663.965364675767;7755.108162561307;7768.766936991885;7775;2327.3134425344565;2338.3101984914406;2359.3865594945264;2364.9054037838464;2367.1241640593003;2198.1537108213374;2220.755716871143;2221.133757834446;2231.475603233239;2248.4603695113137;2193.7148170737782;2200.8569442986236;2217.246136313653;2265.660150977358;2271.4889149941214;2197.7802219777973;2208.768079351661;2231.319447568491;2235.2958817972367;2237.5077482953807;2225.354647152324;2233.530958498701;2251.6284813005836;2257.2551058150934;2258.006477150049;7534.472586918863;7537.057867766529;7552.735654252075;7568.826831841074;7580.355669768076;4664;4779.498152693952;4790.880227994293;4791.496892826272;4798.808047678089;3088.7992280501694;3105.099521138867;3138.2311333723155;3151.6060492438446;3184.5541624172633;1001.4542074569378;1025.3489034463096;1031.2935639087175;1048.3395460859685;1092.322759888874;10686.038256556869;10708.464576771208;10756.946215268952;10768.300060496043;10789.622363217328;4162.167566486714;4212.936805947913;4232.32282834745;4239.046214601752;4283.657307415399;8752.606132724042;8762.561871906379;8784.429012114193;8804.603792829337;8820.206181443573;4671.929921051187;4686.336350595558;4700.670953033323;4728.05438912219;4736.8578942631775;4315.5900189481945;4333.523312435629;4334.414853994734;4360.629346505582;4361.6510679145595;3521.3133438979153;3522.5949015863503;3525.858965641397;3545.4150065239464;3552.644735526478;1093.3221402730358;1105.657246253664;1113.1261959361861;1115.4311301236266;1117.3742704085737;897.4435849773051;898.883145191121;899.8110396816611;970.335320305593;1021.8058568871891;7117.395021423134;7257.237990010973;7270.418366530665;7287.417006639456;7302.415806735448;1096.6107032003683;1181.704573856536;1216.9634910952686;1222.883826036525;1243.3907385381278;5629.380768115504;5721.313442386857;5729.598928075078;5738.368779434259;5760.855978600569;8836.469811811312;8849.380543362031;9059.864102038475;9076.273898088137;9093.408928419763;8999.19007289347;9005.414648047856;9021.774455638662;9027.774305642411;9034.277257819358;6805.3875151236625;6945.583265004116;6967.268436814163;7031.507794454441;7045.295470452914;7168.856622867618;7249.710011599688;7250.166230883516;7268.636568171464;7273.7634602116705;8061.596920154087;8211.58942052883;8299.917000829915;8370.87443688333;8475.194856488624;8391.496510209407;8610.913890861011;8622.137786221328;8627.6980305689;8671.566421678765;6670.799876003728;6807.421369183675;6935.410490108397;6942.097527321416;6943.132108486439;7301.488895777245;7325.560466372035;7334.559926404433;7360.66876990526;7372.078490188726;6595.241547221939;6668.433183179484;6839;6842;7115.6086415247655;6743.763968261087;6803.7618683345845;6810.727570897108;6843.931560684528;6925.342092501204;6749.797506074629;6798.7620433286575;6838.794836154923;6843.794686159423;6857.142857142857;6326.525510586816;6334.764720879384;6341.0805433212845;6358.109864618865;6391.10524526576;6355.713992870239;6429.678516074271;6441.484681225397;6462.063000864942;6477.287498375269 01:08:49 INFO - PROCESS | 15766 | |4;prototype.html;307.3836956901412;314.9307152426466;323.54864963376076;324.6300611419808;327.0466589890469;6106.664133472657;6308.022256550236;6335.809925702225;6365.968170159149;6477.222733272014;6268.780592679257;6275.968620156893;6299.275583307921;6330.556861019731;6362.9045564316575;4575.428071491064;4680.134175177603;4709.576138147566;4710.175719249118;4719.292106184074;4700.576948074672;4703.882402939919;4713.43438787346;4720.315554244632;4727.527247275262;4643.442786865581;4653.720776753389;4656.371389862376;4659.4175728034;4677.251639737643;4671.972166123447;4684.1334353144775;4684.953150468486;4687.789049492747;4706.458757242893;3844.653981141683;3959.8020098994934;4058.269511487931;4061.939070913939;4062.8984275393054;5818.243628328332;5820.825375238707;5825.83483303341;5831.183634291203;5868.530517558585;5336.733163341817;5347.46525347466;5350.464953504657;5357.919631205535;5381.273528073699;6567.54027218095;6586.506012049115;6594.769183078617;6600.306967768363;6627.403533681992;4252.744835309892;4336.913261734748;4370.584794444522;4372.825086996516;4373.212821692094;6898.0687607172895;6926.965365173141;6962.060121883532;6981.476389270774;6987.266337034589;4533.886652833639;4545.045540436479;4562.406887104655;4562.908741825145;4573.268277075652;4443.777811109496;4592.081583683277;4616.192166370872;4621.399218101693;4623.237165867661;5363.812266570651;5405.972970135124;5414.702191379433;5434;5442.938626967703;6635.568688035262;6697.3637504437;6717.563358381787;6718.7312507499155;6738.427233685192;1602.3830825132175;1603.1903888536447;1604.751263554151;1606.9517914462351;1607.9678406431806;1054.7152268887357;1064.2443864856039;1070.9089727373262;1075.1076606416655;1094.1465656787718;6104.8779024420155;6244;6350.396712312323;6353.459955903708;6356.396142366468;6744.5616034957575;6926.272741362185;6987.406070483964;7007.544509606859;7008.859822803515;6373.74505019794;6376.29860715321;6383.680815959184;6399.072134540465;6413.16628838248;3633.109888077438;3738;3741.607131251234;3756.0422092366816;3771.41543060826;7243.0946131733535;7262.5642461451425;7301.671424785897;7302.780916572511;7311.89032164518;7068.3991860691385;7109.395701365442;7111.573305601681;7116.110486189226;7137.964310178416;7170.139583250043;7244.203137654854;7298.087739032621;7315.926840731525;7318.451116166309;6906.8618627626165;6932.0988271524375;6943.9652801735665;6944.548604340702;6961.825954350979;6792.490563207681;6798.456123510206;6855.5543889647015;6869.896951545831;6876.312368763083;7059.717611295696;7277.235890231661;7329.1937886833475;7336.486445948945;7358.484906056525;4565.269556870885;4610.170169369546;4613.400257966443;4616.722996620214;4619.053094115766;6861.897071544031;6946.305369463013;6998.370146686822;6999.30006999296;6999.475039371966;6507.251666058274;6695.899561506679;6697;6708.127943367331;6774.3225677431865;6753.054572359775;6758.932410676027;6774.288699686659;6784.457243420613;6799.5920244785475;6569.507286953402;6646;6657.7669781557415;6669.199696036507;6671.66641667905;6589.341065893564;6707;6752.257251702407;6767;6825.215100263533;6572.80281591553;6581.440577550962;6600.80197594073;6634.336566343327;6634.933650663432 01:08:49 INFO - PROCESS | 15766 | |5;yui.html;617.8239201827479;628.1896353703721;680.4114441008529;680.826389270736;683.7061658136951;12774.68063298418;12840.229586224834;12842.678933026667;12966.740665186691;13059.412326445321;12288.692782680437;12324.876751232485;12368.505259789597;12374.566890158847;12408;569.223010590544;765.6784150656738;793.6468271619132;796.8366484870587;798.2695833312512;797.7287722174459;798.1180795221284;798.656577671601;802.6388125343618;804.3725893802814;832.0348395860802;832.4089896173693;837.4682076881194;839.9874001889976;844.2612713875359;827.9420440569163;828.200786241277;830.622066959538;836.9874451883196;837.409626213518;614.5452365249683;615.6798464798325;617.290116366178;620.0729908786349;620.8261686727724;12235.877641223562;12361.69095772604;12399.628011159679;12416.689582760413;12450.3152326622;12000.819987700192;12142.150049496538;12346.876531234662;12518.937405312916;12773.48906043757;8893.555322233862;8973.910260897374;8978.191962723386;9013.783139276245;9048.230900373475;3428.451447768345;3501.4047611906035;3507.982460087683;3508.17557873902;3516.6659167379057;44197.06253289484;44670.10659786786;44930.326045109025;45448.54551454509;45934.54065459336;9539.379940303998;9634.470104144339;9646.614135434644;9871.605135794487;9882.654107106217;17185.91407042982;17286.049267290167;17315.740263896052;17327.393541225996;17416.39042633527;6951.756688515979;7018.894716579255;7027.7188912442925;7127.10911136108;7306.204056460213;4081;4086.1010577672864;4088.897777555585;4120.196561670506;4126.504819421689;3036.089173248017;3042.863071161759;3047.6647568767416;3057.7400920921527;3061.1581815001055;572.3560993881883;573.5039191099669;580.8867270882138;581.9563532735061;594.4412252482653;518.5125981577305;522.5558275465823;538.8410418926426;572.7279542217414;582.1587805620921;7556.1310449297935;8662.810106777873;8796.384253102222;8933.330000250007;9191.886192866223;506.6504062622355;572.3103660089582;591.3288417646003;597.486161900765;601.6811090122242;3655.1958569114754;3674.147714512415;3695.4087346024507;3706.3328600851564;3827.158025234444;55841.44158558363;56182.15726764102;56340.43659563352;56620;56631;48096;49521.50478495169;50070.499295006586;50398;50521.242181367306;43529.69410917677;44396;47262.29106563405;47303.526964729914;47503;7281.963590182015;7342.375898048512;7430.331270185709;7434.479586428898;7452.478326517092;33416.33167336688;33523.497147542315;33795;33862.32275354528;34212.48681269733;38828;41056.58943410647;43300.917477063325;43929.78035109932;44946;9391.631013252396;9436.85844712316;9448.244140468883;9496.572654230715;9620.75948101303;10057.849132262876;10064.496775161359;10097.949510252402;10176.440295783803;10300.484975751033;8920.24177944882;9031;9115.134062264075;9370.531473426165;9485.620575176916;9164;9307.20888724466;9499.667511637335;9532.618695252113;9566.378185417925;8885.200331970154;8888.73333799987;9036.909630903607;9387.342885997914;9582.712518624452;8062.435629505878;8333.624986875726;8458.873116903374;8503.13636182026;8623.913760862562;8239.670413183405;8401.15988401155;8483.194096560817;8491.617877195664;8553.657853686032 01:08:49 INFO - PROCESS | 15766 | __end_tp_report 01:08:49 INFO - PROCESS | 15766 | __start_cc_report 01:08:49 INFO - PROCESS | 15766 | _x_x_mozilla_cycle_collect,317 01:08:49 INFO - PROCESS | 15766 | __end_cc_report 01:08:49 INFO - PROCESS | 15766 | __startTimestamp1452244129763__endTimestamp 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | ------- Summary: start ------- 01:08:49 INFO - PROCESS | 15766 | Number of tests: 6 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | [#0] dojo.html Cycles:165 Average:5298.14 Median:5483.75 stddev:584.04 (10.7%) stddev-sans-first:560.24 01:08:49 INFO - PROCESS | 15766 | Values: 3118.3 3144.1 3153.1 3182.3 3186.3 5120.1 5189.9 5207.9 5221.8 5289.3 5241.4 5266.3 5267.5 5284.5 5297.3 4803.2 4818.8 4874.0 4950.7 4952.5 4865.8 4885.8 4891.0 4903.5 4955.8 4539.4 4580.3 4904.2 4904.2 4909.7 4847.2 4864.1 4867.1 4875.1 4901.7 4824.7 4846.9 4863.8 4875.8 4907.4 5089.9 5111.0 5166.1 5177.7 5220.7 5729.9 5778.6 5801.5 5802.2 5807.4 5701.1 5821.8 5842.5 5842.6 5850.0 5186.8 5317.8 5374.1 5384.5 5417.3 5836.0 5836.5 5839.5 5852.6 5858.6 5531.3 5613.0 5619.1 5622.6 5625.5 5679.9 5744.2 5757.0 5760.5 5792.7 5592.2 5616.1 5633.3 5633.3 5641.7 5483.8 5562.6 5609.9 5625.6 5678.3 4487.9 4492.7 4493.6 4510.4 4512.0 3990.7 4013.4 4027.6 4039.7 4062.5 5242.7 5300.7 5312.9 5462.2 5464.5 5764.9 5774.4 5777.7 5789.6 5794.9 5408.5 5412.5 5416.5 5425.5 5427.8 4720.8 4817.7 4819.7 4864.9 4908.9 5920.9 5928.5 5954.3 5971.9 5973.4 5555.8 5719.4 5729.3 5731.7 5746.1 5810.4 5815.6 5871.1 5899.3 5948.9 5625.8 5634.4 5656.2 5657.2 5658.0 5616.7 5664.7 5735.1 5755.2 5762.3 5497.2 5567.7 5579.6 5585.6 5640.9 5577.2 5578.7 5587.1 5587.4 5591.8 5417.6 5534.4 5541.9 5542.1 5584.4 5393.4 5540.1 5540.8 5577.0 5583.4 5422.1 5428.8 5445.4 5456.2 5460.5 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | [#1] ext.html Cycles:180 Average:45029.34 Median:36268.27 stddev:78471.34 (216.4%) stddev-sans-first:78620.31 01:08:49 INFO - PROCESS | 15766 | Values: 521.6 528.6 551.6 557.4 560.5 34496.8 35777.3 35810.1 35822.8 35823.5 36342.3 36541.5 36583.5 37031.6 37064.6 8198.5 8414.0 8431.4 8439.3 8446.3 8123.9 8337.9 8431.6 8453.0 8485.8 8386.2 8519.5 8549.1 8565.9 8567.4 8302.1 8451.7 8470.7 8485.6 8500.5 8252.8 8368.6 8400.0 8401.3 8404.8 35751.6 36328.3 36333.0 36371.3 36380.6 3153.8 3247.2 3328.4 3336.3 3552.2 29175.6 29541.6 29787.3 29912.9 30432.7 3182.9 3194.9 3225.0 3261.5 3288.1 265586.0 266896.7 266938.0 267569.0 268685.0 41754.6 47834.5 47918.0 48083.5 48165.3 34911.0 34950.7 35086.1 35125.1 35128.0 12742.1 12884.9 12889.7 12912.0 12937.9 9610.9 9628.4 9639.9 9653.3 9730.5 13763.7 13821.8 14181.4 14198.8 14300.6 5614.1 5716.4 5726.7 5797.4 5808.9 831.2 901.8 927.5 974.9 1092.5 28012.3 28036.9 28061.6 28198.6 28308.9 954.2 993.4 1104.1 1105.8 1149.5 14560.1 14626.2 14636.3 14798.8 14993.6 328817.0 330646.0 330868.0 333935.0 334739.0 50159.5 50975.2 51032.5 51377.2 51499.8 1139.7 1330.0 1333.7 1336.9 1346.1 26918.0 27714.0 27714.6 27968.6 28270.2 45120.5 45294.8 45413.5 45447.0 45512.5 291503.0 295620.0 296202.0 297815.0 299512.0 31985.4 42855.0 43334.1 43749.0 43950.8 37742.2 38957.2 39167.0 39250.2 39555.4 32865.3 33670.3 36208.3 36793.3 36834.4 36442.0 36491.3 36576.3 36599.7 36760.4 35525.0 36014.0 37901.4 39164.4 39265.8 28797.9 30358.2 30943.5 31172.5 31209.2 23836.2 23865.0 24020.3 24191.8 25022.2 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | [#2] jquery.html Cycles:180 Average:26083.86 Median:4878.76 stddev:84194.35 (1725.7%) stddev-sans-first:84408.36 01:08:49 INFO - PROCESS | 15766 | Values: 348.0 349.5 350.9 351.6 353.6 15786.8 15950.9 16602.3 16664.9 17321.7 10655.0 10684.2 10700.6 12278.4 15288.3 4864.6 4875.9 4990.5 5014.4 5054.0 4881.6 5000.0 5001.1 5026.2 5028.3 5001.0 5066.3 5067.9 5238.9 5287.3 5125.2 5153.9 5154.2 5169.8 5463.6 5203.3 5206.8 5238.0 5265.9 5275.2 17364.9 17712.2 18375.3 18436.0 18471.2 1960.1 1981.7 2042.6 2047.9 2121.3 12441.4 12580.1 12631.4 12760.2 12894.4 1782.5 1793.4 1873.8 1887.8 1892.3 52916.7 54379.5 54840.2 54927.5 55361.2 9330.6 9349.9 9359.6 9373.0 9391.5 11842.7 11854.8 11898.0 11907.8 11942.6 6818.7 6845.8 6891.1 6904.4 6960.2 6555.3 6613.4 6622.6 6636.3 6645.3 3939.1 3948.5 3965.3 3970.6 3978.8 1565.5 1646.5 1656.7 1700.0 1721.9 879.0 882.8 943.3 986.7 1007.7 14829.7 14845.8 15517.5 15635.2 15656.1 890.0 915.5 929.2 955.5 975.6 8588.7 8893.5 8925.5 9045.2 9266.1 503841.0 515326.0 517006.0 519684.0 521907.0 66119.7 67072.3 68900.7 69415.0 69999.0 1128.1 1129.9 1149.2 1151.5 1155.8 13784.4 13847.2 14802.2 14965.8 14974.1 24953.5 29154.3 29227.4 30131.0 30389.7 36591.5 38097.0 38111.6 38654.6 40466.0 7132.0 7230.7 7244.7 7321.5 7381.3 10286.3 10760.5 11272.9 11331.8 11468.9 3003.0 3869.9 9138.5 9579.2 9775.7 9453.9 9904.3 10006.5 10065.1 10219.1 9400.0 9891.9 9974.0 10044.8 10062.5 7271.0 7489.1 7527.4 7637.1 7700.9 9587.4 9758.5 9916.7 9942.0 10088.8 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | [#3] mootools.html Cycles:180 Average:5380.47 Median:6374.61 stddev:2766.00 (43.4%) stddev-sans-first:2757.19 01:08:49 INFO - PROCESS | 15766 | Values: 1353.4 1443.2 1546.5 1734.7 1743.4 7441.4 7602.9 7610.8 7612.5 7823.6 7570.1 7664.0 7755.1 7768.8 7775.0 2327.3 2338.3 2359.4 2364.9 2367.1 2198.2 2220.8 2221.1 2231.5 2248.5 2193.7 2200.9 2217.2 2265.7 2271.5 2197.8 2208.8 2231.3 2235.3 2237.5 2225.4 2233.5 2251.6 2257.3 2258.0 7534.5 7537.1 7552.7 7568.8 7580.4 4664.0 4779.5 4790.9 4791.5 4798.8 3088.8 3105.1 3138.2 3151.6 3184.6 1001.5 1025.3 1031.3 1048.3 1092.3 10686.0 10708.5 10756.9 10768.3 10789.6 4162.2 4212.9 4232.3 4239.0 4283.7 8752.6 8762.6 8784.4 8804.6 8820.2 4671.9 4686.3 4700.7 4728.1 4736.9 4315.6 4333.5 4334.4 4360.6 4361.7 3521.3 3522.6 3525.9 3545.4 3552.6 1093.3 1105.7 1113.1 1115.4 1117.4 897.4 898.9 899.8 970.3 1021.8 7117.4 7257.2 7270.4 7287.4 7302.4 1096.6 1181.7 1217.0 1222.9 1243.4 5629.4 5721.3 5729.6 5738.4 5760.9 8836.5 8849.4 9059.9 9076.3 9093.4 8999.2 9005.4 9021.8 9027.8 9034.3 6805.4 6945.6 6967.3 7031.5 7045.3 7168.9 7249.7 7250.2 7268.6 7273.8 8061.6 8211.6 8299.9 8370.9 8475.2 8391.5 8610.9 8622.1 8627.7 8671.6 6670.8 6807.4 6935.4 6942.1 6943.1 7301.5 7325.6 7334.6 7360.7 7372.1 6595.2 6668.4 6839.0 6842.0 7115.6 6743.8 6803.8 6810.7 6843.9 6925.3 6749.8 6798.8 6838.8 6843.8 6857.1 6326.5 6334.8 6341.1 6358.1 6391.1 6355.7 6429.7 6441.5 6462.1 6477.3 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | [#4] prototype.html Cycles:180 Average:5547.75 Median:6354.93 stddev:1739.52 (27.4%) stddev-sans-first:1699.35 01:08:49 INFO - PROCESS | 15766 | Values: 307.4 314.9 323.5 324.6 327.0 6106.7 6308.0 6335.8 6366.0 6477.2 6268.8 6276.0 6299.3 6330.6 6362.9 4575.4 4680.1 4709.6 4710.2 4719.3 4700.6 4703.9 4713.4 4720.3 4727.5 4643.4 4653.7 4656.4 4659.4 4677.3 4672.0 4684.1 4685.0 4687.8 4706.5 3844.7 3959.8 4058.3 4061.9 4062.9 5818.2 5820.8 5825.8 5831.2 5868.5 5336.7 5347.5 5350.5 5357.9 5381.3 6567.5 6586.5 6594.8 6600.3 6627.4 4252.7 4336.9 4370.6 4372.8 4373.2 6898.1 6927.0 6962.1 6981.5 6987.3 4533.9 4545.0 4562.4 4562.9 4573.3 4443.8 4592.1 4616.2 4621.4 4623.2 5363.8 5406.0 5414.7 5434.0 5442.9 6635.6 6697.4 6717.6 6718.7 6738.4 1602.4 1603.2 1604.8 1607.0 1608.0 1054.7 1064.2 1070.9 1075.1 1094.1 6104.9 6244.0 6350.4 6353.5 6356.4 6744.6 6926.3 6987.4 7007.5 7008.9 6373.7 6376.3 6383.7 6399.1 6413.2 3633.1 3738.0 3741.6 3756.0 3771.4 7243.1 7262.6 7301.7 7302.8 7311.9 7068.4 7109.4 7111.6 7116.1 7138.0 7170.1 7244.2 7298.1 7315.9 7318.5 6906.9 6932.1 6944.0 6944.5 6961.8 6792.5 6798.5 6855.6 6869.9 6876.3 7059.7 7277.2 7329.2 7336.5 7358.5 4565.3 4610.2 4613.4 4616.7 4619.1 6861.9 6946.3 6998.4 6999.3 6999.5 6507.3 6695.9 6697.0 6708.1 6774.3 6753.1 6758.9 6774.3 6784.5 6799.6 6569.5 6646.0 6657.8 6669.2 6671.7 6589.3 6707.0 6752.3 6767.0 6825.2 6572.8 6581.4 6600.8 6634.3 6634.9 01:08:49 INFO - PROCESS | 15766 | 01:08:49 INFO - PROCESS | 15766 | [#5] yui.html Cycles:180 Average:12974.64 Median:582.06 stddev:15501.63 (2663.2%) stddev-sans-first:15517.35 01:08:49 INFO - PROCESS | 15766 | Values: 617.8 628.2 680.4 680.8 683.7 12774.7 12840.2 12842.7 12966.7 13059.4 12288.7 12324.9 12368.5 12374.6 12408.0 569.2 765.7 793.6 796.8 798.3 797.7 798.1 798.7 802.6 804.4 832.0 832.4 837.5 840.0 844.3 827.9 828.2 830.6 837.0 837.4 614.5 615.7 617.3 620.1 620.8 12235.9 12361.7 12399.6 12416.7 12450.3 12000.8 12142.2 12346.9 12518.9 12773.5 8893.6 8973.9 8978.2 9013.8 9048.2 3428.5 3501.4 3508.0 3508.2 3516.7 44197.1 44670.1 44930.3 45448.5 45934.5 9539.4 9634.5 9646.6 9871.6 9882.7 17185.9 17286.0 17315.7 17327.4 17416.4 6951.8 7018.9 7027.7 7127.1 7306.2 4081.0 4086.1 4088.9 4120.2 4126.5 3036.1 3042.9 3047.7 3057.7 3061.2 572.4 573.5 580.9 582.0 594.4 518.5 522.6 538.8 572.7 582.2 7556.1 8662.8 8796.4 8933.3 9191.9 506.7 572.3 591.3 597.5 601.7 3655.2 3674.1 3695.4 3706.3 3827.2 55841.4 56182.2 56340.4 56620.0 56631.0 48096.0 49521.5 50070.5 50398.0 50521.2 43529.7 44396.0 47262.3 47303.5 47503.0 7282.0 7342.4 7430.3 7434.5 7452.5 33416.3 33523.5 33795.0 33862.3 34212.5 38828.0 41056.6 43300.9 43929.8 44946.0 9391.6 9436.9 9448.2 9496.6 9620.8 10057.8 10064.5 10097.9 10176.4 10300.5 8920.2 9031.0 9115.1 9370.5 9485.6 9164.0 9307.2 9499.7 9532.6 9566.4 8885.2 8888.7 9036.9 9387.3 9582.7 8062.4 8333.6 8458.9 8503.1 8623.9 8239.7 8401.2 8483.2 8491.6 8553.7 01:08:49 INFO - PROCESS | 15766 | -------- Summary: end -------- 01:08:49 INFO - PROCESS | 15766 | 01:08:50 INFO - TEST-INFO | 15766: exit 0 01:08:50 INFO - TEST-OK | dromaeo_css | took 1110198ms 01:08:50 INFO - TEST-START | kraken 01:08:50 INFO - operating with platform_type : linux_ 01:08:50 INFO - Initialising browser for kraken test... 01:08:50 INFO - TEST-INFO | started process 16003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0own4B/profile http://localhost:43731/getInfo.html) 01:08:54 INFO - PROCESS | 16003 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:08:54 INFO - PROCESS | 16003 | __metrics Screen width/height:1600/1200 01:08:54 INFO - PROCESS | 16003 | colorDepth:24 01:08:54 INFO - PROCESS | 16003 | Browser inner width/height: 1024/697 01:08:54 INFO - PROCESS | 16003 | __metrics 01:08:55 INFO - PROCESS | 16003 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:08:55 INFO - TEST-INFO | 16003: exit 0 01:08:55 INFO - Browser initialized. 01:08:55 INFO - Running cycle 1/1 for kraken test... 01:08:55 INFO - TEST-INFO | started process 16124 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0own4B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:07 INFO - PROCESS | 16124 | RSS: Main: 150691840 01:09:07 INFO - PROCESS | 16124 | 01:09:10 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43731/tests/kraken/driver.html?testName=audio-beat-detection) 01:09:10 INFO - PROCESS | 16124 | RSS: Main: 151318528 01:09:10 INFO - PROCESS | 16124 | 01:09:13 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43731/tests/kraken/driver.html?testName=audio-dft) 01:09:14 INFO - PROCESS | 16124 | RSS: Main: 150020096 01:09:14 INFO - PROCESS | 16124 | 01:09:16 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43731/tests/kraken/driver.html?testName=audio-fft) 01:09:17 INFO - PROCESS | 16124 | RSS: Main: 146821120 01:09:17 INFO - PROCESS | 16124 | 01:09:19 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43731/tests/kraken/driver.html?testName=audio-oscillator) 01:09:20 INFO - PROCESS | 16124 | RSS: Main: 146391040 01:09:20 INFO - PROCESS | 16124 | 01:09:22 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:09:22 INFO - PROCESS | 16124 | RSS: Main: 147275776 01:09:22 INFO - PROCESS | 16124 | 01:09:25 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43731/tests/kraken/driver.html?testName=imaging-darkroom) 01:09:26 INFO - PROCESS | 16124 | RSS: Main: 145952768 01:09:26 INFO - PROCESS | 16124 | 01:09:29 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43731/tests/kraken/driver.html?testName=imaging-desaturate) 01:09:30 INFO - PROCESS | 16124 | RSS: Main: 147226624 01:09:30 INFO - PROCESS | 16124 | 01:09:33 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43731/tests/kraken/driver.html?testName=json-parse-financial) 01:09:33 INFO - PROCESS | 16124 | RSS: Main: 147124224 01:09:33 INFO - PROCESS | 16124 | 01:09:35 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:09:36 INFO - PROCESS | 16124 | RSS: Main: 148258816 01:09:36 INFO - PROCESS | 16124 | 01:09:37 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:09:38 INFO - PROCESS | 16124 | RSS: Main: 149127168 01:09:38 INFO - PROCESS | 16124 | 01:09:40 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:09:41 INFO - PROCESS | 16124 | RSS: Main: 149286912 01:09:41 INFO - PROCESS | 16124 | 01:09:43 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:44 INFO - PROCESS | 16124 | RSS: Main: 149430272 01:09:44 INFO - PROCESS | 16124 | 01:09:46 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:47 INFO - PROCESS | 16124 | RSS: Main: 148582400 01:09:47 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | Cycle 1(1): loaded http://localhost:43731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43731/tests/kraken/driver.html?testName=ai-astar) 01:09:49 INFO - PROCESS | 16124 | RSS: Main: 149102592 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | __start_tp_report 01:09:49 INFO - PROCESS | 16124 | _x_x_mozilla_page_load 01:09:49 INFO - PROCESS | 16124 | _x_x_mozilla_page_load_details 01:09:49 INFO - PROCESS | 16124 | |i|pagename|runs| 01:09:49 INFO - PROCESS | 16124 | |0;ai-astar;111;108;112;110;111;123;111;110;113;112 01:09:49 INFO - PROCESS | 16124 | |1;audio-beat-detection;146;134;153;171;130;156;154;135;161;134 01:09:49 INFO - PROCESS | 16124 | |2;audio-dft;162;163;162;162;162;163;163;163;171;163 01:09:49 INFO - PROCESS | 16124 | |3;audio-fft;72;76;75;72;76;73;136;72;75;74 01:09:49 INFO - PROCESS | 16124 | |4;audio-oscillator;96;99;140;96;98;97;137;96;98;149 01:09:49 INFO - PROCESS | 16124 | |5;imaging-gaussian-blur;110;111;109;109;111;110;110;111;110;110 01:09:49 INFO - PROCESS | 16124 | |6;imaging-darkroom;147;146;147;147;147;147;147;147;149;147 01:09:49 INFO - PROCESS | 16124 | |7;imaging-desaturate;97;97;96;96;97;97;99;96;96;96 01:09:49 INFO - PROCESS | 16124 | |8;json-parse-financial;59;58;62;59;60;60;60;60;56;57 01:09:49 INFO - PROCESS | 16124 | |9;json-stringify-tinderbox;67;67;66;66;67;67;66;67;67;68 01:09:49 INFO - PROCESS | 16124 | |10;stanford-crypto-aes;85;85;86;92;86;92;83;85;87;86 01:09:49 INFO - PROCESS | 16124 | |11;stanford-crypto-ccm;117;132;120;122;124;125;123;134;121;119 01:09:49 INFO - PROCESS | 16124 | |12;stanford-crypto-pbkdf2;144;151;152;151;161;142;153;141;146;147 01:09:49 INFO - PROCESS | 16124 | |13;stanford-crypto-sha256-iterative;70;70;67;70;69;74;69;68;69;68 01:09:49 INFO - PROCESS | 16124 | __end_tp_report 01:09:49 INFO - PROCESS | 16124 | __start_cc_report 01:09:49 INFO - PROCESS | 16124 | _x_x_mozilla_cycle_collect,746 01:09:49 INFO - PROCESS | 16124 | __end_cc_report 01:09:49 INFO - PROCESS | 16124 | __startTimestamp1452244189377__endTimestamp 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | ------- Summary: start ------- 01:09:49 INFO - PROCESS | 16124 | Number of tests: 14 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:4.07 (3.6%) stddev-sans-first:4.29 01:09:49 INFO - PROCESS | 16124 | Values: 111.0 108.0 112.0 110.0 111.0 123.0 111.0 110.0 113.0 112.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:153.50 stddev:13.78 (9.0%) stddev-sans-first:14.60 01:09:49 INFO - PROCESS | 16124 | Values: 146.0 134.0 153.0 171.0 130.0 156.0 154.0 135.0 161.0 134.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.72 (1.7%) stddev-sans-first:2.83 01:09:49 INFO - PROCESS | 16124 | Values: 162.0 163.0 162.0 162.0 162.0 163.0 163.0 163.0 171.0 163.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.50 stddev:19.71 (26.5%) stddev-sans-first:20.68 01:09:49 INFO - PROCESS | 16124 | Values: 72.0 76.0 75.0 72.0 76.0 73.0 136.0 72.0 75.0 74.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:21.89 (22.7%) stddev-sans-first:22.57 01:09:49 INFO - PROCESS | 16124 | Values: 96.0 99.0 140.0 96.0 98.0 97.0 137.0 96.0 98.0 149.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 01:09:49 INFO - PROCESS | 16124 | Values: 110.0 111.0 109.0 109.0 111.0 110.0 110.0 111.0 110.0 110.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 01:09:49 INFO - PROCESS | 16124 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 149.0 147.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 01:09:49 INFO - PROCESS | 16124 | Values: 97.0 97.0 96.0 96.0 97.0 97.0 99.0 96.0 96.0 96.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:1.73 (2.9%) stddev-sans-first:1.83 01:09:49 INFO - PROCESS | 16124 | Values: 59.0 58.0 62.0 59.0 60.0 60.0 60.0 60.0 56.0 57.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 01:09:49 INFO - PROCESS | 16124 | Values: 67.0 67.0 66.0 66.0 67.0 67.0 66.0 67.0 67.0 68.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:2.98 (3.5%) stddev-sans-first:3.10 01:09:49 INFO - PROCESS | 16124 | Values: 85.0 85.0 86.0 92.0 86.0 92.0 83.0 85.0 87.0 86.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.50 stddev:5.46 (4.4%) stddev-sans-first:5.22 01:09:49 INFO - PROCESS | 16124 | Values: 117.0 132.0 120.0 122.0 124.0 125.0 123.0 134.0 121.0 119.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.00 stddev:6.03 (4.0%) stddev-sans-first:6.14 01:09:49 INFO - PROCESS | 16124 | Values: 144.0 151.0 152.0 151.0 161.0 142.0 153.0 141.0 146.0 147.0 01:09:49 INFO - PROCESS | 16124 | 01:09:49 INFO - PROCESS | 16124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.90 (2.7%) stddev-sans-first:2.00 01:09:49 INFO - PROCESS | 16124 | Values: 70.0 70.0 67.0 70.0 69.0 74.0 69.0 68.0 69.0 68.0 01:09:49 INFO - PROCESS | 16124 | -------- Summary: end -------- 01:09:49 INFO - PROCESS | 16124 | 01:09:50 INFO - TEST-INFO | 16124: exit 0 01:09:50 INFO - TEST-OK | kraken | took 60021ms 01:09:50 INFO - TEST-START | v8_7 01:09:50 INFO - operating with platform_type : linux_ 01:09:50 INFO - Initialising browser for v8_7 test... 01:09:50 INFO - TEST-INFO | started process 16413 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyhNrrH/profile http://localhost:43731/getInfo.html) 01:09:54 INFO - PROCESS | 16413 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:09:54 INFO - PROCESS | 16413 | __metrics Screen width/height:1600/1200 01:09:54 INFO - PROCESS | 16413 | colorDepth:24 01:09:54 INFO - PROCESS | 16413 | Browser inner width/height: 1024/697 01:09:54 INFO - PROCESS | 16413 | __metrics 01:09:55 INFO - PROCESS | 16413 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:09:55 INFO - TEST-INFO | 16413: exit 0 01:09:55 INFO - Browser initialized. 01:09:55 INFO - Running cycle 1/1 for v8_7 test... 01:09:55 INFO - TEST-INFO | started process 16535 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyhNrrH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:10:07 INFO - PROCESS | 16535 | RSS: Main: 150450176 01:10:07 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | Cycle 1(1): loaded http://localhost:43731/tests/v8_7/run.html (next: http://localhost:43731/tests/v8_7/run.html) 01:10:30 INFO - PROCESS | 16535 | RSS: Main: 145788928 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | __start_tp_report 01:10:30 INFO - PROCESS | 16535 | _x_x_mozilla_page_load 01:10:30 INFO - PROCESS | 16535 | _x_x_mozilla_page_load_details 01:10:30 INFO - PROCESS | 16535 | |i|pagename|runs| 01:10:30 INFO - PROCESS | 16535 | |0;Richards;169.664065151001 01:10:30 INFO - PROCESS | 16535 | |1;DeltaBlue;189.78933383943823 01:10:30 INFO - PROCESS | 16535 | |2;Encrypt;280.3476310625175 01:10:30 INFO - PROCESS | 16535 | |3;Decrypt;5278.9473684210525 01:10:30 INFO - PROCESS | 16535 | |4;RayTrace;1078.7486515641856 01:10:30 INFO - PROCESS | 16535 | |5;Earley;703.7297677691766 01:10:30 INFO - PROCESS | 16535 | |6;Boyer;12231.707317073171 01:10:30 INFO - PROCESS | 16535 | |7;RegExp;42020.833333333336 01:10:30 INFO - PROCESS | 16535 | |8;Splay;595.0413223140496 01:10:30 INFO - PROCESS | 16535 | |9;NavierStokes;4835.748792270531 01:10:30 INFO - PROCESS | 16535 | __end_tp_report 01:10:30 INFO - PROCESS | 16535 | __startTimestamp1452244230375__endTimestamp 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | ------- Summary: start ------- 01:10:30 INFO - PROCESS | 16535 | Number of tests: 10 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#0] Richards Cycles:1 Average:169.66 Median:169.66 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 169.7 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#1] DeltaBlue Cycles:1 Average:189.79 Median:189.79 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 189.8 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 280.3 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#3] Decrypt Cycles:1 Average:5278.95 Median:5278.95 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 5278.9 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 1078.7 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 703.7 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 12231.7 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#7] RegExp Cycles:1 Average:42020.83 Median:42020.83 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 42020.8 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#8] Splay Cycles:1 Average:595.04 Median:595.04 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 595.0 01:10:30 INFO - PROCESS | 16535 | 01:10:30 INFO - PROCESS | 16535 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 01:10:30 INFO - PROCESS | 16535 | Values: 4835.7 01:10:30 INFO - PROCESS | 16535 | -------- Summary: end -------- 01:10:30 INFO - PROCESS | 16535 | 01:10:31 INFO - TEST-INFO | 16535: exit 0 01:10:31 INFO - TEST-OK | v8_7 | took 40809ms 01:10:31 INFO - SUITE-END | took 1211s 01:10:31 INFO - Completed test suite (00:20:11) 01:10:31 INFO - Working with test: dromaeo_css 01:10:31 INFO - Generating results file: dromaeo_css 01:10:31 INFO - Working with test: kraken 01:10:31 INFO - Generating results file: kraken 01:10:31 INFO - javascript benchmark 01:10:31 INFO - Working with test: v8_7 01:10:31 INFO - Generating results file: v8_7 01:10:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 01:10:31 INFO - process_Request line: dromaeo_css 6696.62 graph.html#tests=[[72,63,43]] 01:10:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:31 INFO - process_Request line: kraken 1522.00 graph.html#tests=[[232,63,43]] 01:10:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:31 INFO - process_Request line: v8_7 20290.93 graph.html#tests=[[230,63,43]] 01:10:31 INFO - RETURN: dromaeo_css: 6696.62 01:10:31 INFO - RETURN: kraken: 1522.00 01:10:31 INFO - RETURN: v8_7: 20290.93 01:10:31 INFO - javascript benchmark 01:10:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.2827949571597, 3144.1039303798407, 3153.101366110659, 3182.3219866795807, 3186.2830863055815, 5120.078385890548, 5189.896202075961, 5207.947920520794, 5221.765020574074, 5289.259503669489, 5241.371035475749, 5266.34170728658, 5267.47325267473, 5284.497972692588, 5297.284866543016, 4803.159447096753, 4818.831340903069, 4873.951260487385, 4950.678205916622, 4952.479989601094, 4865.781039853215, 4885.828995985141, 4890.951090489103, 4903.509649035086, 4955.752212389366, 4539.364488971513, 4580.3358513015755, 4904.190808516591, 4904.239842824368, 4909.680870743408, 4847.175980083359, 4864.075825593126, 4867.050925069578, 4875.07373599015, 4901.705897646153, 4824.662273640846, 4846.927296090526, 4863.781129849165, 4875.804967801284, 4907.4356449008465, 5089.949100508985, 5110.97444512775, 5166.07010738067, 5177.689338639693, 5220.738963051832, 5729.885402291972, 5778.624389414675, 5801.506871915893, 5802.21670074543, 5807.448292412214, 5701.14482827575, 5821.825345239649, 5842.503387212049, 5842.591018628697, 5849.970750146222, 5186.818461353834, 5317.787288508455, 5374.059539580597, 5384.542313903284, 5417.322834645669, 5836.007878660638, 5836.503897168788, 5839.474447299678, 5852.590318677651, 5858.589898707135, 5531.308586426697, 5613.045782217033, 5619.072852979294, 5622.606417550814, 5625.521830644359, 5679.943200568024, 5744.195812586241, 5756.971215143897, 5760.481556659837, 5792.739326730307, 5592.245046918695, 5616.129499927518, 5633.295838020247, 5633.324001119892, 5641.717914104278, 5483.75323110461, 5562.554995600423, 5609.915851262234, 5625.578081643893, 5678.261825962599, 4487.910241795211, 4492.730436173774, 4493.59557639814, 4510.436195475566, 4512.0, 3990.700697447703, 4013.3979903014197, 4027.5771044039952, 4039.7374170678813, 4062.51249850014, 5242.7116508591635, 5300.681959082467, 5312.867178320495, 5462.235287059815, 5464.480874316933, 5764.884702305931, 5774.39368866263, 5777.711114444261, 5789.623674461147, 5794.942050579441, 5408.5402740766685, 5412.485813847678, 5416.539594134464, 5425.484578964992, 5427.810026649048, 4720.811167553328, 4817.7350245736825, 4819.7108173509705, 4864.878378040577, 4908.9263661045115, 5920.911186332209, 5928.466438020599, 5954.285485741652, 5971.850703732442, 5973.432523910222, 5555.833325000256, 5719.399463056319, 5729.341125770589, 5731.684757338219, 5746.051901436216, 5810.360860305447, 5815.621984570989, 5871.119332100219, 5899.321578018411, 5948.910766338422, 5625.831225063254, 5634.380218175916, 5656.1798539212405, 5657.2079908811975, 5658.038133517394, 5616.7191640416995, 5664.716764161858, 5735.082386818256, 5755.223044889054, 5762.337331206965, 5497.230387745639, 5567.749451274622, 5579.581531385081, 5585.636933599303, 5640.915386269291, 5577.247071645276, 5578.721063946705, 5587.07813210832, 5587.44125587438, 5591.832245032656, 5417.566594672496, 5534.418886017072, 5541.9168712470155, 5542.057850165401, 5584.441555844545, 5393.43368946255, 5540.113581826889, 5540.778368865362, 5576.972115139399, 5583.35791383996, 5422.05114105038, 5428.782848686008, 5445.428230035789, 5456.181572763959, 5460.535854452257], "unit": "score", "name": "dojo.html", "value": 5260.5792301639995}, {"lowerIsBetter": false, "replicates": [521.5983692556731, 528.6484487815601, 551.6359202926068, 557.389658324135, 560.5319558168932, 34496.82751586242, 35777.284454310895, 35810.10474738133, 35822.82088589557, 35823.52205974253, 36342.273154536895, 36541.45187822185, 36583.4512482313, 37031.629683703155, 37064.629353706456, 8198.549079800609, 8413.957930210341, 8431.367647426438, 8439.282660973824, 8446.282066024396, 8123.918760812405, 8337.916620833774, 8431.578421078952, 8453.02790179128, 8485.830283394329, 8386.161383861627, 8519.53142577158, 8549.102344253826, 8565.871511927326, 8567.400281980264, 8302.086770455246, 8451.661933522682, 8470.703525376583, 8485.575721213976, 8500.532470714108, 8252.793680157984, 8368.58157092143, 8400.0, 8401.327893768485, 8404.8319033619, 35751.642483575095, 36328.27343453116, 36333.0, 36371.272574548624, 36380.63619363825, 3153.7634677399055, 3247.1882029492626, 3328.367610154063, 3336.2660214752714, 3552.236269202134, 29175.562366564518, 29541.556876646653, 29787.25531861699, 29912.8504357479, 30432.69567304343, 3182.867478789217, 3194.8881789137267, 3225.048610659861, 3261.4944683574086, 3288.128645908836, 265586.0, 266896.6655166731, 266938.0, 267569.0, 268685.0, 41754.58245417507, 47834.521654783704, 47918.0, 48083.519164808604, 48165.27752083722, 34911.0, 34950.650493495246, 35086.12284692903, 35125.12187195341, 35128.0, 12742.10805243624, 12884.935575322063, 12889.742205155844, 12912.0, 12937.870621293667, 9610.855837162448, 9628.422294662343, 9639.855402168972, 9653.276004299705, 9730.464824434725, 13763.655908602364, 13821.79267310991, 14181.361838717283, 14198.787018194735, 14300.570982870531, 5614.129809879475, 5716.42835716425, 5726.685032323262, 5797.449242321973, 5808.941910580925, 831.2477208126655, 901.8016036471965, 927.4945154890601, 974.9122578967927, 1092.4919912240687, 28012.29969250785, 28036.85981570079, 28061.579076313872, 28198.577021344696, 28308.85845570759, 954.1698722111807, 993.3940296419179, 1104.0615476844619, 1105.7622611138484, 1149.4712432281078, 14560.126392416489, 14626.195559244345, 14636.341364638616, 14798.778018329735, 14993.550193494213, 328817.0, 330646.0, 330868.0, 333935.0, 334739.0, 50159.49840501621, 50975.235371469455, 51032.48967510352, 51377.229341559905, 51499.82002159765, 1139.6922830835795, 1329.9867001330056, 1333.69991751857, 1336.8529461759392, 1346.0846624295377, 26918.0, 27714.0, 27714.584281235395, 27968.580471293353, 28270.15189544317, 45120.54879451163, 45294.77352613216, 45413.545864542255, 45447.0, 45512.54487455083, 291503.0, 295620.0, 296202.0, 297815.0, 299512.0, 31985.36029279355, 42855.0, 43334.133317334105, 43749.0, 43950.78024609984, 37742.24515509729, 38957.22085558216, 39167.0, 39250.21499569935, 39555.40666890056, 32865.34269314648, 33670.32659346848, 36208.27583448369, 36793.26413471769, 36834.447483288306, 36442.0, 36491.270174595826, 36576.26847463089, 36599.72522430917, 36760.44859327059, 35525.0, 36014.0, 37901.431478527295, 39164.412533811446, 39265.80367098146, 28797.856010719814, 30358.241043973194, 30943.535846961862, 31172.53241201429, 31209.219769505944, 23836.16573419922, 23865.0, 24020.279391618278, 24191.758082419656, 25022.249332520052], "unit": "score", "name": "ext.html", "value": 17193.67534973122}, {"lowerIsBetter": false, "replicates": [347.9652034796521, 349.51068504094246, 350.8859620623297, 351.63254399152885, 353.588069898568, 15786.84213157868, 15950.920245398771, 16602.25289861956, 16664.91667541662, 17321.7401738974, 10654.987776161272, 10684.19868509861, 10700.571977120906, 12278.447469863855, 15288.31202595883, 4864.635152363587, 4875.926861097078, 4990.500949904998, 5014.398272207341, 5054.039732450841, 4881.585065269456, 5000.0, 5001.1248031594505, 5026.2209357549455, 5028.2709007193935, 5001.049800537904, 5066.341375621182, 5067.949320506803, 5238.92141617876, 5287.312649355578, 5125.2312153176945, 5153.922691159635, 5154.175331946889, 5169.819056333029, 5463.590230732671, 5203.323567936182, 5206.76569554371, 5238.0, 5265.921011184797, 5275.182346736262, 17364.91317543417, 17712.202950867242, 18375.264989400406, 18436.0, 18471.16879740415, 1960.14733590887, 1981.7423734914512, 2042.6221149087467, 2047.948801279965, 2121.321177223289, 12441.440135193847, 12580.11939164259, 12631.368431578476, 12760.170588911784, 12894.419751111223, 1782.5008997480727, 1793.3902473159058, 1873.7564116664882, 1887.7545919030438, 1892.2593000525887, 52916.735416323056, 54379.45620543823, 54840.177397339074, 54927.450725492636, 55361.16958245629, 9330.58012389444, 9349.859752103725, 9359.578818953163, 9372.95313523428, 9391.483468409304, 11842.703932401759, 11854.822177667342, 11898.0, 11907.821382679267, 11942.641720748392, 6818.727250910008, 6845.760398386033, 6891.104156459728, 6904.378605925491, 6960.199577048603, 6555.311692272338, 6613.371729685672, 6622.569532980341, 6636.336366363422, 6645.269020407752, 3939.054626889526, 3948.506436695413, 3965.3457179565626, 3970.6029397060065, 3978.840846366113, 1565.4599163288647, 1646.4648989078598, 1656.6521030583713, 1699.9745003824705, 1721.888077274973, 878.9868151977726, 882.7793051737066, 943.2736792669606, 986.6842610364758, 1007.7027276953316, 14829.703405931821, 14845.777313340308, 15517.456889009056, 15635.218239088, 15656.13891235993, 889.958748264532, 915.514777168102, 929.2194556572376, 955.5270141279972, 975.5951280218629, 8588.742337729878, 8893.4663920165, 8925.509096999598, 9045.231155351737, 9266.11971862672, 503841.0, 515326.0, 517006.0, 519684.0, 521907.0, 66119.66940165365, 67072.3292767066, 68900.65549672219, 69415.0, 69999.0, 1128.1200663482496, 1129.9265547739371, 1149.166854030821, 1151.5221183209042, 1155.820847768597, 13784.379702913193, 13847.238401887993, 14802.185879776285, 14965.77551336709, 14974.101553906801, 24953.500929980935, 29154.27114322074, 29227.41545169127, 30131.0, 30389.696103039572, 36591.45112823363, 38097.0, 38111.61888381081, 38654.6134538651, 40466.0, 7132.0, 7230.74692385764, 7244.746433875, 7321.450891183076, 7381.26187381279, 10286.2799604027, 10760.46197690128, 11272.887271127513, 11331.830022549504, 11468.885311147116, 3003.0, 3869.916423401452, 9138.543072846463, 9579.233661307218, 9775.657851975147, 9453.858192126985, 9904.306698531034, 10006.499675016075, 10065.144462720458, 10219.080282774587, 9400.0, 9891.851622225817, 9974.0, 10044.849327260243, 10062.49687515636, 7270.9636451819515, 7489.138749043712, 7527.397808175442, 7637.121731000784, 7700.922990770021, 9587.376820506644, 9758.46328451942, 9916.652917147865, 9942.0, 10088.798224035625], "unit": "score", "name": "jquery.html", "value": 7779.672615296612}, {"lowerIsBetter": false, "replicates": [1353.3639189580897, 1443.1629654800213, 1546.5205786206277, 1734.7051001329773, 1743.4333841501516, 7441.40468762499, 7602.923970760291, 7610.771676849697, 7612.5432474051595, 7823.647935842887, 7570.12943511495, 7663.965364675767, 7755.108162561307, 7768.766936991885, 7775.0, 2327.3134425344565, 2338.3101984914406, 2359.3865594945264, 2364.9054037838464, 2367.1241640593003, 2198.1537108213374, 2220.755716871143, 2221.133757834446, 2231.475603233239, 2248.4603695113137, 2193.7148170737782, 2200.8569442986236, 2217.246136313653, 2265.660150977358, 2271.4889149941214, 2197.7802219777973, 2208.768079351661, 2231.319447568491, 2235.2958817972367, 2237.5077482953807, 2225.354647152324, 2233.530958498701, 2251.6284813005836, 2257.2551058150934, 2258.006477150049, 7534.472586918863, 7537.057867766529, 7552.735654252075, 7568.826831841074, 7580.355669768076, 4664.0, 4779.498152693952, 4790.880227994293, 4791.496892826272, 4798.808047678089, 3088.7992280501694, 3105.099521138867, 3138.2311333723155, 3151.6060492438446, 3184.5541624172633, 1001.4542074569378, 1025.3489034463096, 1031.2935639087175, 1048.3395460859685, 1092.322759888874, 10686.038256556869, 10708.464576771208, 10756.946215268952, 10768.300060496043, 10789.622363217328, 4162.167566486714, 4212.936805947913, 4232.32282834745, 4239.046214601752, 4283.657307415399, 8752.606132724042, 8762.561871906379, 8784.429012114193, 8804.603792829337, 8820.206181443573, 4671.929921051187, 4686.336350595558, 4700.670953033323, 4728.05438912219, 4736.8578942631775, 4315.5900189481945, 4333.523312435629, 4334.414853994734, 4360.629346505582, 4361.6510679145595, 3521.3133438979153, 3522.5949015863503, 3525.858965641397, 3545.4150065239464, 3552.644735526478, 1093.3221402730358, 1105.657246253664, 1113.1261959361861, 1115.4311301236266, 1117.3742704085737, 897.4435849773051, 898.883145191121, 899.8110396816611, 970.335320305593, 1021.8058568871891, 7117.395021423134, 7257.237990010973, 7270.418366530665, 7287.417006639456, 7302.415806735448, 1096.6107032003683, 1181.704573856536, 1216.9634910952686, 1222.883826036525, 1243.3907385381278, 5629.380768115504, 5721.313442386857, 5729.598928075078, 5738.368779434259, 5760.855978600569, 8836.469811811312, 8849.380543362031, 9059.864102038475, 9076.273898088137, 9093.408928419763, 8999.19007289347, 9005.414648047856, 9021.774455638662, 9027.774305642411, 9034.277257819358, 6805.3875151236625, 6945.583265004116, 6967.268436814163, 7031.507794454441, 7045.295470452914, 7168.856622867618, 7249.710011599688, 7250.166230883516, 7268.636568171464, 7273.7634602116705, 8061.596920154087, 8211.58942052883, 8299.917000829915, 8370.87443688333, 8475.194856488624, 8391.496510209407, 8610.913890861011, 8622.137786221328, 8627.6980305689, 8671.566421678765, 6670.799876003728, 6807.421369183675, 6935.410490108397, 6942.097527321416, 6943.132108486439, 7301.488895777245, 7325.560466372035, 7334.559926404433, 7360.66876990526, 7372.078490188726, 6595.241547221939, 6668.433183179484, 6839.0, 6842.0, 7115.6086415247655, 6743.763968261087, 6803.7618683345845, 6810.727570897108, 6843.931560684528, 6925.342092501204, 6749.797506074629, 6798.7620433286575, 6838.794836154923, 6843.794686159423, 6857.142857142857, 6326.525510586816, 6334.764720879384, 6341.0805433212845, 6358.109864618865, 6391.10524526576, 6355.713992870239, 6429.678516074271, 6441.484681225397, 6462.063000864942, 6477.287498375269], "unit": "score", "name": "mootools.html", "value": 4422.76924211603}, {"lowerIsBetter": false, "replicates": [307.3836956901412, 314.9307152426466, 323.54864963376076, 324.6300611419808, 327.0466589890469, 6106.664133472657, 6308.022256550236, 6335.809925702225, 6365.968170159149, 6477.222733272014, 6268.780592679257, 6275.968620156893, 6299.275583307921, 6330.556861019731, 6362.9045564316575, 4575.428071491064, 4680.134175177603, 4709.576138147566, 4710.175719249118, 4719.292106184074, 4700.576948074672, 4703.882402939919, 4713.43438787346, 4720.315554244632, 4727.527247275262, 4643.442786865581, 4653.720776753389, 4656.371389862376, 4659.4175728034, 4677.251639737643, 4671.972166123447, 4684.1334353144775, 4684.953150468486, 4687.789049492747, 4706.458757242893, 3844.653981141683, 3959.8020098994934, 4058.269511487931, 4061.939070913939, 4062.8984275393054, 5818.243628328332, 5820.825375238707, 5825.83483303341, 5831.183634291203, 5868.530517558585, 5336.733163341817, 5347.46525347466, 5350.464953504657, 5357.919631205535, 5381.273528073699, 6567.54027218095, 6586.506012049115, 6594.769183078617, 6600.306967768363, 6627.403533681992, 4252.744835309892, 4336.913261734748, 4370.584794444522, 4372.825086996516, 4373.212821692094, 6898.0687607172895, 6926.965365173141, 6962.060121883532, 6981.476389270774, 6987.266337034589, 4533.886652833639, 4545.045540436479, 4562.406887104655, 4562.908741825145, 4573.268277075652, 4443.777811109496, 4592.081583683277, 4616.192166370872, 4621.399218101693, 4623.237165867661, 5363.812266570651, 5405.972970135124, 5414.702191379433, 5434.0, 5442.938626967703, 6635.568688035262, 6697.3637504437, 6717.563358381787, 6718.7312507499155, 6738.427233685192, 1602.3830825132175, 1603.1903888536447, 1604.751263554151, 1606.9517914462351, 1607.9678406431806, 1054.7152268887357, 1064.2443864856039, 1070.9089727373262, 1075.1076606416655, 1094.1465656787718, 6104.8779024420155, 6244.0, 6350.396712312323, 6353.459955903708, 6356.396142366468, 6744.5616034957575, 6926.272741362185, 6987.406070483964, 7007.544509606859, 7008.859822803515, 6373.74505019794, 6376.29860715321, 6383.680815959184, 6399.072134540465, 6413.16628838248, 3633.109888077438, 3738.0, 3741.607131251234, 3756.0422092366816, 3771.41543060826, 7243.0946131733535, 7262.5642461451425, 7301.671424785897, 7302.780916572511, 7311.89032164518, 7068.3991860691385, 7109.395701365442, 7111.573305601681, 7116.110486189226, 7137.964310178416, 7170.139583250043, 7244.203137654854, 7298.087739032621, 7315.926840731525, 7318.451116166309, 6906.8618627626165, 6932.0988271524375, 6943.9652801735665, 6944.548604340702, 6961.825954350979, 6792.490563207681, 6798.456123510206, 6855.5543889647015, 6869.896951545831, 6876.312368763083, 7059.717611295696, 7277.235890231661, 7329.1937886833475, 7336.486445948945, 7358.484906056525, 4565.269556870885, 4610.170169369546, 4613.400257966443, 4616.722996620214, 4619.053094115766, 6861.897071544031, 6946.305369463013, 6998.370146686822, 6999.30006999296, 6999.475039371966, 6507.251666058274, 6695.899561506679, 6697.0, 6708.127943367331, 6774.3225677431865, 6753.054572359775, 6758.932410676027, 6774.288699686659, 6784.457243420613, 6799.5920244785475, 6569.507286953402, 6646.0, 6657.7669781557415, 6669.199696036507, 6671.66641667905, 6589.341065893564, 6707.0, 6752.257251702407, 6767.0, 6825.215100263533, 6572.80281591553, 6581.440577550962, 6600.80197594073, 6634.336566343327, 6634.933650663432], "unit": "score", "name": "prototype.html", "value": 4967.113452319255}, {"lowerIsBetter": false, "replicates": [617.8239201827479, 628.1896353703721, 680.4114441008529, 680.826389270736, 683.7061658136951, 12774.68063298418, 12840.229586224834, 12842.678933026667, 12966.740665186691, 13059.412326445321, 12288.692782680437, 12324.876751232485, 12368.505259789597, 12374.566890158847, 12408.0, 569.223010590544, 765.6784150656738, 793.6468271619132, 796.8366484870587, 798.2695833312512, 797.7287722174459, 798.1180795221284, 798.656577671601, 802.6388125343618, 804.3725893802814, 832.0348395860802, 832.4089896173693, 837.4682076881194, 839.9874001889976, 844.2612713875359, 827.9420440569163, 828.200786241277, 830.622066959538, 836.9874451883196, 837.409626213518, 614.5452365249683, 615.6798464798325, 617.290116366178, 620.0729908786349, 620.8261686727724, 12235.877641223562, 12361.69095772604, 12399.628011159679, 12416.689582760413, 12450.3152326622, 12000.819987700192, 12142.150049496538, 12346.876531234662, 12518.937405312916, 12773.48906043757, 8893.555322233862, 8973.910260897374, 8978.191962723386, 9013.783139276245, 9048.230900373475, 3428.451447768345, 3501.4047611906035, 3507.982460087683, 3508.17557873902, 3516.6659167379057, 44197.06253289484, 44670.10659786786, 44930.326045109025, 45448.54551454509, 45934.54065459336, 9539.379940303998, 9634.470104144339, 9646.614135434644, 9871.605135794487, 9882.654107106217, 17185.91407042982, 17286.049267290167, 17315.740263896052, 17327.393541225996, 17416.39042633527, 6951.756688515979, 7018.894716579255, 7027.7188912442925, 7127.10911136108, 7306.204056460213, 4081.0, 4086.1010577672864, 4088.897777555585, 4120.196561670506, 4126.504819421689, 3036.089173248017, 3042.863071161759, 3047.6647568767416, 3057.7400920921527, 3061.1581815001055, 572.3560993881883, 573.5039191099669, 580.8867270882138, 581.9563532735061, 594.4412252482653, 518.5125981577305, 522.5558275465823, 538.8410418926426, 572.7279542217414, 582.1587805620921, 7556.1310449297935, 8662.810106777873, 8796.384253102222, 8933.330000250007, 9191.886192866223, 506.6504062622355, 572.3103660089582, 591.3288417646003, 597.486161900765, 601.6811090122242, 3655.1958569114754, 3674.147714512415, 3695.4087346024507, 3706.3328600851564, 3827.158025234444, 55841.44158558363, 56182.15726764102, 56340.43659563352, 56620.0, 56631.0, 48096.0, 49521.50478495169, 50070.499295006586, 50398.0, 50521.242181367306, 43529.69410917677, 44396.0, 47262.29106563405, 47303.526964729914, 47503.0, 7281.963590182015, 7342.375898048512, 7430.331270185709, 7434.479586428898, 7452.478326517092, 33416.33167336688, 33523.497147542315, 33795.0, 33862.32275354528, 34212.48681269733, 38828.0, 41056.58943410647, 43300.917477063325, 43929.78035109932, 44946.0, 9391.631013252396, 9436.85844712316, 9448.244140468883, 9496.572654230715, 9620.75948101303, 10057.849132262876, 10064.496775161359, 10097.949510252402, 10176.440295783803, 10300.484975751033, 8920.24177944882, 9031.0, 9115.134062264075, 9370.531473426165, 9485.620575176916, 9164.0, 9307.20888724466, 9499.667511637335, 9532.618695252113, 9566.378185417925, 8885.200331970154, 8888.73333799987, 9036.909630903607, 9387.342885997914, 9582.712518624452, 8062.435629505878, 8333.624986875726, 8458.873116903374, 8503.13636182026, 8623.913760862562, 8239.670413183405, 8401.15988401155, 8483.194096560817, 8491.617877195664, 8553.657853686032], "unit": "score", "name": "yui.html", "value": 5833.591959373075}], "name": "dromaeo_css", "value": 6696.6165931503165}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 110.0, 111.0, 123.0, 111.0, 110.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [146.0, 134.0, 153.0, 171.0, 130.0, 156.0, 154.0, 135.0, 161.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 171.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 75.0, 72.0, 76.0, 73.0, 136.0, 72.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 140.0, 96.0, 98.0, 97.0, 137.0, 96.0, 98.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 109.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 99.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 62.0, 59.0, 60.0, 60.0, 60.0, 60.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 92.0, 86.0, 92.0, 83.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [117.0, 132.0, 120.0, 122.0, 124.0, 125.0, 123.0, 134.0, 121.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [144.0, 151.0, 152.0, 151.0, 161.0, 142.0, 153.0, 141.0, 146.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 67.0, 70.0, 69.0, 74.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1522.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.664065151001], "unit": "score", "name": "Richards", "value": 208.0699880000001}, {"lowerIsBetter": false, "replicates": [189.78933383943823], "unit": "score", "name": "DeltaBlue", "value": 348.37574199999995}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5278.9473684210525], "unit": "score", "name": "Decrypt", "value": 50.423120638085756}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [42020.833333333336], "unit": "score", "name": "RegExp", "value": 21.679365394149706}, {"lowerIsBetter": false, "replicates": [595.0413223140496], "unit": "score", "name": "Splay", "value": 136.95015277777784}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20290.927605744782}]} 01:10:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20290.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1522.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6696.62"}}} 01:10:31 INFO - Return code: 0 01:10:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:10:31 INFO - # TBPL SUCCESS # 01:10:31 INFO - Running post-action listener: _resource_record_post_action 01:10:31 INFO - Running post-run listener: _resource_record_post_run 01:10:33 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 577642496; Read time: 0; Write time: 568068 01:10:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254218240; Read time: 0; Write time: 323020 01:10:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 323424256; Read time: 0; Write time: 245048 01:10:33 INFO - Running post-run listener: _upload_blobber_files 01:10:33 INFO - Blob upload gear active. 01:10:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:10:33 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 01:10:33 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:10:33 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:10:33 INFO - (blobuploader) - INFO - Open directory for files ... 01:10:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:10:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:10:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:34 INFO - (blobuploader) - INFO - Done attempting. 01:10:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:10:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:10:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:35 INFO - (blobuploader) - INFO - Done attempting. 01:10:35 INFO - (blobuploader) - INFO - Iteration through files over. 01:10:35 INFO - Return code: 0 01:10:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:10:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:10:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75b36b77be76636bfd9fedf79b23f45a2a77c459b6571cea6f3a3b6424e20e0109a12a9867168978da6ef9cfc17d51b786acbe963296725fda12a95af8549756", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/344f932d0134fb34ee9b2f5b1aa2ac5caeddcb8727e692f89858f3480af8573aa769cd6fef5bbb331d39b76417c8f6e611072ba230821fddc45e2f5a98030437"} 01:10:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:10:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:10:35 INFO - Contents: 01:10:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75b36b77be76636bfd9fedf79b23f45a2a77c459b6571cea6f3a3b6424e20e0109a12a9867168978da6ef9cfc17d51b786acbe963296725fda12a95af8549756", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/344f932d0134fb34ee9b2f5b1aa2ac5caeddcb8727e692f89858f3480af8573aa769cd6fef5bbb331d39b76417c8f6e611072ba230821fddc45e2f5a98030437"} 01:10:35 INFO - Copying logs to upload dir... 01:10:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.237647 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-08 01:10:35.063966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 01:10:35.067156) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 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-Inbound/sha512/75b36b77be76636bfd9fedf79b23f45a2a77c459b6571cea6f3a3b6424e20e0109a12a9867168978da6ef9cfc17d51b786acbe963296725fda12a95af8549756", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/344f932d0134fb34ee9b2f5b1aa2ac5caeddcb8727e692f89858f3480af8573aa769cd6fef5bbb331d39b76417c8f6e611072ba230821fddc45e2f5a98030437"} build_url:https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/UWYiO8-hTsWorXWVfK6MwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75b36b77be76636bfd9fedf79b23f45a2a77c459b6571cea6f3a3b6424e20e0109a12a9867168978da6ef9cfc17d51b786acbe963296725fda12a95af8549756", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/344f932d0134fb34ee9b2f5b1aa2ac5caeddcb8727e692f89858f3480af8573aa769cd6fef5bbb331d39b76417c8f6e611072ba230821fddc45e2f5a98030437"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 01:10:35.091649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:10:35.091980) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452242331.673186-1284164191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:10:35.177564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 01:10:35.177881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 01:10:35.178165) ========= ========= Total master_lag: 0.24 =========