builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1451389649.1 results: success (0) buildid: 20151229013004 builduid: 1b53497eec0a45b19c6d4f697c5279cd revision: 31c27281f5184efd1ed58c892bc77a518536566d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.102824) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.103328) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.103609) ========= 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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.128714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.129150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.144636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.145013) ========= 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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.193948) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.194246) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.194613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.194887) ========= 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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 03:47:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2015-12-29 03:47:29 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.379281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.379600) ========= 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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014806 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.429289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.429703) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 31c27281f5184efd1ed58c892bc77a518536566d --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 31c27281f5184efd1ed58c892bc77a518536566d --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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 03:47:29,855 truncating revision to first 12 chars 2015-12-29 03:47:29,855 Setting DEBUG logging. 2015-12-29 03:47:29,855 attempt 1/10 2015-12-29 03:47:29,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/31c27281f518?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 03:47:30,081 unpacking tar archive at: mozilla-inbound-31c27281f518/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.953446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.953812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.963957) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.964319) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.964800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-29 03:47:29.965111) ========= /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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:30 INFO - MultiFileLogger online at 20151229 03:47:30 in /builds/slave/test-pgo 03:47:30 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 03:47:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:47:30 INFO - {'append_to_log': False, 03:47:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:47:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:47:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:47:30 INFO - 'branch': 'Mozilla-Inbound', 03:47:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:30 INFO - 'config_files': ('talos/linux_config.py',), 03:47:30 INFO - 'default_actions': ('clobber', 03:47:30 INFO - 'read-buildbot-config', 03:47:30 INFO - 'download-and-extract', 03:47:30 INFO - 'populate-webroot', 03:47:30 INFO - 'create-virtualenv', 03:47:30 INFO - 'install', 03:47:30 INFO - 'run-tests'), 03:47:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:30 INFO - 'download_minidump_stackwalk': True, 03:47:30 INFO - 'download_symbols': 'ondemand', 03:47:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:30 INFO - 'installer_path': 'installer.exe', 03:47:30 INFO - 'log_level': 'info', 03:47:30 INFO - 'log_name': 'talos', 03:47:30 INFO - 'log_to_console': True, 03:47:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:30 INFO - 'opt_config_files': (), 03:47:30 INFO - 'pip_index': False, 03:47:30 INFO - 'sps_profile': False, 03:47:30 INFO - 'sps_profile_interval': 0, 03:47:30 INFO - 'suite': 'dromaeojs-e10s', 03:47:30 INFO - 'system_bits': '32', 03:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:30 INFO - 'title': 'talos-linux64-ix-047', 03:47:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:30 INFO - 'use_talos_json': True, 03:47:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:47:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:30 INFO - 'work_dir': 'build'} 03:47:30 INFO - ##### 03:47:30 INFO - ##### Running clobber step. 03:47:30 INFO - ##### 03:47:30 INFO - Running pre-action listener: _resource_record_pre_action 03:47:30 INFO - Running main action method: clobber 03:47:30 INFO - rmtree: /builds/slave/test-pgo/build 03:47:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:47:30 INFO - Running post-action listener: _resource_record_post_action 03:47:30 INFO - ##### 03:47:30 INFO - ##### Running read-buildbot-config step. 03:47:30 INFO - ##### 03:47:30 INFO - Running pre-action listener: _resource_record_pre_action 03:47:30 INFO - Running main action method: read_buildbot_config 03:47:30 INFO - Using buildbot properties: 03:47:30 INFO - { 03:47:30 INFO - "project": "", 03:47:30 INFO - "product": "firefox", 03:47:30 INFO - "script_repo_revision": "production", 03:47:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:47:30 INFO - "repository": "", 03:47:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:47:30 INFO - "buildid": "20151229013004", 03:47:30 INFO - "pgo_build": "True", 03:47:30 INFO - "basedir": "/builds/slave/test-pgo", 03:47:30 INFO - "buildnumber": 271, 03:47:30 INFO - "slavename": "talos-linux64-ix-047", 03:47:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:47:30 INFO - "platform": "ubuntu64_hw", 03:47:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:47:30 INFO - "branch": "mozilla-inbound", 03:47:30 INFO - "repo_path": "integration/mozilla-inbound", 03:47:30 INFO - "revision": "31c27281f5184efd1ed58c892bc77a518536566d", 03:47:30 INFO - "stage_platform": "linux64-pgo", 03:47:30 INFO - "builduid": "1b53497eec0a45b19c6d4f697c5279cd", 03:47:30 INFO - "slavebuilddir": "test" 03:47:30 INFO - } 03:47:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:47:30 INFO - Running post-action listener: _resource_record_post_action 03:47:30 INFO - ##### 03:47:30 INFO - ##### Running download-and-extract step. 03:47:30 INFO - ##### 03:47:30 INFO - Running pre-action listener: _resource_record_pre_action 03:47:30 INFO - Running main action method: download_and_extract 03:47:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:47:30 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')]} 03:47:30 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json 03:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json 03:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:47:33 INFO - Downloaded 1302 bytes. 03:47:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:47:33 INFO - Using the following test package requirements: 03:47:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:47:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'jsshell-linux-x86_64.zip'], 03:47:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:47:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:47:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:47:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:47:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:47:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:47:33 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')]} 03:47:33 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:45 INFO - Downloaded 23199705 bytes. 03:47:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:47:47 INFO - Return code: 0 03:47:47 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 03:47: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')]} 03:47:47 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:48 INFO - Downloaded 23199705 bytes. 03:47:48 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 03:47:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:48 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 03:47:49 INFO - Return code: 0 03:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:49 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:50 INFO - Downloaded 11132270 bytes. 03:47:50 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 03:47:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:50 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 03:47:50 INFO - Return code: 0 03:47: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')]} 03:47:50 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:52 INFO - Downloaded 54906192 bytes. 03:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:52 INFO - mkdir: /builds/slave/test-pgo/properties 03:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:47:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:47:52 INFO - Contents: 03:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:52 INFO - Running post-action listener: _resource_record_post_action 03:47:52 INFO - Running post-action listener: set_extra_try_arguments 03:47:52 INFO - ##### 03:47:52 INFO - ##### Running populate-webroot step. 03:47:52 INFO - ##### 03:47:52 INFO - Running pre-action listener: _resource_record_pre_action 03:47:52 INFO - Running main action method: populate_webroot 03:47:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:52 INFO - '--tppagecycles', 03:47:52 INFO - '7'], 03:47:52 INFO - 'tests': ['tsvgm']}}, 03:47:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:47:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'tests': ['damp', 'tps']}, 03:47:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['damp', 'tps']}, 03:47:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:47:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:52 INFO - 'other': {'tests': ['a11yr', 03:47:52 INFO - 'ts_paint', 03:47:52 INFO - 'tpaint', 03:47:52 INFO - 'sessionrestore', 03:47:52 INFO - 'sessionrestore_no_auto_restore']}, 03:47:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['a11yr', 03:47:52 INFO - 'ts_paint', 03:47:52 INFO - 'tpaint', 03:47:52 INFO - 'sessionrestore', 03:47:52 INFO - 'sessionrestore_no_auto_restore']}, 03:47:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['a11yr', 03:47:52 INFO - 'ts_paint', 03:47:52 INFO - 'tpaint', 03:47:52 INFO - 'sessionrestore', 03:47:52 INFO - 'sessionrestore_no_auto_restore']}, 03:47:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['a11yr', 03:47:52 INFO - 'ts_paint', 03:47:52 INFO - 'tpaint', 03:47:52 INFO - 'sessionrestore', 03:47:52 INFO - 'sessionrestore_no_auto_restore']}, 03:47:52 INFO - 'other_l64': {'tests': ['a11yr', 03:47:52 INFO - 'ts_paint', 03:47:52 INFO - 'tpaint', 03:47:52 INFO - 'sessionrestore', 03:47:52 INFO - 'sessionrestore_no_auto_restore']}, 03:47:52 INFO - 'other_nol64': {'tests': ['a11yr', 03:47:52 INFO - 'ts_paint', 03:47:52 INFO - 'tpaint', 03:47:52 INFO - 'sessionrestore', 03:47:52 INFO - 'sessionrestore_no_auto_restore']}, 03:47:52 INFO - 'svgr': {'tests': ['tsvgx', 03:47:52 INFO - 'tsvgr_opacity', 03:47:52 INFO - 'tart', 03:47:52 INFO - 'tscrollx', 03:47:52 INFO - 'cart']}, 03:47:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['tsvgx', 03:47:52 INFO - 'tsvgr_opacity', 03:47:52 INFO - 'tart', 03:47:52 INFO - 'tscrollx', 03:47:52 INFO - 'cart']}, 03:47:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'tests': ['tp5o']}, 03:47:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'talos_options': ['--e10s'], 03:47:52 INFO - 'tests': ['tp5o']}, 03:47:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'talos_options': ['--xperf_path', 03:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:52 INFO - 'tests': ['tp5n']}, 03:47:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:52 INFO - 'talos_options': ['--e10s', 03:47:52 INFO - '--xperf_path', 03:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:52 INFO - 'tests': ['tp5n']}}, 03:47:52 INFO - 'talos.zip': {'path': '', 03:47:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:52 INFO - Running post-action listener: _resource_record_post_action 03:47:52 INFO - ##### 03:47:52 INFO - ##### Running create-virtualenv step. 03:47:52 INFO - ##### 03:47:52 INFO - Running pre-action listener: _resource_record_pre_action 03:47:52 INFO - Running main action method: create_virtualenv 03:47:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:47:52 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 03:47:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:47:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:52 INFO - Using real prefix '/usr' 03:47:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:47:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:55 INFO - Installing pip.................done. 03:47:55 INFO - Return code: 0 03:47:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:47:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:47:55 INFO - Using env: {'DISPLAY': ':0', 03:47:55 INFO - 'HOME': '/home/cltbld', 03:47:55 INFO - 'LANG': 'en_US.UTF-8', 03:47:55 INFO - 'LANGUAGE': 'en_US:en', 03:47:55 INFO - 'LOGNAME': 'cltbld', 03:47:55 INFO - 'MAIL': '/var/mail/cltbld', 03:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:55 INFO - 'MOZ_NO_REMOTE': '1', 03:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:55 INFO - 'NO_EM_RESTART': '1', 03:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:55 INFO - 'SHELL': '/bin/bash', 03:47:55 INFO - 'SHLVL': '1', 03:47:55 INFO - 'TERM': 'linux', 03:47:55 INFO - 'TMOUT': '86400', 03:47:55 INFO - 'USER': 'cltbld', 03:47:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:55 INFO - '_': '/tools/buildbot/bin/python'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 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 03:47:55 INFO - Cleaning up... 03:47:55 INFO - Return code: 0 03:47:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:47:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:47:55 INFO - Using env: {'DISPLAY': ':0', 03:47:55 INFO - 'HOME': '/home/cltbld', 03:47:55 INFO - 'LANG': 'en_US.UTF-8', 03:47:55 INFO - 'LANGUAGE': 'en_US:en', 03:47:55 INFO - 'LOGNAME': 'cltbld', 03:47:55 INFO - 'MAIL': '/var/mail/cltbld', 03:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:55 INFO - 'MOZ_NO_REMOTE': '1', 03:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:55 INFO - 'NO_EM_RESTART': '1', 03:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:55 INFO - 'SHELL': '/bin/bash', 03:47:55 INFO - 'SHLVL': '1', 03:47:55 INFO - 'TERM': 'linux', 03:47:55 INFO - 'TMOUT': '86400', 03:47:55 INFO - 'USER': 'cltbld', 03:47:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:55 INFO - '_': '/tools/buildbot/bin/python'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 INFO - Downloading/unpacking psutil>=0.7.1 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:57 INFO - Installing collected packages: psutil 03:47:57 INFO - Running setup.py install for psutil 03:47:57 INFO - building 'psutil._psutil_linux' extension 03:47:57 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 03:47:57 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 03:47:57 INFO - building 'psutil._psutil_posix' extension 03:47:57 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 03:47:57 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 03:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:57 INFO - Successfully installed psutil 03:47:57 INFO - Cleaning up... 03:47:58 INFO - Return code: 0 03:47:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:47:58 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')]} 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:58 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')]} 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:58 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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:47:58 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 03:47:58 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 03:47:58 INFO - Using env: {'DISPLAY': ':0', 03:47:58 INFO - 'HOME': '/home/cltbld', 03:47:58 INFO - 'LANG': 'en_US.UTF-8', 03:47:58 INFO - 'LANGUAGE': 'en_US:en', 03:47:58 INFO - 'LOGNAME': 'cltbld', 03:47:58 INFO - 'MAIL': '/var/mail/cltbld', 03:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:58 INFO - 'MOZ_NO_REMOTE': '1', 03:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:58 INFO - 'NO_EM_RESTART': '1', 03:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:58 INFO - 'SHELL': '/bin/bash', 03:47:58 INFO - 'SHLVL': '1', 03:47:58 INFO - 'TERM': 'linux', 03:47:58 INFO - 'TMOUT': '86400', 03:47:58 INFO - 'USER': 'cltbld', 03:47:58 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:58 INFO - '_': '/tools/buildbot/bin/python'} 03:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:47:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:59 INFO - Installing collected packages: mozsystemmonitor 03:47:59 INFO - Running setup.py install for mozsystemmonitor 03:48:00 INFO - Successfully installed mozsystemmonitor 03:48:00 INFO - Cleaning up... 03:48:00 INFO - Return code: 0 03:48:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:48:00 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')]} 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:00 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')]} 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:00 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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:48:00 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 03:48:00 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 03:48:00 INFO - Using env: {'DISPLAY': ':0', 03:48:00 INFO - 'HOME': '/home/cltbld', 03:48:00 INFO - 'LANG': 'en_US.UTF-8', 03:48:00 INFO - 'LANGUAGE': 'en_US:en', 03:48:00 INFO - 'LOGNAME': 'cltbld', 03:48:00 INFO - 'MAIL': '/var/mail/cltbld', 03:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:00 INFO - 'MOZ_NO_REMOTE': '1', 03:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:00 INFO - 'NO_EM_RESTART': '1', 03:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:00 INFO - 'SHELL': '/bin/bash', 03:48:00 INFO - 'SHLVL': '1', 03:48:00 INFO - 'TERM': 'linux', 03:48:00 INFO - 'TMOUT': '86400', 03:48:00 INFO - 'USER': 'cltbld', 03:48:00 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:00 INFO - '_': '/tools/buildbot/bin/python'} 03:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:48:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:48:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - Downloading docopt-0.6.1.tar.gz 03:48:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:48:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:02 INFO - Running setup.py install for blobuploader 03:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:48:02 INFO - Running setup.py install for requests 03:48:03 INFO - Running setup.py install for docopt 03:48:03 INFO - Successfully installed blobuploader requests docopt 03:48:03 INFO - Cleaning up... 03:48:03 INFO - Return code: 0 03:48:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:03 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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:48:03 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 03:48:03 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 03:48:03 INFO - Using env: {'DISPLAY': ':0', 03:48:03 INFO - 'HOME': '/home/cltbld', 03:48:03 INFO - 'LANG': 'en_US.UTF-8', 03:48:03 INFO - 'LANGUAGE': 'en_US:en', 03:48:03 INFO - 'LOGNAME': 'cltbld', 03:48:03 INFO - 'MAIL': '/var/mail/cltbld', 03:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:03 INFO - 'MOZ_NO_REMOTE': '1', 03:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:03 INFO - 'NO_EM_RESTART': '1', 03:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:03 INFO - 'SHELL': '/bin/bash', 03:48:03 INFO - 'SHLVL': '1', 03:48:03 INFO - 'TERM': 'linux', 03:48:03 INFO - 'TMOUT': '86400', 03:48:03 INFO - 'USER': 'cltbld', 03:48:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:03 INFO - '_': '/tools/buildbot/bin/python'} 03:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:03 INFO - Running setup.py (path:/tmp/pip-3HkfG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:03 INFO - Running setup.py (path:/tmp/pip-hZ0PjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:03 INFO - Running setup.py (path:/tmp/pip-I0LiaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:03 INFO - Running setup.py (path:/tmp/pip-zrYzXK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:03 INFO - Running setup.py (path:/tmp/pip-YpjfU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:03 INFO - Running setup.py (path:/tmp/pip-GAL9HM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:03 INFO - Running setup.py (path:/tmp/pip-CcmUxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:03 INFO - Running setup.py (path:/tmp/pip-ygM0pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:04 INFO - Running setup.py (path:/tmp/pip-MvX6yh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:04 INFO - Running setup.py (path:/tmp/pip-9Bx_OE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:04 INFO - Running setup.py (path:/tmp/pip-al8SPh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:04 INFO - Running setup.py (path:/tmp/pip-uZ4i2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:04 INFO - Running setup.py (path:/tmp/pip-47ifYu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:04 INFO - Running setup.py (path:/tmp/pip-ac7PZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:04 INFO - Running setup.py (path:/tmp/pip-8_y9xu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:04 INFO - Running setup.py (path:/tmp/pip-fLxRMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:04 INFO - Running setup.py (path:/tmp/pip-5jrArX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:04 INFO - Running setup.py install for manifestparser 03:48:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozcrash 03:48:04 INFO - Running setup.py install for mozdebug 03:48:04 INFO - Running setup.py install for mozdevice 03:48:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozfile 03:48:05 INFO - Running setup.py install for mozhttpd 03:48:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozinfo 03:48:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozInstall 03:48:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozleak 03:48:05 INFO - Running setup.py install for mozlog 03:48:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for moznetwork 03:48:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozprocess 03:48:05 INFO - Running setup.py install for mozprofile 03:48:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:48:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:48:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:48:06 INFO - Running setup.py install for mozrunner 03:48:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:48:06 INFO - Running setup.py install for mozscreenshot 03:48:06 INFO - Running setup.py install for moztest 03:48:06 INFO - Running setup.py install for mozversion 03:48:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:48:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:06 INFO - Cleaning up... 03:48:06 INFO - Return code: 0 03:48:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:06 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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:48:06 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 03:48:06 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 03:48:06 INFO - Using env: {'DISPLAY': ':0', 03:48:06 INFO - 'HOME': '/home/cltbld', 03:48:06 INFO - 'LANG': 'en_US.UTF-8', 03:48:06 INFO - 'LANGUAGE': 'en_US:en', 03:48:06 INFO - 'LOGNAME': 'cltbld', 03:48:06 INFO - 'MAIL': '/var/mail/cltbld', 03:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:06 INFO - 'MOZ_NO_REMOTE': '1', 03:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:06 INFO - 'NO_EM_RESTART': '1', 03:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:06 INFO - 'SHELL': '/bin/bash', 03:48:06 INFO - 'SHLVL': '1', 03:48:06 INFO - 'TERM': 'linux', 03:48:06 INFO - 'TMOUT': '86400', 03:48:06 INFO - 'USER': 'cltbld', 03:48:06 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:06 INFO - '_': '/tools/buildbot/bin/python'} 03:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:06 INFO - Running setup.py (path:/tmp/pip-4gDyFF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:06 INFO - Running setup.py (path:/tmp/pip-Ba9Xrb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:06 INFO - Running setup.py (path:/tmp/pip-ELfAIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:06 INFO - Running setup.py (path:/tmp/pip-GGQ0ML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:06 INFO - Running setup.py (path:/tmp/pip-sukRO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:07 INFO - Running setup.py (path:/tmp/pip-x6qxvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:07 INFO - Running setup.py (path:/tmp/pip-Sp3Mzp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:07 INFO - Running setup.py (path:/tmp/pip-1IkPMi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:07 INFO - Running setup.py (path:/tmp/pip-sWAU3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:07 INFO - Running setup.py (path:/tmp/pip-uc92HG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:07 INFO - Running setup.py (path:/tmp/pip-dOdzbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:07 INFO - Running setup.py (path:/tmp/pip-_4e6X0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:07 INFO - Running setup.py (path:/tmp/pip-SKxofq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:07 INFO - Running setup.py (path:/tmp/pip-JdUwem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:07 INFO - Running setup.py (path:/tmp/pip-ATeA9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:07 INFO - Running setup.py (path:/tmp/pip-Z657o_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:07 INFO - Running setup.py (path:/tmp/pip-ydhxy2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:07 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 03:48:07 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 03:48:07 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 03:48:07 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 03:48:07 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 03:48:07 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 03:48:09 INFO - Downloading blessings-1.5.1.tar.gz 03:48:09 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 03:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:09 INFO - Installing collected packages: blessings 03:48:09 INFO - Running setup.py install for blessings 03:48:09 INFO - Successfully installed blessings 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:48:10 INFO - Reading from file tmpfile_stdout 03:48:10 INFO - Current package versions: 03:48:10 INFO - argparse == 1.2.1 03:48:10 INFO - blessings == 1.5.1 03:48:10 INFO - blobuploader == 1.2.4 03:48:10 INFO - docopt == 0.6.1 03:48:10 INFO - manifestparser == 1.1 03:48:10 INFO - mozInstall == 1.12 03:48:10 INFO - mozcrash == 0.16 03:48:10 INFO - mozdebug == 0.1 03:48:10 INFO - mozdevice == 0.47 03:48:10 INFO - mozfile == 1.2 03:48:10 INFO - mozhttpd == 0.7 03:48:10 INFO - mozinfo == 0.9 03:48:10 INFO - mozleak == 0.1 03:48:10 INFO - mozlog == 3.1 03:48:10 INFO - moznetwork == 0.27 03:48:10 INFO - mozprocess == 0.22 03:48:10 INFO - mozprofile == 0.28 03:48:10 INFO - mozrunner == 6.11 03:48:10 INFO - mozscreenshot == 0.1 03:48:10 INFO - mozsystemmonitor == 0.0 03:48:10 INFO - moztest == 0.7 03:48:10 INFO - mozversion == 1.4 03:48:10 INFO - psutil == 3.1.1 03:48:10 INFO - requests == 1.2.3 03:48:10 INFO - wsgiref == 0.1.2 03:48:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:48:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 03:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 03:48:10 INFO - Using env: {'DISPLAY': ':0', 03:48:10 INFO - 'HOME': '/home/cltbld', 03:48:10 INFO - 'LANG': 'en_US.UTF-8', 03:48:10 INFO - 'LANGUAGE': 'en_US:en', 03:48:10 INFO - 'LOGNAME': 'cltbld', 03:48:10 INFO - 'MAIL': '/var/mail/cltbld', 03:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:10 INFO - 'MOZ_NO_REMOTE': '1', 03:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:10 INFO - 'NO_EM_RESTART': '1', 03:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:10 INFO - 'SHELL': '/bin/bash', 03:48:10 INFO - 'SHLVL': '1', 03:48:10 INFO - 'TERM': 'linux', 03:48:10 INFO - 'TMOUT': '86400', 03:48:10 INFO - 'USER': 'cltbld', 03:48:10 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:10 INFO - '_': '/tools/buildbot/bin/python'} 03:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 INFO - Cleaning up... 03:48:10 INFO - Return code: 0 03:48:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:48:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:10 INFO - Using env: {'DISPLAY': ':0', 03:48:10 INFO - 'HOME': '/home/cltbld', 03:48:10 INFO - 'LANG': 'en_US.UTF-8', 03:48:10 INFO - 'LANGUAGE': 'en_US:en', 03:48:10 INFO - 'LOGNAME': 'cltbld', 03:48:10 INFO - 'MAIL': '/var/mail/cltbld', 03:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:10 INFO - 'MOZ_NO_REMOTE': '1', 03:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:10 INFO - 'NO_EM_RESTART': '1', 03:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:10 INFO - 'SHELL': '/bin/bash', 03:48:10 INFO - 'SHLVL': '1', 03:48:10 INFO - 'TERM': 'linux', 03:48:10 INFO - 'TMOUT': '86400', 03:48:10 INFO - 'USER': 'cltbld', 03:48:10 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:10 INFO - '_': '/tools/buildbot/bin/python'} 03:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:10 INFO - Downloading/unpacking jsonschema 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:12 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 03:48:12 INFO - Downloading/unpacking functools32 (from jsonschema) 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:48:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:12 INFO - warning: no files found matching '*.txt' 03:48:12 INFO - no previously-included directories found matching 'build' 03:48:12 INFO - no previously-included directories found matching 'dist' 03:48:12 INFO - no previously-included directories found matching '.git*' 03:48:12 INFO - Installing collected packages: jsonschema, functools32 03:48:12 INFO - Running setup.py install for functools32 03:48:12 INFO - warning: no files found matching '*.txt' 03:48:12 INFO - no previously-included directories found matching 'build' 03:48:12 INFO - no previously-included directories found matching 'dist' 03:48:12 INFO - no previously-included directories found matching '.git*' 03:48:12 INFO - Successfully installed jsonschema functools32 03:48:12 INFO - Cleaning up... 03:48:12 INFO - Return code: 0 03:48:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:48:12 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')]} 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:12 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')]} 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:12 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 0x7fc85629af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, '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': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', '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 03:48:12 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 03:48:12 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 03:48:12 INFO - Using env: {'DISPLAY': ':0', 03:48:12 INFO - 'HOME': '/home/cltbld', 03:48:12 INFO - 'LANG': 'en_US.UTF-8', 03:48:12 INFO - 'LANGUAGE': 'en_US:en', 03:48:12 INFO - 'LOGNAME': 'cltbld', 03:48:12 INFO - 'MAIL': '/var/mail/cltbld', 03:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:12 INFO - 'MOZ_NO_REMOTE': '1', 03:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:12 INFO - 'NO_EM_RESTART': '1', 03:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:12 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:12 INFO - 'SHELL': '/bin/bash', 03:48:12 INFO - 'SHLVL': '1', 03:48:12 INFO - 'TERM': 'linux', 03:48:12 INFO - 'TMOUT': '86400', 03:48:12 INFO - 'USER': 'cltbld', 03:48:12 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:12 INFO - '_': '/tools/buildbot/bin/python'} 03:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:12 INFO - Downloading/unpacking flake8 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:48:14 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 03:48:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:48:14 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 03:48:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 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 03:48:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:48:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:15 INFO - no previously-included directories found matching 'docs/_build' 03:48:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:48:15 INFO - Running setup.py install for pep8 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:15 INFO - no previously-included directories found matching 'docs/_build' 03:48:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:48:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:48:15 INFO - Cleaning up... 03:48:15 INFO - Return code: 0 03:48:15 INFO - Running post-action listener: _resource_record_post_action 03:48:15 INFO - Running post-action listener: _start_resource_monitoring 03:48:15 INFO - Starting resource monitoring. 03:48:15 INFO - ##### 03:48:15 INFO - ##### Running install step. 03:48:15 INFO - ##### 03:48:15 INFO - Running pre-action listener: _resource_record_pre_action 03:48:15 INFO - Running main action method: install 03:48:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:48:15 INFO - Reading from file tmpfile_stdout 03:48:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:48:15 INFO - Reading from file tmpfile_stdout 03:48:15 INFO - Output received: 03:48:15 INFO - Usage: mozinstall [options] installer 03:48:15 INFO - Options: 03:48:15 INFO - -h, --help show this help message and exit 03:48:15 INFO - -d DEST, --destination=DEST 03:48:15 INFO - Directory to install application into. [default: 03:48:15 INFO - "/builds/slave/test-pgo"] 03:48:15 INFO - --app=APP Application being installed. [default: firefox] 03:48:15 INFO - mkdir: /builds/slave/test-pgo/build/application 03:48:15 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'] 03:48:15 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 03:48:31 INFO - Reading from file tmpfile_stdout 03:48:31 INFO - Output received: 03:48:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:48:31 INFO - Running post-action listener: _resource_record_post_action 03:48:31 INFO - ##### 03:48:31 INFO - ##### Running run-tests step. 03:48:31 INFO - ##### 03:48:31 INFO - Running pre-action listener: _resource_record_pre_action 03:48:31 INFO - Running main action method: run_tests 03:48:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:48:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:48:31 INFO - Python 2.7.3 03:48:31 INFO - Return code: 0 03:48:31 INFO - grabbing minidump binary from tooltool 03:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:31 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 0x2b0e7f0>, '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 0x2a7a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:48:31 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 03:48:31 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 03:48:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:31 INFO - Return code: 0 03:48:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:48:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:48:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:48:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:48:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:48:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:48:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:48:32 INFO - Return code: 0 03:48:32 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/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:48:32 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/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 03:48:32 INFO - Using env: {'DISPLAY': ':0', 03:48:32 INFO - 'HOME': '/home/cltbld', 03:48:32 INFO - 'LANG': 'en_US.UTF-8', 03:48:32 INFO - 'LANGUAGE': 'en_US:en', 03:48:32 INFO - 'LOGNAME': 'cltbld', 03:48:32 INFO - 'MAIL': '/var/mail/cltbld', 03:48:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:48:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:32 INFO - 'MOZ_NO_REMOTE': '1', 03:48:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:32 INFO - 'NO_EM_RESTART': '1', 03:48:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:48:32 INFO - 'SHELL': '/bin/bash', 03:48:32 INFO - 'SHLVL': '1', 03:48:32 INFO - 'TERM': 'linux', 03:48:32 INFO - 'TMOUT': '86400', 03:48:32 INFO - 'USER': 'cltbld', 03:48:32 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961', 03:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:32 INFO - '_': '/tools/buildbot/bin/python'} 03:48:32 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/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:48:32 INFO - mozversion application_buildid: 20151229013004 03:48:32 INFO - mozversion application_changeset: 31c27281f5184efd1ed58c892bc77a518536566d 03:48:32 INFO - mozversion application_display_name: Nightly 03:48:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:32 INFO - mozversion application_name: Firefox 03:48:32 INFO - mozversion application_remotingname: firefox 03:48:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:48:32 INFO - mozversion application_vendor: Mozilla 03:48:32 INFO - mozversion application_version: 46.0a1 03:48:32 INFO - mozversion platform_buildid: 20151229013004 03:48:32 INFO - mozversion platform_changeset: 31c27281f5184efd1ed58c892bc77a518536566d 03:48:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:48:32 INFO - mozversion platform_version: 46.0a1 03:48:32 INFO - using testdate: 1451389712 03:48:32 INFO - actual date: 1451389712 03:48:32 INFO - starting webserver on 'localhost:45945' 03:48:32 INFO - SUITE-START | Running 3 tests 03:48:32 INFO - TEST-START | dromaeo_css 03:48:32 INFO - operating with platform_type : linux_ 03:48:32 INFO - Initialising browser for dromaeo_css test... 03:48:32 INFO - TEST-INFO | started process 5325 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmlenIo/profile http://localhost:45945/getInfo.html) 03:48:37 INFO - PROCESS | 5325 | __metrics Screen width/height:1600/1200 03:48:37 INFO - PROCESS | 5325 | colorDepth:24 03:48:37 INFO - PROCESS | 5325 | Browser inner width/height: 1024/697 03:48:37 INFO - PROCESS | 5325 | __metrics 03:48:37 INFO - PROCESS | 5325 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:48:38 INFO - TEST-INFO | 5325: exit 0 03:48:38 INFO - Browser initialized. 03:48:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:38 INFO - TEST-INFO | started process 5458 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmlenIo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:50 INFO - PROCESS | 5458 | RSS: Main: 149299200 03:48:50 INFO - PROCESS | 5458 | 03:49:39 INFO - PROCESS | 5458 | 1451389779611 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] 03:51:49 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:45945/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45945/tests/dromaeo/cssquery-ext.html) 03:51:50 INFO - PROCESS | 5458 | RSS: Main: 154976256 03:51:50 INFO - PROCESS | 5458 | 03:54:52 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:45945/tests/dromaeo/cssquery-ext.html (next: http://localhost:45945/tests/dromaeo/cssquery-jquery.html) 03:54:52 INFO - PROCESS | 5458 | RSS: Main: 153083904 03:54:52 INFO - PROCESS | 5458 | 03:57:54 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:45945/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45945/tests/dromaeo/cssquery-mootools.html) 03:57:55 INFO - PROCESS | 5458 | RSS: Main: 153423872 03:57:55 INFO - PROCESS | 5458 | 04:00:56 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:45945/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45945/tests/dromaeo/cssquery-prototype.html) 04:00:57 INFO - PROCESS | 5458 | RSS: Main: 152084480 04:00:57 INFO - PROCESS | 5458 | 04:03:59 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:45945/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45945/tests/dromaeo/cssquery-yui.html) 04:04:00 INFO - PROCESS | 5458 | RSS: Main: 152301568 04:04:00 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:45945/tests/dromaeo/cssquery-yui.html (next: http://localhost:45945/tests/dromaeo/cssquery-dojo.html) 04:07:02 INFO - PROCESS | 5458 | RSS: Main: 155312128 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | __start_tp_report 04:07:02 INFO - PROCESS | 5458 | _x_x_mozilla_page_load 04:07:02 INFO - PROCESS | 5458 | _x_x_mozilla_page_load_details 04:07:02 INFO - PROCESS | 5458 | |i|pagename|runs| 04:07:02 INFO - PROCESS | 5458 | |0;dojo.html;3247.6589958054406;3275.4268003099464;3308.387948229576;3333.949990750139;3344.498325251212;5447.727613619323;5459.535939445147;5476.17857321401;5477.808276710316;5496.340439147303;5351.09031464651;5528.585356098289;5570.554355651549;5594.300712410949;5681.23303354047;4980.800767969277;4992.301077849104;4997.775100120485;5001.249812528114;5099;5021.949780502185;5071.239314102896;5079.187330027196;5088;5088.4148322942965;4932.235503496964;4998.075356059123;5000.449950505442;5002;5085.821996230115;5049.34358533392;5054.292399064134;5055.620828437845;5056.519630635084;5080.339555857752;4987.800487980477;5027.3464449621315;5039.244113382985;5043.319151914481;5060.74696265189;5297.020051290524;5336.066188417011;5399.433059528732;5411.945880541183;5494.532964698005;5904.61619994699;5905.763769449217;5909.556783241274;5913.763449462016;5928.614640048426;5936.584439089265;5941.8811623767715;5949.6727679977585;5960.374160713106;5963.582549221556;5530.668159910419;5593.552515798808;5621.297337832771;5621.325440947113;5656.519195868397;6143.266246520256;6178.1350610913605;6182.721777520022;6186.566940314135;6187.3503282155625;5871.3541510433815;5874.089516125007;5905.822825315247;5930.347661757203;5937.287525496968;5894.764209431661;5924.822255332347;5978.073398623221;6026.939730602638;6033.728482218311;5819.621724587888;5884.529237660977;5885.911711324334;5888.116782482662;5893.3222679391565;5796.536277097822;5869.706514674249;5877.206577112121;5879.853003674943;5882.823515294463;4530.388397566352;4566.88582785433;4605.631549476034;4618.907621847544;4645.74448405341;4003.039270575099;4006.4791577094793;4014.638682518529;4058.3303754880703;4067.349224124185;5455.61810673257;5517.834464966058;5518;5537.473939975695;5541.750621221974;5967.701614919323;5987.670678112746;6017.428344307284;6021.066734656135;6099.420555047263;5577.107662773937;5583.748731307101;5590.552755779528;5601.29983752031;5606.775728970877;5018.4981501849525;5047.419546752097;5113.64204505681;5127.025865085622;5130.050940576006;5911.822645320647;6025.879482410327;6027.638341699512;6037.818865434044;6038.909416358758;5855.970720146543;5867.5305975521005;5882.558808089325;5895.734691938959;5966.49284810796;6161.392058738642;6185.84535386619;6231.688415579112;6232.345603711727;6239.656818875005;5922.51729347219;5966;5993.220881285405;6000.609960352563;6053.697315134137;5817.592768506164;5881.17663527098;5898.882022359443;5912.970435147797;5967.313758917607;5780.450857168562;5820.76716931318;5822.650640961556;5825.097109947965;5846.503047240862;5767.3367562729145;5822;5824.95150872847;5825.621334613236;5829.300483941955;5652.095664693629;5695.629784064023;5735.025045742151;5735.655860648374;5831.387704291158;5833.891560603472;5853.590248682552;5867.6772777497645;5879.559033072451;5896.941030589639;5709.7145142741865;5725.8568535786935;5735.942640573541;5736.856578585569;5765.135229715576 04:07:02 INFO - PROCESS | 5458 | |1;ext.html;538.3002097273543;540.9242706021157;565.5193085877003;565.790657456741;572.8711040015997;34236.31527369451;35160.824195879046;35224.119397015085;35262.1184470388;35310.823445882765;38763.61236387635;39301.60698393015;39372.21255574887;39385;39614.603853961526;8424.115467875861;8551.700690475835;8564.957175214146;8576.142385761435;8577.871331930026;8459.957700211491;8541.743747687578;8577.442466239705;8712.825743485126;8754.737357879241;8741.30069594431;8778.2099611035;8807.251383632367;8845.734627961172;8852.468851868876;8597.785055373603;8644.049154592989;8662.393632445732;8714.128587141298;8750.86873696895;8523.232909038154;8630.223279904776;8633.309335253227;8633.870491942625;8639.827203455958;38489.615103849166;38938.80530597329;38991.61008389908;39000.219995600215;39036.41445378322;2445.5720248956363;2547.503725782418;2784.081253186464;2973.55396690496;3338.7162091222276;28268.858655706794;28307.433851322858;28716.712832871614;28762.712372876213;29182.854085729647;3870.574236833946;3878.728489005771;3893.3965235388278;3993.341098718708;4060.7766572838777;221599;222188.99999999837;222673.88663056743;223499;223715;52916.470835291155;53785.731071344395;54588.72705636446;61120;61650.38349616446;54189.72905135528;54270.185947210826;54383.72808135934;54628.72685636626;54701.179482307794;14897.404103835943;14999.925000374928;15075.170865602278;15219.923900380649;15236.771448428282;11134.109271258441;11139;11203.71990700239;11307.434628268553;11432.657020289405;19529.707054394195;20463.4884127898;20527.79472205259;20556.691649625267;20641.587168256552;7921.722739704198;8068.193180682002;8123.187681231948;8169.79575510617;8224.259816616533;918.196577994255;924.6624981881565;1034.6275340877278;1068.2255364860414;1105.662772854271;24918.875405622857;26270;26851.328716781845;27407.588886166723;27532.449351012867;1038.7974345002804;1087.6791346552786;1098.0392156862745;1127.610974213895;1216.1486959128645;14820.92589537067;15123.860493445047;15637.139957302457;15861;15904;352711;356507;357907;359038;359516;53409.73295133577;53901.1914821278;54153.45846541563;54186.45813541893;54342.18486722702;1383.2253937794867;1388.3544151969384;1396.406527225925;1400.852910444409;1404.206623257856;29052.854735727033;30280.394392112474;30323.848380757954;30908.536371954888;30930.047972524662;45362.09275814399;45469.45305469426;45722.77138614419;45729.08541829211;45809.541904580525;228491;230037;232412;232751;233452;38820.80589597034;42157.77893149374;43179.35230971475;43397.26410943653;43432.565674342855;38165.80917095508;38395.23209535738;38522.22955540929;38606.6139338603;38889.805550972065;32315.35369292554;32553.34893302168;32927.67072329246;33190;33205.83397082999;33097;33155.83422082874;33923.49114763231;34022.48966265558;34041.48937765985;32439;32728.34543309073;32976;35714.28571428505;35961.82019089888;30987.690123099383;32244.19389515281;32519.837400812845;32908.83545582257;33101.66898330986;24841.25476235716;25200.873995630638;25338.87330563409;25361.483942082854;25362 04:07:02 INFO - PROCESS | 5458 | |2;jquery.html;351.8170551313317;356.2785359646717;357.7656634904139;360.8700867687632;361.9457081437784;16322.755158672615;16429.917850410748;17057.23242454091;17588.560285992855;18217.453476395694;13936.44254229832;15607.141607211599;15830.683386332266;15833.841661583381;16145.192740362963;4837.927431088528;4906.31311616374;4924.482929292427;4939.53074457926;4940.827071052514;4886.242632391985;4901.362822833044;4907.2884431757375;4907.82822601209;4913.238448040542;4781.832635857746;4906.31311616374;4989.101961646902;5169.043726910515;5194.117000109972;4925.458199598042;5062.012907483024;5074.4671809460215;5107.080725469414;5111.718855462948;4922.409310882717;4962.082014827269;4964.379452568429;4979.427365852937;4984.725840078794;18344.082795860155;18400.263989440406;18712.438626841216;18889.149988250563;18989.810101898944;661.2726001398471;1281.6734679606564;2126.9896799020344;2157.524055153246;2258.2999270226283;9148.634054637807;9160.8625870612;9503.667371642028;11782.351970641612;12472.43874025671;1745.729411941151;1813.3925135079764;1824.5165031266724;1831.880927739706;1832.3769918227867;60047.399526004614;60564.69717651427;60659.393406065814;60707;62907.68546157286;9931.255155863339;10003.349782264275;10005.749856253651;10006.399616023062;10013;12693.936530317289;12780.680482988;12808.039397045259;12830.16603920742;12841.93579032099;7002.229754726976;7382.926170738331;7547.547147171187;7611.695532178651;7632.542047477169;7562.319391254813;7602.885956710654;7613.5431874087735;7639.465237433437;7650.31147196755;4203.159368126387;4264.168487145039;4312.741235525878;4333.891652708645;4345.196138714348;1768.32803534656;1779.3772179736989;1826.159966415437;1826.4246762269843;1837.7702787151607;772.142921357293;782.7143092771212;793.4683761879439;817.8159914019298;840.3193413335096;14933.925330373278;15111.924440377728;15427.5371738848;15520.767188492182;15663.68672626564;845.7970087179033;876.7895705030746;882.1046637662778;885.5660726244093;888.4136469929815;8972.237359824358;9689.27330450219;10022.849657255147;10094.596216151273;10163.796724065478;478338;500230;504850;519083;564990;79297.60351198322;81841.59079204685;81946.18053819505;82109.58945205355;82807.5859620698;1104.4532956186738;1110.8833572474934;1122.1303489795312;1124.5670416889557;1131.3890499130378;14673.486427974969;15484.5354639361;15719.449819256271;15735.685286293981;15835.287412066715;31561.21096972594;31850.681493184773;32360;32697.509537356484;33192.668073319925;36064.63935360613;44502.77748611236;45466.31800523061;45635;46045.76977115093;9143.954280228556;9341.626334946526;9405.623775048922;9462.053794620482;9476.763080923032;16410.835891641407;16827.663446730752;16994.575135621708;17083.31666733317;17297;13690.794638080237;14018.228997404833;14417.567472975827;14479.855201448272;14547.709045818812;13748.106373085717;13981.23103229332;14091.788623170865;14118.152910825384;14465.49370772018;14010.509632162826;14060.367283472473;14189.148651080968;14201.644958876112;14374.856251437352;8984.23633991092;9156.542172891195;9277.118673725985;9294.674686385944;9364.016778238187;11170.832437513282;13807.792883106962;13976.510822121178;13988.510402135877;14143.717125657635 04:07:02 INFO - PROCESS | 5458 | |3;mootools.html;1470.2281302316285;1485.1608841004834;1646.135778716174;1761.7357396390548;1787.2940188625485;6924.4806639501985;6984.615846128461;7596.848063038736;7785.844283114335;7799.181085985975;7434.107907051161;7493;7586.279303466162;7610.315071643551;7615.276548727876;2285.70285862838;2308.572914010905;2323.8838058097112;2325.616273314901;2328.8486248393883;2311.976880231193;2342.2504798464497;2367.183321753992;2368.7275963264187;2371.5256948610263;2281.418238349227;2289.7939185473306;2312.063614236237;2320.6170981787986;2324;2247;2251.459649684064;2260.333201705501;2262.6266666000006;2272.534130503251;2300.18343488061;2327.755585663515;2333.125078095714;2337.6960995070704;2342.8711420871846;7564;7593.430492713069;7594.8481030379635;7625.771226863203;7627.466077374586;4541;4606.447226332828;4607.976960115211;4610.585047345755;4614.5385461453925;2874.3245337345707;2891.089306868351;2976.1666733314705;2995.400919816024;3023.486007378751;920.5259291464901;920.6041402197053;943.8112377524454;956.9330146889721;965.4110992294694;9833.213342932548;9890.554925028318;9925.801483970281;9943.950280248624;9950.054744799232;4323.481182258086;4327.1345730853955;4331.956680433218;4372.737635741865;4401.625861801719;8603.139686031473;8681.218690317775;8692.608832602547;8697.782555436164;8702.086280940537;4634.97682511592;4636.814527418933;4656.138614356355;4657.231556793091;4671.719696818202;4230.682698797603;4274.273373526508;4356.455443069616;4403.295472724349;4414.558544145624;3562.87529936451;3580.534530511017;3608.7654302470255;3621.6559426854406;3628.346897558412;1114.3815182573749;1117.1007339091946;1117.5529788084668;1126.4592995362273;1132.0660455124391;1003.7741508160606;1016.049993256293;1018.9861088217272;1133.3709791066037;1299.590628951896;7059.435245180476;7158.105236845395;7159.069320988238;7159.534630249017;7172.13934327884;494.5400777277095;496.5927939089984;503.3029254482568;507.31259143860274;508.29347207381767;5239.633225674243;5241.68549887008;5244.816431424882;5288.762005709752;5313.44208858072;9174.954125229331;9189.218916392048;9443.480608566595;9516.762080948032;9541.618335266512;9286.67496637628;9290.74574932389;9335.486548239776;9413.19987801031;9433.764155896157;7235.131784185826;7305.817354566178;7333.88999165013;7367.852642947111;7373.88939165913;6961.199462061928;6976.476764242803;7002.3697867192195;7018.33325834045;7020.7893763187185;8310.293625041697;8395.118512556093;8399.118092600189;8453.027901791373;8514.148585141436;8273.875891861506;8300.169983001651;8334.291585215324;8345.582720863811;8390.916090839013;6627.867442651216;6770.424513916372;6853.520253582202;6880.58716477013;6915.066466027022;7386.482946193715;7470.775876723707;7472.29013243741;7497.175310715707;7521.5111017783665;6684.899726504009;6741.797746067626;6806.523543351917;6905.896411553931;6989.685464154024;6685.197776266685;6756.189257289157;6803.319668033157;6903.206131294965;6947.305269473012;6799.490038247052;6859.862802744017;6871.587704737732;6892.104026476526;6913.5506192097355;6302.873942521215;6305.842353941188;6353.936460635335;6363.490920726238;6364.045393190873;6464.806055818333;6490.740370385321;6495.967520162369;6510.934890651033;6548.246951600627 04:07:02 INFO - PROCESS | 5458 | |4;prototype.html;332.9400707872583;337.9860418743769;342.3204938197679;343.94152993991025;345.9308138372326;6202.472789812871;6307.274663413708;6309.77915772948;6334.461570766491;6335.873282534347;6114.327423983369;6222.7199776010075;6237.126802247689;6281.43467087962;6288.968555157229;4779.617630589553;4787.760611969405;4789.161896668086;4798.736069516175;4806.951930480685;4786.808527658889;4791.856244312658;4799.952000480003;4802.111609352263;4823.445303790074;4649.814007439699;4761.381020467335;4766.666333356667;4768.332433459318;4785.712857228577;4741.407324084489;4745.454272758625;4745.905081898377;4753.33453316536;4773.474917759044;4061.97969010156;4133.565975572582;4137.13120244749;4151.398047283157;4153.003279212998;5953.958057339992;5971.701414929236;5975.1037344398255;5980.073088671263;5993.820185394445;5580.637258578179;5596.496315331639;5605.327360716699;5617.269754931874;5618.803341883015;6579.868402631921;6688.83277918051;6721.26066132725;6724.092247546617;6730.360615741497;4597.011642496879;4638.2115040443205;4656.883577910546;4663.134746101553;4666.043461090502;6948.235694073648;6976.686049127852;6984.650767461607;6992.440604751659;7028.859422811566;4816.988432429159;4837.758112094381;4841.878953026203;4846.321514987904;4848.660593758474;4811.855644330676;4906.313116163668;4919.385076865392;4919.794650310697;4936.777844996984;5652.3217213934595;5655.1799989001365;5663.490285874209;5666.433356664383;5679.829605111853;6722.731090756412;6779.898301525481;6783.118194634666;6786.491013174032;6787.830304242433;1682.503661419884;1697.4822679082997;1714.3057061889954;1716.605180808421;1717.1328479117965;1119.3060302612432;1131.298594871185;1138.9202755807014;1139.732162941708;1165.1901928159848;6323.462505687068;6330.620162790247;6343.55595108338;6372.426481616584;6380.776672816429;6917.481188910851;6924.688389022506;6925.3074692530345;6927.930720692729;6945.652717364112;6183.536234782409;6249.500039996789;6256.717372938537;6293.842653933688;6324.810255692337;3718.4980027696456;3725.720570957135;3752.493413389212;3754.249150169977;3755.830987605564;7030.015797788314;7153.284671532805;7179.210286868441;7187.712491500281;7213.4589905757275;7106.111736032996;7119.89320160198;7122.038524799086;7145.785626431215;7149.92850071503;6961.199462061826;7222.494425390278;7222.819429514199;7223.566586004857;7226.74706385274;6962.338577835098;6982.720691172296;6985.96507017482;6987.301269873175;7000.229974702676;6899.310068993061;6934.514583979275;6936;6944.826379340355;6946.826329341807;7094.148702155774;7191;7222.96388518054;7234.6020968847215;7249.05762250904;4554.20301447252;4644.164050470813;4644.187267228154;4646.558576935186;4655.185342565105;7003.54476958996;7015.263397343206;7021.368076873106;7021.754238601625;7021.789346319619;6655.068290439439;6790.083338749403;6791.89812152828;6807.455403567802;6809.455243580601;6733.091032710521;6780.966095169492;6787.321267873173;6788.728450862108;6789.72841086351;6639.3692599203;6669.7332106715185;6680.63256520896;6684.866302674017;6690.19717633887;6674.866502670016;6788.86422271542;6817.079694241214;6822.635472905339;6835.14560679915;6620.8344791380605;6649.667516624053;6660;6661.16735408074;6664.166979127609 04:07:02 INFO - PROCESS | 5458 | |5;yui.html;549.2118809508358;555.4306835493619;571.6227289988608;658.3416583416583;663.2770280394369;12182.573609923644;12206;12226.205296655711;12337.074719396047;12348.320842353667;10956.945215273912;11167.329960202394;11201;11236.775264494705;11256.38089905055;688.0951548713451;689.4208864553774;805.6012273924416;816.3102178659053;818.2186012358213;811.350919264586;811.4765975945512;818;818.7789296889836;819.2258315891455;858.4977787994031;862.374778285741;862.8015556422026;863.9092895246002;864.2653744317342;851.1743608699583;855.7732200966686;859.1623167411786;859.3340161374922;859.7248880358288;625.1217040058725;633.8415396150963;636.0268788753215;636.4494712074069;638.0620487882804;11417.771644567061;11424.485898134604;11457.36984465854;11485.19603627738;11523.42382880861;11467;11697.47361368732;11729.64811055661;11885.524579016828;11998.340091294975;9309.162175404246;9379.437233765995;9477.857832132524;9478.573464194127;9495.762605934908;3363.4450315698127;3421.9144521386916;3485.0590340608146;3547.6807087362004;3591.7844929304065;44437.55562444399;44502;44665.77667111644;44732;44843.775781121214;9263.953680231556;9304.90695093054;9341.392809467363;9345.299102567335;9410.153086222273;17392.5651858702;17468.47594572165;17493.562660933578;17498.562535936704;17507.562310942074;7238.384737297283;7257.52826066304;7415.925840741632;7432.739854105081;7509.345561481377;4008.748539413378;4053.858114965962;4055.5538890721996;4057.14799892026;4061.614146656063;2724.4006318609872;2747.8900843966017;2750.4636595863612;2759.282586527477;2759.6826364968288;513.3070355020692;516.2205070343808;528.9894202115936;539.711254478852;540.864783804049;503.594606341891;546.2434528178501;565.8528782516493;577.5495113811234;581.3517927510795;7322;7341.229170937081;7380.889286660705;7563.168051514329;7586.468947173645;516.8656149401182;553.1785298831232;565.124057710547;600.906859436788;614.1126072824725;3579.487434933148;3607.639236076424;3646.7629604076183;3674.4488326750666;3679.0802299425145;53924.46075539194;53932;54112.72943635335;54135.45864541304;57878.7106064467;47293.29060064102;48108;48182.75908620434;48593.75703121462;48936.51063489391;42707.57292427036;43635.56364436315;43873.78063109728;44303;44304.556954430685;7605.391568674603;7648.464607477423;8179.754607361789;8189.426740128134;8437.240648341678;33671;34222.657773421946;34266.31467370688;34892.65107348894;35058.123546911535;43676.34485482784;43968.56031439645;44443.77778111089;44759;45032.324515131644;10157.339772914736;10334.431606261427;10394.740131496774;10426.895731042592;10476.0571548561;11675.182737208654;11699.766004680028;11841.763164736829;12352.691182720144;12353.505859765508;10190.01712942681;10436.425996570262;10441.321314114559;10682.412467314372;10714.624988125379;10378.325408848401;10431.582736690447;10720.517576709222;10735.624253151414;11045;9754.122129008423;9961.651342203279;10085.041921017491;10196.898031019595;10274;9382.390144640576;9388.906110939077;9526.142647161789;9582.185514231369;9616.567254473426;8472.279856212292;8620.568971551273;8738.868916966378;8936.955315223382;9026.45841249527 04:07:02 INFO - PROCESS | 5458 | __end_tp_report 04:07:02 INFO - PROCESS | 5458 | __start_cc_report 04:07:02 INFO - PROCESS | 5458 | _x_x_mozilla_cycle_collect,315 04:07:02 INFO - PROCESS | 5458 | __end_cc_report 04:07:02 INFO - PROCESS | 5458 | __startTimestamp1451390822902__endTimestamp 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | ------- Summary: start ------- 04:07:02 INFO - PROCESS | 5458 | Number of tests: 6 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | [#0] dojo.html Cycles:165 Average:5513.14 Median:5736.86 stddev:621.19 (10.8%) stddev-sans-first:597.13 04:07:02 INFO - PROCESS | 5458 | Values: 3247.7 3275.4 3308.4 3333.9 3344.5 5447.7 5459.5 5476.2 5477.8 5496.3 5351.1 5528.6 5570.6 5594.3 5681.2 4980.8 4992.3 4997.8 5001.2 5099.0 5021.9 5071.2 5079.2 5088.0 5088.4 4932.2 4998.1 5000.4 5002.0 5085.8 5049.3 5054.3 5055.6 5056.5 5080.3 4987.8 5027.3 5039.2 5043.3 5060.7 5297.0 5336.1 5399.4 5411.9 5494.5 5904.6 5905.8 5909.6 5913.8 5928.6 5936.6 5941.9 5949.7 5960.4 5963.6 5530.7 5593.6 5621.3 5621.3 5656.5 6143.3 6178.1 6182.7 6186.6 6187.4 5871.4 5874.1 5905.8 5930.3 5937.3 5894.8 5924.8 5978.1 6026.9 6033.7 5819.6 5884.5 5885.9 5888.1 5893.3 5796.5 5869.7 5877.2 5879.9 5882.8 4530.4 4566.9 4605.6 4618.9 4645.7 4003.0 4006.5 4014.6 4058.3 4067.3 5455.6 5517.8 5518.0 5537.5 5541.8 5967.7 5987.7 6017.4 6021.1 6099.4 5577.1 5583.7 5590.6 5601.3 5606.8 5018.5 5047.4 5113.6 5127.0 5130.1 5911.8 6025.9 6027.6 6037.8 6038.9 5856.0 5867.5 5882.6 5895.7 5966.5 6161.4 6185.8 6231.7 6232.3 6239.7 5922.5 5966.0 5993.2 6000.6 6053.7 5817.6 5881.2 5898.9 5913.0 5967.3 5780.5 5820.8 5822.7 5825.1 5846.5 5767.3 5822.0 5825.0 5825.6 5829.3 5652.1 5695.6 5735.0 5735.7 5831.4 5833.9 5853.6 5867.7 5879.6 5896.9 5709.7 5725.9 5735.9 5736.9 5765.1 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | [#1] ext.html Cycles:180 Average:43999.36 Median:194010.91 stddev:72612.58 (37.4%) stddev-sans-first:72742.95 04:07:02 INFO - PROCESS | 5458 | Values: 538.3 540.9 565.5 565.8 572.9 34236.3 35160.8 35224.1 35262.1 35310.8 38763.6 39301.6 39372.2 39385.0 39614.6 8424.1 8551.7 8565.0 8576.1 8577.9 8460.0 8541.7 8577.4 8712.8 8754.7 8741.3 8778.2 8807.3 8845.7 8852.5 8597.8 8644.0 8662.4 8714.1 8750.9 8523.2 8630.2 8633.3 8633.9 8639.8 38489.6 38938.8 38991.6 39000.2 39036.4 2445.6 2547.5 2784.1 2973.6 3338.7 28268.9 28307.4 28716.7 28762.7 29182.9 3870.6 3878.7 3893.4 3993.3 4060.8 221599.0 222189.0 222673.9 223499.0 223715.0 52916.5 53785.7 54588.7 61120.0 61650.4 54189.7 54270.2 54383.7 54628.7 54701.2 14897.4 14999.9 15075.2 15219.9 15236.8 11134.1 11139.0 11203.7 11307.4 11432.7 19529.7 20463.5 20527.8 20556.7 20641.6 7921.7 8068.2 8123.2 8169.8 8224.3 918.2 924.7 1034.6 1068.2 1105.7 24918.9 26270.0 26851.3 27407.6 27532.4 1038.8 1087.7 1098.0 1127.6 1216.1 14820.9 15123.9 15637.1 15861.0 15904.0 352711.0 356507.0 357907.0 359038.0 359516.0 53409.7 53901.2 54153.5 54186.5 54342.2 1383.2 1388.4 1396.4 1400.9 1404.2 29052.9 30280.4 30323.8 30908.5 30930.0 45362.1 45469.5 45722.8 45729.1 45809.5 228491.0 230037.0 232412.0 232751.0 233452.0 38820.8 42157.8 43179.4 43397.3 43432.6 38165.8 38395.2 38522.2 38606.6 38889.8 32315.4 32553.3 32927.7 33190.0 33205.8 33097.0 33155.8 33923.5 34022.5 34041.5 32439.0 32728.3 32976.0 35714.3 35961.8 30987.7 32244.2 32519.8 32908.8 33101.7 24841.3 25200.9 25338.9 25361.5 25362.0 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | [#2] jquery.html Cycles:180 Average:27807.44 Median:359.32 stddev:84123.77 (23412.1%) stddev-sans-first:84334.49 04:07:02 INFO - PROCESS | 5458 | Values: 351.8 356.3 357.8 360.9 361.9 16322.8 16429.9 17057.2 17588.6 18217.5 13936.4 15607.1 15830.7 15833.8 16145.2 4837.9 4906.3 4924.5 4939.5 4940.8 4886.2 4901.4 4907.3 4907.8 4913.2 4781.8 4906.3 4989.1 5169.0 5194.1 4925.5 5062.0 5074.5 5107.1 5111.7 4922.4 4962.1 4964.4 4979.4 4984.7 18344.1 18400.3 18712.4 18889.1 18989.8 661.3 1281.7 2127.0 2157.5 2258.3 9148.6 9160.9 9503.7 11782.4 12472.4 1745.7 1813.4 1824.5 1831.9 1832.4 60047.4 60564.7 60659.4 60707.0 62907.7 9931.3 10003.3 10005.7 10006.4 10013.0 12693.9 12780.7 12808.0 12830.2 12841.9 7002.2 7382.9 7547.5 7611.7 7632.5 7562.3 7602.9 7613.5 7639.5 7650.3 4203.2 4264.2 4312.7 4333.9 4345.2 1768.3 1779.4 1826.2 1826.4 1837.8 772.1 782.7 793.5 817.8 840.3 14933.9 15111.9 15427.5 15520.8 15663.7 845.8 876.8 882.1 885.6 888.4 8972.2 9689.3 10022.8 10094.6 10163.8 478338.0 500230.0 504850.0 519083.0 564990.0 79297.6 81841.6 81946.2 82109.6 82807.6 1104.5 1110.9 1122.1 1124.6 1131.4 14673.5 15484.5 15719.4 15735.7 15835.3 31561.2 31850.7 32360.0 32697.5 33192.7 36064.6 44502.8 45466.3 45635.0 46045.8 9144.0 9341.6 9405.6 9462.1 9476.8 16410.8 16827.7 16994.6 17083.3 17297.0 13690.8 14018.2 14417.6 14479.9 14547.7 13748.1 13981.2 14091.8 14118.2 14465.5 14010.5 14060.4 14189.1 14201.6 14374.9 8984.2 9156.5 9277.1 9294.7 9364.0 11170.8 13807.8 13976.5 13988.5 14143.7 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | [#3] mootools.html Cycles:180 Average:5342.05 Median:6656.38 stddev:2761.25 (41.5%) stddev-sans-first:2753.66 04:07:02 INFO - PROCESS | 5458 | Values: 1470.2 1485.2 1646.1 1761.7 1787.3 6924.5 6984.6 7596.8 7785.8 7799.2 7434.1 7493.0 7586.3 7610.3 7615.3 2285.7 2308.6 2323.9 2325.6 2328.8 2312.0 2342.3 2367.2 2368.7 2371.5 2281.4 2289.8 2312.1 2320.6 2324.0 2247.0 2251.5 2260.3 2262.6 2272.5 2300.2 2327.8 2333.1 2337.7 2342.9 7564.0 7593.4 7594.8 7625.8 7627.5 4541.0 4606.4 4608.0 4610.6 4614.5 2874.3 2891.1 2976.2 2995.4 3023.5 920.5 920.6 943.8 956.9 965.4 9833.2 9890.6 9925.8 9944.0 9950.1 4323.5 4327.1 4332.0 4372.7 4401.6 8603.1 8681.2 8692.6 8697.8 8702.1 4635.0 4636.8 4656.1 4657.2 4671.7 4230.7 4274.3 4356.5 4403.3 4414.6 3562.9 3580.5 3608.8 3621.7 3628.3 1114.4 1117.1 1117.6 1126.5 1132.1 1003.8 1016.0 1019.0 1133.4 1299.6 7059.4 7158.1 7159.1 7159.5 7172.1 494.5 496.6 503.3 507.3 508.3 5239.6 5241.7 5244.8 5288.8 5313.4 9175.0 9189.2 9443.5 9516.8 9541.6 9286.7 9290.7 9335.5 9413.2 9433.8 7235.1 7305.8 7333.9 7367.9 7373.9 6961.2 6976.5 7002.4 7018.3 7020.8 8310.3 8395.1 8399.1 8453.0 8514.1 8273.9 8300.2 8334.3 8345.6 8390.9 6627.9 6770.4 6853.5 6880.6 6915.1 7386.5 7470.8 7472.3 7497.2 7521.5 6684.9 6741.8 6806.5 6905.9 6989.7 6685.2 6756.2 6803.3 6903.2 6947.3 6799.5 6859.9 6871.6 6892.1 6913.6 6302.9 6305.8 6353.9 6363.5 6364.0 6464.8 6490.7 6496.0 6510.9 6548.2 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | [#4] prototype.html Cycles:180 Average:5615.40 Median:6308.53 stddev:1706.24 (27.0%) stddev-sans-first:1664.32 04:07:02 INFO - PROCESS | 5458 | Values: 332.9 338.0 342.3 343.9 345.9 6202.5 6307.3 6309.8 6334.5 6335.9 6114.3 6222.7 6237.1 6281.4 6289.0 4779.6 4787.8 4789.2 4798.7 4807.0 4786.8 4791.9 4800.0 4802.1 4823.4 4649.8 4761.4 4766.7 4768.3 4785.7 4741.4 4745.5 4745.9 4753.3 4773.5 4062.0 4133.6 4137.1 4151.4 4153.0 5954.0 5971.7 5975.1 5980.1 5993.8 5580.6 5596.5 5605.3 5617.3 5618.8 6579.9 6688.8 6721.3 6724.1 6730.4 4597.0 4638.2 4656.9 4663.1 4666.0 6948.2 6976.7 6984.7 6992.4 7028.9 4817.0 4837.8 4841.9 4846.3 4848.7 4811.9 4906.3 4919.4 4919.8 4936.8 5652.3 5655.2 5663.5 5666.4 5679.8 6722.7 6779.9 6783.1 6786.5 6787.8 1682.5 1697.5 1714.3 1716.6 1717.1 1119.3 1131.3 1138.9 1139.7 1165.2 6323.5 6330.6 6343.6 6372.4 6380.8 6917.5 6924.7 6925.3 6927.9 6945.7 6183.5 6249.5 6256.7 6293.8 6324.8 3718.5 3725.7 3752.5 3754.2 3755.8 7030.0 7153.3 7179.2 7187.7 7213.5 7106.1 7119.9 7122.0 7145.8 7149.9 6961.2 7222.5 7222.8 7223.6 7226.7 6962.3 6982.7 6986.0 6987.3 7000.2 6899.3 6934.5 6936.0 6944.8 6946.8 7094.1 7191.0 7223.0 7234.6 7249.1 4554.2 4644.2 4644.2 4646.6 4655.2 7003.5 7015.3 7021.4 7021.8 7021.8 6655.1 6790.1 6791.9 6807.5 6809.5 6733.1 6781.0 6787.3 6788.7 6789.7 6639.4 6669.7 6680.6 6684.9 6690.2 6674.9 6788.9 6817.1 6822.6 6835.1 6620.8 6649.7 6660.0 6661.2 6664.2 04:07:02 INFO - PROCESS | 5458 | 04:07:02 INFO - PROCESS | 5458 | [#5] yui.html Cycles:180 Average:12995.14 Median:48388.26 stddev:15236.18 (31.5%) stddev-sans-first:15250.25 04:07:02 INFO - PROCESS | 5458 | Values: 549.2 555.4 571.6 658.3 663.3 12182.6 12206.0 12226.2 12337.1 12348.3 10956.9 11167.3 11201.0 11236.8 11256.4 688.1 689.4 805.6 816.3 818.2 811.4 811.5 818.0 818.8 819.2 858.5 862.4 862.8 863.9 864.3 851.2 855.8 859.2 859.3 859.7 625.1 633.8 636.0 636.4 638.1 11417.8 11424.5 11457.4 11485.2 11523.4 11467.0 11697.5 11729.6 11885.5 11998.3 9309.2 9379.4 9477.9 9478.6 9495.8 3363.4 3421.9 3485.1 3547.7 3591.8 44437.6 44502.0 44665.8 44732.0 44843.8 9264.0 9304.9 9341.4 9345.3 9410.2 17392.6 17468.5 17493.6 17498.6 17507.6 7238.4 7257.5 7415.9 7432.7 7509.3 4008.7 4053.9 4055.6 4057.1 4061.6 2724.4 2747.9 2750.5 2759.3 2759.7 513.3 516.2 529.0 539.7 540.9 503.6 546.2 565.9 577.5 581.4 7322.0 7341.2 7380.9 7563.2 7586.5 516.9 553.2 565.1 600.9 614.1 3579.5 3607.6 3646.8 3674.4 3679.1 53924.5 53932.0 54112.7 54135.5 57878.7 47293.3 48108.0 48182.8 48593.8 48936.5 42707.6 43635.6 43873.8 44303.0 44304.6 7605.4 7648.5 8179.8 8189.4 8437.2 33671.0 34222.7 34266.3 34892.7 35058.1 43676.3 43968.6 44443.8 44759.0 45032.3 10157.3 10334.4 10394.7 10426.9 10476.1 11675.2 11699.8 11841.8 12352.7 12353.5 10190.0 10436.4 10441.3 10682.4 10714.6 10378.3 10431.6 10720.5 10735.6 11045.0 9754.1 9961.7 10085.0 10196.9 10274.0 9382.4 9388.9 9526.1 9582.2 9616.6 8472.3 8620.6 8738.9 8937.0 9026.5 04:07:02 INFO - PROCESS | 5458 | -------- Summary: end -------- 04:07:02 INFO - PROCESS | 5458 | 04:07:03 INFO - TEST-INFO | 5458: exit 0 04:07:03 INFO - TEST-OK | dromaeo_css | took 1110847ms 04:07:03 INFO - TEST-START | kraken 04:07:03 INFO - operating with platform_type : linux_ 04:07:03 INFO - Initialising browser for kraken test... 04:07:03 INFO - TEST-INFO | started process 5698 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9hP7jA/profile http://localhost:45945/getInfo.html) 04:07:07 INFO - PROCESS | 5698 | __metrics Screen width/height:1600/1200 04:07:07 INFO - PROCESS | 5698 | colorDepth:24 04:07:07 INFO - PROCESS | 5698 | Browser inner width/height: 1024/697 04:07:07 INFO - PROCESS | 5698 | __metrics 04:07:07 INFO - PROCESS | 5698 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:07:08 INFO - TEST-INFO | 5698: exit 0 04:07:08 INFO - Browser initialized. 04:07:08 INFO - Running cycle 1/1 for kraken test... 04:07:08 INFO - TEST-INFO | started process 5816 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9hP7jA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:20 INFO - PROCESS | 5816 | RSS: Main: 149516288 04:07:20 INFO - PROCESS | 5816 | 04:07:22 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45945/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:23 INFO - PROCESS | 5816 | RSS: Main: 151707648 04:07:23 INFO - PROCESS | 5816 | 04:07:26 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45945/tests/kraken/driver.html?testName=audio-dft) 04:07:26 INFO - PROCESS | 5816 | RSS: Main: 151748608 04:07:26 INFO - PROCESS | 5816 | 04:07:29 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45945/tests/kraken/driver.html?testName=audio-fft) 04:07:30 INFO - PROCESS | 5816 | RSS: Main: 145133568 04:07:30 INFO - PROCESS | 5816 | 04:07:32 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45945/tests/kraken/driver.html?testName=audio-oscillator) 04:07:32 INFO - PROCESS | 5816 | RSS: Main: 146620416 04:07:32 INFO - PROCESS | 5816 | 04:07:35 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45945/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:35 INFO - PROCESS | 5816 | RSS: Main: 146436096 04:07:35 INFO - PROCESS | 5816 | 04:07:38 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45945/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:39 INFO - PROCESS | 5816 | RSS: Main: 145375232 04:07:39 INFO - PROCESS | 5816 | 04:07:42 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45945/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:43 INFO - PROCESS | 5816 | RSS: Main: 148852736 04:07:43 INFO - PROCESS | 5816 | 04:07:45 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45945/tests/kraken/driver.html?testName=json-parse-financial) 04:07:46 INFO - PROCESS | 5816 | RSS: Main: 147099648 04:07:46 INFO - PROCESS | 5816 | 04:07:48 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45945/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:48 INFO - PROCESS | 5816 | RSS: Main: 147808256 04:07:48 INFO - PROCESS | 5816 | 04:07:50 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:51 INFO - PROCESS | 5816 | RSS: Main: 148860928 04:07:51 INFO - PROCESS | 5816 | 04:07:53 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:53 INFO - PROCESS | 5816 | RSS: Main: 149032960 04:07:53 INFO - PROCESS | 5816 | 04:07:56 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:56 INFO - PROCESS | 5816 | RSS: Main: 147496960 04:07:56 INFO - PROCESS | 5816 | 04:07:59 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:00 INFO - PROCESS | 5816 | RSS: Main: 148656128 04:08:00 INFO - PROCESS | 5816 | 04:08:01 INFO - PROCESS | 5816 | Cycle 1(1): loaded http://localhost:45945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45945/tests/kraken/driver.html?testName=ai-astar) 04:08:02 INFO - PROCESS | 5816 | RSS: Main: 148946944 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | __start_tp_report 04:08:02 INFO - PROCESS | 5816 | _x_x_mozilla_page_load 04:08:02 INFO - PROCESS | 5816 | _x_x_mozilla_page_load_details 04:08:02 INFO - PROCESS | 5816 | |i|pagename|runs| 04:08:02 INFO - PROCESS | 5816 | |0;ai-astar;111;104;109;109;111;122;109;109;109;112 04:08:02 INFO - PROCESS | 5816 | |1;audio-beat-detection;151;127;149;165;131;148;161;128;168;140 04:08:02 INFO - PROCESS | 5816 | |2;audio-dft;162;167;163;163;162;162;162;166;168;163 04:08:02 INFO - PROCESS | 5816 | |3;audio-fft;85;72;74;75;73;127;75;72;74;72 04:08:02 INFO - PROCESS | 5816 | |4;audio-oscillator;97;97;141;95;97;96;141;97;98;137 04:08:02 INFO - PROCESS | 5816 | |5;imaging-gaussian-blur;110;110;110;111;110;109;109;110;110;110 04:08:02 INFO - PROCESS | 5816 | |6;imaging-darkroom;147;147;147;146;147;147;147;147;147;147 04:08:02 INFO - PROCESS | 5816 | |7;imaging-desaturate;96;96;97;97;96;97;96;96;96;96 04:08:02 INFO - PROCESS | 5816 | |8;json-parse-financial;56;59;60;60;59;59;58;58;58;57 04:08:02 INFO - PROCESS | 5816 | |9;json-stringify-tinderbox;68;69;68;69;68;69;68;68;70;69 04:08:02 INFO - PROCESS | 5816 | |10;stanford-crypto-aes;85;93;88;88;94;85;87;86;86;86 04:08:02 INFO - PROCESS | 5816 | |11;stanford-crypto-ccm;121;119;119;123;126;128;125;123;122;119 04:08:02 INFO - PROCESS | 5816 | |12;stanford-crypto-pbkdf2;146;147;155;157;157;141;155;156;143;156 04:08:02 INFO - PROCESS | 5816 | |13;stanford-crypto-sha256-iterative;71;69;71;69;69;69;69;70;72;70 04:08:02 INFO - PROCESS | 5816 | __end_tp_report 04:08:02 INFO - PROCESS | 5816 | __start_cc_report 04:08:02 INFO - PROCESS | 5816 | _x_x_mozilla_cycle_collect,730 04:08:02 INFO - PROCESS | 5816 | __end_cc_report 04:08:02 INFO - PROCESS | 5816 | __startTimestamp1451390882049__endTimestamp 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | ------- Summary: start ------- 04:08:02 INFO - PROCESS | 5816 | Number of tests: 14 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.00 stddev:4.58 (4.2%) stddev-sans-first:4.85 04:08:02 INFO - PROCESS | 5816 | Values: 111.0 104.0 109.0 109.0 111.0 122.0 109.0 109.0 109.0 112.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:150.00 stddev:15.08 (10.1%) stddev-sans-first:15.92 04:08:02 INFO - PROCESS | 5816 | Values: 151.0 127.0 149.0 165.0 131.0 148.0 161.0 128.0 168.0 140.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.30 (1.4%) stddev-sans-first:2.35 04:08:02 INFO - PROCESS | 5816 | Values: 162.0 167.0 163.0 163.0 162.0 162.0 162.0 166.0 168.0 163.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#3] audio-fft Cycles:10 Average:79.90 Median:74.00 stddev:16.99 (23.0%) stddev-sans-first:17.92 04:08:02 INFO - PROCESS | 5816 | Values: 85.0 72.0 74.0 75.0 73.0 127.0 75.0 72.0 74.0 72.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:97.00 stddev:20.79 (21.4%) stddev-sans-first:21.55 04:08:02 INFO - PROCESS | 5816 | Values: 97.0 97.0 141.0 95.0 97.0 96.0 141.0 97.0 98.0 137.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:08:02 INFO - PROCESS | 5816 | Values: 110.0 110.0 110.0 111.0 110.0 109.0 109.0 110.0 110.0 110.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:08:02 INFO - PROCESS | 5816 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:08:02 INFO - PROCESS | 5816 | Values: 96.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:1.26 (2.1%) stddev-sans-first:1.00 04:08:02 INFO - PROCESS | 5816 | Values: 56.0 59.0 60.0 60.0 59.0 59.0 58.0 58.0 58.0 57.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:08:02 INFO - PROCESS | 5816 | Values: 68.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 70.0 69.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.50 stddev:3.19 (3.6%) stddev-sans-first:3.22 04:08:02 INFO - PROCESS | 5816 | Values: 85.0 93.0 88.0 88.0 94.0 85.0 87.0 86.0 86.0 86.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:123.00 stddev:3.14 (2.5%) stddev-sans-first:3.28 04:08:02 INFO - PROCESS | 5816 | Values: 121.0 119.0 119.0 123.0 126.0 128.0 125.0 123.0 122.0 119.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:155.50 stddev:6.31 (4.1%) stddev-sans-first:6.39 04:08:02 INFO - PROCESS | 5816 | Values: 146.0 147.0 155.0 157.0 157.0 141.0 155.0 156.0 143.0 156.0 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - PROCESS | 5816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:1.09 04:08:02 INFO - PROCESS | 5816 | Values: 71.0 69.0 71.0 69.0 69.0 69.0 69.0 70.0 72.0 70.0 04:08:02 INFO - PROCESS | 5816 | -------- Summary: end -------- 04:08:02 INFO - PROCESS | 5816 | 04:08:02 INFO - TEST-INFO | 5816: exit 0 04:08:02 INFO - TEST-OK | kraken | took 59373ms 04:08:02 INFO - TEST-START | v8_7 04:08:02 INFO - operating with platform_type : linux_ 04:08:02 INFO - Initialising browser for v8_7 test... 04:08:02 INFO - TEST-INFO | started process 6101 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSjI6YP/profile http://localhost:45945/getInfo.html) 04:08:07 INFO - PROCESS | 6101 | __metrics Screen width/height:1600/1200 04:08:07 INFO - PROCESS | 6101 | colorDepth:24 04:08:07 INFO - PROCESS | 6101 | Browser inner width/height: 1024/697 04:08:07 INFO - PROCESS | 6101 | __metrics 04:08:07 INFO - PROCESS | 6101 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:08:08 INFO - TEST-INFO | 6101: exit 0 04:08:08 INFO - Browser initialized. 04:08:08 INFO - Running cycle 1/1 for v8_7 test... 04:08:08 INFO - TEST-INFO | started process 6223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSjI6YP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:19 INFO - PROCESS | 6223 | RSS: Main: 149864448 04:08:19 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | Cycle 1(1): loaded http://localhost:45945/tests/v8_7/run.html (next: http://localhost:45945/tests/v8_7/run.html) 04:08:41 INFO - PROCESS | 6223 | RSS: Main: 145752064 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | __start_tp_report 04:08:41 INFO - PROCESS | 6223 | _x_x_mozilla_page_load 04:08:41 INFO - PROCESS | 6223 | _x_x_mozilla_page_load_details 04:08:41 INFO - PROCESS | 6223 | |i|pagename|runs| 04:08:41 INFO - PROCESS | 6223 | |0;Richards;166.11295681063123 04:08:41 INFO - PROCESS | 6223 | |1;DeltaBlue;190.65776930409913 04:08:41 INFO - PROCESS | 6223 | |2;Encrypt;280.50490883590464 04:08:41 INFO - PROCESS | 6223 | |3;Decrypt;5234.375 04:08:41 INFO - PROCESS | 6223 | |4;RayTrace;1083.4236186348862 04:08:41 INFO - PROCESS | 6223 | |5;Earley;704.7216349541931 04:08:41 INFO - PROCESS | 6223 | |6;Boyer;12407.407407407407 04:08:41 INFO - PROCESS | 6223 | |7;RegExp;25200 04:08:41 INFO - PROCESS | 6223 | |8;Splay;618.0469715698393 04:08:41 INFO - PROCESS | 6223 | |9;NavierStokes;4850.241545893719 04:08:41 INFO - PROCESS | 6223 | __end_tp_report 04:08:41 INFO - PROCESS | 6223 | __startTimestamp1451390921596__endTimestamp 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | ------- Summary: start ------- 04:08:41 INFO - PROCESS | 6223 | Number of tests: 10 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 166.1 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#1] DeltaBlue Cycles:1 Average:190.66 Median:190.66 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 190.7 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 280.5 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#3] Decrypt Cycles:1 Average:5234.38 Median:5234.38 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 5234.4 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#4] RayTrace Cycles:1 Average:1083.42 Median:1083.42 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 1083.4 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 704.7 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 12407.4 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 25200.0 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#8] Splay Cycles:1 Average:618.05 Median:618.05 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 618.0 04:08:41 INFO - PROCESS | 6223 | 04:08:41 INFO - PROCESS | 6223 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 04:08:41 INFO - PROCESS | 6223 | Values: 4850.2 04:08:41 INFO - PROCESS | 6223 | -------- Summary: end -------- 04:08:41 INFO - PROCESS | 6223 | 04:08:42 INFO - TEST-INFO | 6223: exit 0 04:08:42 INFO - TEST-OK | v8_7 | took 39491ms 04:08:42 INFO - SUITE-END | took 1209s 04:08:42 INFO - Completed test suite (00:20:09) 04:08:42 INFO - Working with test: dromaeo_css 04:08:42 INFO - Generating results file: dromaeo_css 04:08:42 INFO - Working with test: kraken 04:08:42 INFO - Generating results file: kraken 04:08:42 INFO - javascript benchmark 04:08:42 INFO - Working with test: v8_7 04:08:42 INFO - Generating results file: v8_7 04:08:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 04:08:42 INFO - process_Request line: dromaeo_css 6905.94 graph.html#tests=[[72,63,43]] 04:08:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:42 INFO - process_Request line: kraken 1522.20 graph.html#tests=[[232,63,43]] 04:08:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:42 INFO - process_Request line: v8_7 21245.28 graph.html#tests=[[230,63,43]] 04:08:42 INFO - RETURN: dromaeo_css: 6905.94 04:08:42 INFO - RETURN: kraken: 1522.20 04:08:42 INFO - RETURN: v8_7: 21245.28 04:08:42 INFO - javascript benchmark 04:08:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3247.6589958054406, 3275.4268003099464, 3308.387948229576, 3333.949990750139, 3344.498325251212, 5447.727613619323, 5459.535939445147, 5476.17857321401, 5477.808276710316, 5496.340439147303, 5351.09031464651, 5528.585356098289, 5570.554355651549, 5594.300712410949, 5681.23303354047, 4980.800767969277, 4992.301077849104, 4997.775100120485, 5001.249812528114, 5099.0, 5021.949780502185, 5071.239314102896, 5079.187330027196, 5088.0, 5088.4148322942965, 4932.235503496964, 4998.075356059123, 5000.449950505442, 5002.0, 5085.821996230115, 5049.34358533392, 5054.292399064134, 5055.620828437845, 5056.519630635084, 5080.339555857752, 4987.800487980477, 5027.3464449621315, 5039.244113382985, 5043.319151914481, 5060.74696265189, 5297.020051290524, 5336.066188417011, 5399.433059528732, 5411.945880541183, 5494.532964698005, 5904.61619994699, 5905.763769449217, 5909.556783241274, 5913.763449462016, 5928.614640048426, 5936.584439089265, 5941.8811623767715, 5949.6727679977585, 5960.374160713106, 5963.582549221556, 5530.668159910419, 5593.552515798808, 5621.297337832771, 5621.325440947113, 5656.519195868397, 6143.266246520256, 6178.1350610913605, 6182.721777520022, 6186.566940314135, 6187.3503282155625, 5871.3541510433815, 5874.089516125007, 5905.822825315247, 5930.347661757203, 5937.287525496968, 5894.764209431661, 5924.822255332347, 5978.073398623221, 6026.939730602638, 6033.728482218311, 5819.621724587888, 5884.529237660977, 5885.911711324334, 5888.116782482662, 5893.3222679391565, 5796.536277097822, 5869.706514674249, 5877.206577112121, 5879.853003674943, 5882.823515294463, 4530.388397566352, 4566.88582785433, 4605.631549476034, 4618.907621847544, 4645.74448405341, 4003.039270575099, 4006.4791577094793, 4014.638682518529, 4058.3303754880703, 4067.349224124185, 5455.61810673257, 5517.834464966058, 5518.0, 5537.473939975695, 5541.750621221974, 5967.701614919323, 5987.670678112746, 6017.428344307284, 6021.066734656135, 6099.420555047263, 5577.107662773937, 5583.748731307101, 5590.552755779528, 5601.29983752031, 5606.775728970877, 5018.4981501849525, 5047.419546752097, 5113.64204505681, 5127.025865085622, 5130.050940576006, 5911.822645320647, 6025.879482410327, 6027.638341699512, 6037.818865434044, 6038.909416358758, 5855.970720146543, 5867.5305975521005, 5882.558808089325, 5895.734691938959, 5966.49284810796, 6161.392058738642, 6185.84535386619, 6231.688415579112, 6232.345603711727, 6239.656818875005, 5922.51729347219, 5966.0, 5993.220881285405, 6000.609960352563, 6053.697315134137, 5817.592768506164, 5881.17663527098, 5898.882022359443, 5912.970435147797, 5967.313758917607, 5780.450857168562, 5820.76716931318, 5822.650640961556, 5825.097109947965, 5846.503047240862, 5767.3367562729145, 5822.0, 5824.95150872847, 5825.621334613236, 5829.300483941955, 5652.095664693629, 5695.629784064023, 5735.025045742151, 5735.655860648374, 5831.387704291158, 5833.891560603472, 5853.590248682552, 5867.6772777497645, 5879.559033072451, 5896.941030589639, 5709.7145142741865, 5725.8568535786935, 5735.942640573541, 5736.856578585569, 5765.135229715576], "unit": "score", "name": "dojo.html", "value": 5472.087454332938}, {"lowerIsBetter": false, "replicates": [538.3002097273543, 540.9242706021157, 565.5193085877003, 565.790657456741, 572.8711040015997, 34236.31527369451, 35160.824195879046, 35224.119397015085, 35262.1184470388, 35310.823445882765, 38763.61236387635, 39301.60698393015, 39372.21255574887, 39385.0, 39614.603853961526, 8424.115467875861, 8551.700690475835, 8564.957175214146, 8576.142385761435, 8577.871331930026, 8459.957700211491, 8541.743747687578, 8577.442466239705, 8712.825743485126, 8754.737357879241, 8741.30069594431, 8778.2099611035, 8807.251383632367, 8845.734627961172, 8852.468851868876, 8597.785055373603, 8644.049154592989, 8662.393632445732, 8714.128587141298, 8750.86873696895, 8523.232909038154, 8630.223279904776, 8633.309335253227, 8633.870491942625, 8639.827203455958, 38489.615103849166, 38938.80530597329, 38991.61008389908, 39000.219995600215, 39036.41445378322, 2445.5720248956363, 2547.503725782418, 2784.081253186464, 2973.55396690496, 3338.7162091222276, 28268.858655706794, 28307.433851322858, 28716.712832871614, 28762.712372876213, 29182.854085729647, 3870.574236833946, 3878.728489005771, 3893.3965235388278, 3993.341098718708, 4060.7766572838777, 221599.0, 222188.99999999837, 222673.88663056743, 223499.0, 223715.0, 52916.470835291155, 53785.731071344395, 54588.72705636446, 61120.0, 61650.38349616446, 54189.72905135528, 54270.185947210826, 54383.72808135934, 54628.72685636626, 54701.179482307794, 14897.404103835943, 14999.925000374928, 15075.170865602278, 15219.923900380649, 15236.771448428282, 11134.109271258441, 11139.0, 11203.71990700239, 11307.434628268553, 11432.657020289405, 19529.707054394195, 20463.4884127898, 20527.79472205259, 20556.691649625267, 20641.587168256552, 7921.722739704198, 8068.193180682002, 8123.187681231948, 8169.79575510617, 8224.259816616533, 918.196577994255, 924.6624981881565, 1034.6275340877278, 1068.2255364860414, 1105.662772854271, 24918.875405622857, 26270.0, 26851.328716781845, 27407.588886166723, 27532.449351012867, 1038.7974345002804, 1087.6791346552786, 1098.0392156862745, 1127.610974213895, 1216.1486959128645, 14820.92589537067, 15123.860493445047, 15637.139957302457, 15861.0, 15904.0, 352711.0, 356507.0, 357907.0, 359038.0, 359516.0, 53409.73295133577, 53901.1914821278, 54153.45846541563, 54186.45813541893, 54342.18486722702, 1383.2253937794867, 1388.3544151969384, 1396.406527225925, 1400.852910444409, 1404.206623257856, 29052.854735727033, 30280.394392112474, 30323.848380757954, 30908.536371954888, 30930.047972524662, 45362.09275814399, 45469.45305469426, 45722.77138614419, 45729.08541829211, 45809.541904580525, 228491.0, 230037.0, 232412.0, 232751.0, 233452.0, 38820.80589597034, 42157.77893149374, 43179.35230971475, 43397.26410943653, 43432.565674342855, 38165.80917095508, 38395.23209535738, 38522.22955540929, 38606.6139338603, 38889.805550972065, 32315.35369292554, 32553.34893302168, 32927.67072329246, 33190.0, 33205.83397082999, 33097.0, 33155.83422082874, 33923.49114763231, 34022.48966265558, 34041.48937765985, 32439.0, 32728.34543309073, 32976.0, 35714.28571428505, 35961.82019089888, 30987.690123099383, 32244.19389515281, 32519.837400812845, 32908.83545582257, 33101.66898330986, 24841.25476235716, 25200.873995630638, 25338.87330563409, 25361.483942082854, 25362.0], "unit": "score", "name": "ext.html", "value": 18063.337707704133}, {"lowerIsBetter": false, "replicates": [351.8170551313317, 356.2785359646717, 357.7656634904139, 360.8700867687632, 361.9457081437784, 16322.755158672615, 16429.917850410748, 17057.23242454091, 17588.560285992855, 18217.453476395694, 13936.44254229832, 15607.141607211599, 15830.683386332266, 15833.841661583381, 16145.192740362963, 4837.927431088528, 4906.31311616374, 4924.482929292427, 4939.53074457926, 4940.827071052514, 4886.242632391985, 4901.362822833044, 4907.2884431757375, 4907.82822601209, 4913.238448040542, 4781.832635857746, 4906.31311616374, 4989.101961646902, 5169.043726910515, 5194.117000109972, 4925.458199598042, 5062.012907483024, 5074.4671809460215, 5107.080725469414, 5111.718855462948, 4922.409310882717, 4962.082014827269, 4964.379452568429, 4979.427365852937, 4984.725840078794, 18344.082795860155, 18400.263989440406, 18712.438626841216, 18889.149988250563, 18989.810101898944, 661.2726001398471, 1281.6734679606564, 2126.9896799020344, 2157.524055153246, 2258.2999270226283, 9148.634054637807, 9160.8625870612, 9503.667371642028, 11782.351970641612, 12472.43874025671, 1745.729411941151, 1813.3925135079764, 1824.5165031266724, 1831.880927739706, 1832.3769918227867, 60047.399526004614, 60564.69717651427, 60659.393406065814, 60707.0, 62907.68546157286, 9931.255155863339, 10003.349782264275, 10005.749856253651, 10006.399616023062, 10013.0, 12693.936530317289, 12780.680482988, 12808.039397045259, 12830.16603920742, 12841.93579032099, 7002.229754726976, 7382.926170738331, 7547.547147171187, 7611.695532178651, 7632.542047477169, 7562.319391254813, 7602.885956710654, 7613.5431874087735, 7639.465237433437, 7650.31147196755, 4203.159368126387, 4264.168487145039, 4312.741235525878, 4333.891652708645, 4345.196138714348, 1768.32803534656, 1779.3772179736989, 1826.159966415437, 1826.4246762269843, 1837.7702787151607, 772.142921357293, 782.7143092771212, 793.4683761879439, 817.8159914019298, 840.3193413335096, 14933.925330373278, 15111.924440377728, 15427.5371738848, 15520.767188492182, 15663.68672626564, 845.7970087179033, 876.7895705030746, 882.1046637662778, 885.5660726244093, 888.4136469929815, 8972.237359824358, 9689.27330450219, 10022.849657255147, 10094.596216151273, 10163.796724065478, 478338.0, 500230.0, 504850.0, 519083.0, 564990.0, 79297.60351198322, 81841.59079204685, 81946.18053819505, 82109.58945205355, 82807.5859620698, 1104.4532956186738, 1110.8833572474934, 1122.1303489795312, 1124.5670416889557, 1131.3890499130378, 14673.486427974969, 15484.5354639361, 15719.449819256271, 15735.685286293981, 15835.287412066715, 31561.21096972594, 31850.681493184773, 32360.0, 32697.509537356484, 33192.668073319925, 36064.63935360613, 44502.77748611236, 45466.31800523061, 45635.0, 46045.76977115093, 9143.954280228556, 9341.626334946526, 9405.623775048922, 9462.053794620482, 9476.763080923032, 16410.835891641407, 16827.663446730752, 16994.575135621708, 17083.31666733317, 17297.0, 13690.794638080237, 14018.228997404833, 14417.567472975827, 14479.855201448272, 14547.709045818812, 13748.106373085717, 13981.23103229332, 14091.788623170865, 14118.152910825384, 14465.49370772018, 14010.509632162826, 14060.367283472473, 14189.148651080968, 14201.644958876112, 14374.856251437352, 8984.23633991092, 9156.542172891195, 9277.118673725985, 9294.674686385944, 9364.016778238187, 11170.832437513282, 13807.792883106962, 13976.510822121178, 13988.510402135877, 14143.717125657635], "unit": "score", "name": "jquery.html", "value": 8548.414594943893}, {"lowerIsBetter": false, "replicates": [1470.2281302316285, 1485.1608841004834, 1646.135778716174, 1761.7357396390548, 1787.2940188625485, 6924.4806639501985, 6984.615846128461, 7596.848063038736, 7785.844283114335, 7799.181085985975, 7434.107907051161, 7493.0, 7586.279303466162, 7610.315071643551, 7615.276548727876, 2285.70285862838, 2308.572914010905, 2323.8838058097112, 2325.616273314901, 2328.8486248393883, 2311.976880231193, 2342.2504798464497, 2367.183321753992, 2368.7275963264187, 2371.5256948610263, 2281.418238349227, 2289.7939185473306, 2312.063614236237, 2320.6170981787986, 2324.0, 2247.0, 2251.459649684064, 2260.333201705501, 2262.6266666000006, 2272.534130503251, 2300.18343488061, 2327.755585663515, 2333.125078095714, 2337.6960995070704, 2342.8711420871846, 7564.0, 7593.430492713069, 7594.8481030379635, 7625.771226863203, 7627.466077374586, 4541.0, 4606.447226332828, 4607.976960115211, 4610.585047345755, 4614.5385461453925, 2874.3245337345707, 2891.089306868351, 2976.1666733314705, 2995.400919816024, 3023.486007378751, 920.5259291464901, 920.6041402197053, 943.8112377524454, 956.9330146889721, 965.4110992294694, 9833.213342932548, 9890.554925028318, 9925.801483970281, 9943.950280248624, 9950.054744799232, 4323.481182258086, 4327.1345730853955, 4331.956680433218, 4372.737635741865, 4401.625861801719, 8603.139686031473, 8681.218690317775, 8692.608832602547, 8697.782555436164, 8702.086280940537, 4634.97682511592, 4636.814527418933, 4656.138614356355, 4657.231556793091, 4671.719696818202, 4230.682698797603, 4274.273373526508, 4356.455443069616, 4403.295472724349, 4414.558544145624, 3562.87529936451, 3580.534530511017, 3608.7654302470255, 3621.6559426854406, 3628.346897558412, 1114.3815182573749, 1117.1007339091946, 1117.5529788084668, 1126.4592995362273, 1132.0660455124391, 1003.7741508160606, 1016.049993256293, 1018.9861088217272, 1133.3709791066037, 1299.590628951896, 7059.435245180476, 7158.105236845395, 7159.069320988238, 7159.534630249017, 7172.13934327884, 494.5400777277095, 496.5927939089984, 503.3029254482568, 507.31259143860274, 508.29347207381767, 5239.633225674243, 5241.68549887008, 5244.816431424882, 5288.762005709752, 5313.44208858072, 9174.954125229331, 9189.218916392048, 9443.480608566595, 9516.762080948032, 9541.618335266512, 9286.67496637628, 9290.74574932389, 9335.486548239776, 9413.19987801031, 9433.764155896157, 7235.131784185826, 7305.817354566178, 7333.88999165013, 7367.852642947111, 7373.88939165913, 6961.199462061928, 6976.476764242803, 7002.3697867192195, 7018.33325834045, 7020.7893763187185, 8310.293625041697, 8395.118512556093, 8399.118092600189, 8453.027901791373, 8514.148585141436, 8273.875891861506, 8300.169983001651, 8334.291585215324, 8345.582720863811, 8390.916090839013, 6627.867442651216, 6770.424513916372, 6853.520253582202, 6880.58716477013, 6915.066466027022, 7386.482946193715, 7470.775876723707, 7472.29013243741, 7497.175310715707, 7521.5111017783665, 6684.899726504009, 6741.797746067626, 6806.523543351917, 6905.896411553931, 6989.685464154024, 6685.197776266685, 6756.189257289157, 6803.319668033157, 6903.206131294965, 6947.305269473012, 6799.490038247052, 6859.862802744017, 6871.587704737732, 6892.104026476526, 6913.5506192097355, 6302.873942521215, 6305.842353941188, 6353.936460635335, 6363.490920726238, 6364.045393190873, 6464.806055818333, 6490.740370385321, 6495.967520162369, 6510.934890651033, 6548.246951600627], "unit": "score", "name": "mootools.html", "value": 4323.929923699462}, {"lowerIsBetter": false, "replicates": [332.9400707872583, 337.9860418743769, 342.3204938197679, 343.94152993991025, 345.9308138372326, 6202.472789812871, 6307.274663413708, 6309.77915772948, 6334.461570766491, 6335.873282534347, 6114.327423983369, 6222.7199776010075, 6237.126802247689, 6281.43467087962, 6288.968555157229, 4779.617630589553, 4787.760611969405, 4789.161896668086, 4798.736069516175, 4806.951930480685, 4786.808527658889, 4791.856244312658, 4799.952000480003, 4802.111609352263, 4823.445303790074, 4649.814007439699, 4761.381020467335, 4766.666333356667, 4768.332433459318, 4785.712857228577, 4741.407324084489, 4745.454272758625, 4745.905081898377, 4753.33453316536, 4773.474917759044, 4061.97969010156, 4133.565975572582, 4137.13120244749, 4151.398047283157, 4153.003279212998, 5953.958057339992, 5971.701414929236, 5975.1037344398255, 5980.073088671263, 5993.820185394445, 5580.637258578179, 5596.496315331639, 5605.327360716699, 5617.269754931874, 5618.803341883015, 6579.868402631921, 6688.83277918051, 6721.26066132725, 6724.092247546617, 6730.360615741497, 4597.011642496879, 4638.2115040443205, 4656.883577910546, 4663.134746101553, 4666.043461090502, 6948.235694073648, 6976.686049127852, 6984.650767461607, 6992.440604751659, 7028.859422811566, 4816.988432429159, 4837.758112094381, 4841.878953026203, 4846.321514987904, 4848.660593758474, 4811.855644330676, 4906.313116163668, 4919.385076865392, 4919.794650310697, 4936.777844996984, 5652.3217213934595, 5655.1799989001365, 5663.490285874209, 5666.433356664383, 5679.829605111853, 6722.731090756412, 6779.898301525481, 6783.118194634666, 6786.491013174032, 6787.830304242433, 1682.503661419884, 1697.4822679082997, 1714.3057061889954, 1716.605180808421, 1717.1328479117965, 1119.3060302612432, 1131.298594871185, 1138.9202755807014, 1139.732162941708, 1165.1901928159848, 6323.462505687068, 6330.620162790247, 6343.55595108338, 6372.426481616584, 6380.776672816429, 6917.481188910851, 6924.688389022506, 6925.3074692530345, 6927.930720692729, 6945.652717364112, 6183.536234782409, 6249.500039996789, 6256.717372938537, 6293.842653933688, 6324.810255692337, 3718.4980027696456, 3725.720570957135, 3752.493413389212, 3754.249150169977, 3755.830987605564, 7030.015797788314, 7153.284671532805, 7179.210286868441, 7187.712491500281, 7213.4589905757275, 7106.111736032996, 7119.89320160198, 7122.038524799086, 7145.785626431215, 7149.92850071503, 6961.199462061826, 7222.494425390278, 7222.819429514199, 7223.566586004857, 7226.74706385274, 6962.338577835098, 6982.720691172296, 6985.96507017482, 6987.301269873175, 7000.229974702676, 6899.310068993061, 6934.514583979275, 6936.0, 6944.826379340355, 6946.826329341807, 7094.148702155774, 7191.0, 7222.96388518054, 7234.6020968847215, 7249.05762250904, 4554.20301447252, 4644.164050470813, 4644.187267228154, 4646.558576935186, 4655.185342565105, 7003.54476958996, 7015.263397343206, 7021.368076873106, 7021.754238601625, 7021.789346319619, 6655.068290439439, 6790.083338749403, 6791.89812152828, 6807.455403567802, 6809.455243580601, 6733.091032710521, 6780.966095169492, 6787.321267873173, 6788.728450862108, 6789.72841086351, 6639.3692599203, 6669.7332106715185, 6680.63256520896, 6684.866302674017, 6690.19717633887, 6674.866502670016, 6788.86422271542, 6817.079694241214, 6822.635472905339, 6835.14560679915, 6620.8344791380605, 6649.667516624053, 6660.0, 6661.16735408074, 6664.166979127609], "unit": "score", "name": "prototype.html", "value": 5055.912319364114}, {"lowerIsBetter": false, "replicates": [549.2118809508358, 555.4306835493619, 571.6227289988608, 658.3416583416583, 663.2770280394369, 12182.573609923644, 12206.0, 12226.205296655711, 12337.074719396047, 12348.320842353667, 10956.945215273912, 11167.329960202394, 11201.0, 11236.775264494705, 11256.38089905055, 688.0951548713451, 689.4208864553774, 805.6012273924416, 816.3102178659053, 818.2186012358213, 811.350919264586, 811.4765975945512, 818.0, 818.7789296889836, 819.2258315891455, 858.4977787994031, 862.374778285741, 862.8015556422026, 863.9092895246002, 864.2653744317342, 851.1743608699583, 855.7732200966686, 859.1623167411786, 859.3340161374922, 859.7248880358288, 625.1217040058725, 633.8415396150963, 636.0268788753215, 636.4494712074069, 638.0620487882804, 11417.771644567061, 11424.485898134604, 11457.36984465854, 11485.19603627738, 11523.42382880861, 11467.0, 11697.47361368732, 11729.64811055661, 11885.524579016828, 11998.340091294975, 9309.162175404246, 9379.437233765995, 9477.857832132524, 9478.573464194127, 9495.762605934908, 3363.4450315698127, 3421.9144521386916, 3485.0590340608146, 3547.6807087362004, 3591.7844929304065, 44437.55562444399, 44502.0, 44665.77667111644, 44732.0, 44843.775781121214, 9263.953680231556, 9304.90695093054, 9341.392809467363, 9345.299102567335, 9410.153086222273, 17392.5651858702, 17468.47594572165, 17493.562660933578, 17498.562535936704, 17507.562310942074, 7238.384737297283, 7257.52826066304, 7415.925840741632, 7432.739854105081, 7509.345561481377, 4008.748539413378, 4053.858114965962, 4055.5538890721996, 4057.14799892026, 4061.614146656063, 2724.4006318609872, 2747.8900843966017, 2750.4636595863612, 2759.282586527477, 2759.6826364968288, 513.3070355020692, 516.2205070343808, 528.9894202115936, 539.711254478852, 540.864783804049, 503.594606341891, 546.2434528178501, 565.8528782516493, 577.5495113811234, 581.3517927510795, 7322.0, 7341.229170937081, 7380.889286660705, 7563.168051514329, 7586.468947173645, 516.8656149401182, 553.1785298831232, 565.124057710547, 600.906859436788, 614.1126072824725, 3579.487434933148, 3607.639236076424, 3646.7629604076183, 3674.4488326750666, 3679.0802299425145, 53924.46075539194, 53932.0, 54112.72943635335, 54135.45864541304, 57878.7106064467, 47293.29060064102, 48108.0, 48182.75908620434, 48593.75703121462, 48936.51063489391, 42707.57292427036, 43635.56364436315, 43873.78063109728, 44303.0, 44304.556954430685, 7605.391568674603, 7648.464607477423, 8179.754607361789, 8189.426740128134, 8437.240648341678, 33671.0, 34222.657773421946, 34266.31467370688, 34892.65107348894, 35058.123546911535, 43676.34485482784, 43968.56031439645, 44443.77778111089, 44759.0, 45032.324515131644, 10157.339772914736, 10334.431606261427, 10394.740131496774, 10426.895731042592, 10476.0571548561, 11675.182737208654, 11699.766004680028, 11841.763164736829, 12352.691182720144, 12353.505859765508, 10190.01712942681, 10436.425996570262, 10441.321314114559, 10682.412467314372, 10714.624988125379, 10378.325408848401, 10431.582736690447, 10720.517576709222, 10735.624253151414, 11045.0, 9754.122129008423, 9961.651342203279, 10085.041921017491, 10196.898031019595, 10274.0, 9382.390144640576, 9388.906110939077, 9526.142647161789, 9582.185514231369, 9616.567254473426, 8472.279856212292, 8620.568971551273, 8738.868916966378, 8936.955315223382, 9026.45841249527], "unit": "score", "name": "yui.html", "value": 5871.985631475079}], "name": "dromaeo_css", "value": 6905.940388494117}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 109.0, 109.0, 111.0, 122.0, 109.0, 109.0, 109.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 149.0, 165.0, 131.0, 148.0, 161.0, 128.0, 168.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 167.0, 163.0, 163.0, 162.0, 162.0, 162.0, 166.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [85.0, 72.0, 74.0, 75.0, 73.0, 127.0, 75.0, 72.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 95.0, 97.0, 96.0, 141.0, 97.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 60.0, 60.0, 59.0, 59.0, 58.0, 58.0, 58.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 88.0, 88.0, 94.0, 85.0, 87.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 119.0, 123.0, 126.0, 128.0, 125.0, 123.0, 122.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 155.0, 157.0, 157.0, 141.0, 155.0, 156.0, 143.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 71.0, 69.0, 69.0, 69.0, 69.0, 70.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1522.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [190.65776930409913], "unit": "score", "name": "DeltaBlue", "value": 346.78891000000004}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5234.375], "unit": "score", "name": "Decrypt", "value": 50.852489552238794}, {"lowerIsBetter": false, "replicates": [1083.4236186348862], "unit": "score", "name": "RayTrace", "value": 683.0098469999997}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [618.0469715698393], "unit": "score", "name": "Splay", "value": 131.852438}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21245.27651585112}]} 04:08:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21245.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1522.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6905.94"}}} 04:08:42 INFO - Return code: 0 04:08:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:08:42 INFO - # TBPL SUCCESS # 04:08:42 INFO - Running post-action listener: _resource_record_post_action 04:08:42 INFO - Running post-run listener: _resource_record_post_run 04:08:43 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555089920; Read time: 12; Write time: 373892 04:08:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235466752; Read time: 0; Write time: 197020 04:08:43 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319623168; Read time: 12; Write time: 176872 04:08:43 INFO - Running post-run listener: _upload_blobber_files 04:08:43 INFO - Blob upload gear active. 04:08:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:08:43 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 04:08:43 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'] 04:08:43 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 04:08:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:08:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:45 INFO - (blobuploader) - INFO - Done attempting. 04:08:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:08:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:45 INFO - (blobuploader) - INFO - Done attempting. 04:08:45 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:45 INFO - Return code: 0 04:08:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:08:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6099c6634195007a389cf10a5d281d92ad6fd2e1689a3292ae468db352afb4d10579bdd7996098a98ef913fd3319625c142ff922434c4bd0cd6922896237cb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0347ff93f4126fbfce274304afcd5a77ce6fe6d825bf07d193b0d97a0f24316b6f22443496d492ffdbf4a82e17e4f98bf0404f41cb93ee234d6b855d1620a734"} 04:08:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:08:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:08:45 INFO - Contents: 04:08:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6099c6634195007a389cf10a5d281d92ad6fd2e1689a3292ae468db352afb4d10579bdd7996098a98ef913fd3319625c142ff922434c4bd0cd6922896237cb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0347ff93f4126fbfce274304afcd5a77ce6fe6d825bf07d193b0d97a0f24316b6f22443496d492ffdbf4a82e17e4f98bf0404f41cb93ee234d6b855d1620a734"} 04:08:45 INFO - Copying logs to upload dir... 04:08:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.680700 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-29 04:08:45.668396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:45.671813) ========= 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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 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/6099c6634195007a389cf10a5d281d92ad6fd2e1689a3292ae468db352afb4d10579bdd7996098a98ef913fd3319625c142ff922434c4bd0cd6922896237cb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0347ff93f4126fbfce274304afcd5a77ce6fe6d825bf07d193b0d97a0f24316b6f22443496d492ffdbf4a82e17e4f98bf0404f41cb93ee234d6b855d1620a734"} build_url:https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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/6099c6634195007a389cf10a5d281d92ad6fd2e1689a3292ae468db352afb4d10579bdd7996098a98ef913fd3319625c142ff922434c4bd0cd6922896237cb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0347ff93f4126fbfce274304afcd5a77ce6fe6d825bf07d193b0d97a0f24316b6f22443496d492ffdbf4a82e17e4f98bf0404f41cb93ee234d6b855d1620a734"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:45.697156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:45.697535) ========= 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=f5f5a079460e1a9be8676904000001c1-1451385399.579353-1390702961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:45.781356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 04:08:45.781661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 04:08:45.781952) ========= ========= Total master_lag: 0.24 =========