builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1452517279.66 results: success (0) buildid: 20160111023004 builduid: 0950449848284eb3b7d5d344da1edddf revision: eea6896314ef30abaddf87100ee1b8e188c67508 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.660287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.660741) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.661039) ========= 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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004242 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.678301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.678643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.688865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.689158) ========= 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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.737922) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.738220) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.738638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.738931) ========= 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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 05:01:19-- 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% 84.5M=0s 2016-01-11 05:01:19 (84.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.842932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.843241) ========= 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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022232 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:19.892535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 05:01:19.892894) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev eea6896314ef30abaddf87100ee1b8e188c67508 --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/b2g-inbound --rev eea6896314ef30abaddf87100ee1b8e188c67508 --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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 05:01:19,956 truncating revision to first 12 chars 2016-01-11 05:01:19,956 Setting DEBUG logging. 2016-01-11 05:01:19,956 attempt 1/10 2016-01-11 05:01:19,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/eea6896314ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 05:01:20,957 unpacking tar archive at: b2g-inbound-eea6896314ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.332081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 05:01:21.237863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:21.238226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:21.444759) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:21.445209) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 05:01:21.445639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-11 05:01:21.445979) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:21 INFO - MultiFileLogger online at 20160111 05:01:21 in /builds/slave/test-pgo 05:01:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 05:01:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:01:21 INFO - {'append_to_log': False, 05:01:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:01:21 INFO - 'blob_upload_branch': 'B2G-Inbound', 05:01:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:01:21 INFO - 'branch': 'B2G-Inbound', 05:01:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:21 INFO - 'config_files': ('talos/linux_config.py',), 05:01:21 INFO - 'default_actions': ('clobber', 05:01:21 INFO - 'read-buildbot-config', 05:01:21 INFO - 'download-and-extract', 05:01:21 INFO - 'populate-webroot', 05:01:21 INFO - 'create-virtualenv', 05:01:21 INFO - 'install', 05:01:21 INFO - 'run-tests'), 05:01:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:21 INFO - 'download_minidump_stackwalk': True, 05:01:21 INFO - 'download_symbols': 'ondemand', 05:01:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:21 INFO - 'installer_path': 'installer.exe', 05:01:21 INFO - 'log_level': 'info', 05:01:21 INFO - 'log_name': 'talos', 05:01:21 INFO - 'log_to_console': True, 05:01:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:21 INFO - 'opt_config_files': (), 05:01:21 INFO - 'pip_index': False, 05:01:21 INFO - 'sps_profile': False, 05:01:21 INFO - 'sps_profile_interval': 0, 05:01:21 INFO - 'suite': 'dromaeojs', 05:01:21 INFO - 'system_bits': '32', 05:01:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:21 INFO - 'title': 'talos-linux64-ix-010', 05:01:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:21 INFO - 'use_talos_json': True, 05:01:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:01:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:21 INFO - 'work_dir': 'build'} 05:01:21 INFO - ##### 05:01:21 INFO - ##### Running clobber step. 05:01:21 INFO - ##### 05:01:21 INFO - Running pre-action listener: _resource_record_pre_action 05:01:21 INFO - Running main action method: clobber 05:01:21 INFO - rmtree: /builds/slave/test-pgo/build 05:01:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:01:22 INFO - Running post-action listener: _resource_record_post_action 05:01:22 INFO - ##### 05:01:22 INFO - ##### Running read-buildbot-config step. 05:01:22 INFO - ##### 05:01:22 INFO - Running pre-action listener: _resource_record_pre_action 05:01:22 INFO - Running main action method: read_buildbot_config 05:01:22 INFO - Using buildbot properties: 05:01:22 INFO - { 05:01:22 INFO - "project": "", 05:01:22 INFO - "product": "firefox", 05:01:22 INFO - "script_repo_revision": "production", 05:01:22 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:01:22 INFO - "repository": "", 05:01:22 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 05:01:22 INFO - "buildid": "20160111023004", 05:01:22 INFO - "pgo_build": "True", 05:01:22 INFO - "basedir": "/builds/slave/test-pgo", 05:01:22 INFO - "buildnumber": 1098, 05:01:22 INFO - "slavename": "talos-linux64-ix-010", 05:01:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:01:22 INFO - "platform": "ubuntu64_hw", 05:01:22 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 05:01:22 INFO - "branch": "b2g-inbound", 05:01:22 INFO - "repo_path": "integration/b2g-inbound", 05:01:22 INFO - "revision": "eea6896314ef30abaddf87100ee1b8e188c67508", 05:01:22 INFO - "stage_platform": "linux64-pgo", 05:01:22 INFO - "builduid": "0950449848284eb3b7d5d344da1edddf", 05:01:22 INFO - "slavebuilddir": "test" 05:01:22 INFO - } 05:01:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:01:22 INFO - Running post-action listener: _resource_record_post_action 05:01:22 INFO - ##### 05:01:22 INFO - ##### Running download-and-extract step. 05:01:22 INFO - ##### 05:01:22 INFO - Running pre-action listener: _resource_record_pre_action 05:01:22 INFO - Running main action method: download_and_extract 05:01:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:22 INFO - https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/test_packages.json 05:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/test_packages.json 05:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:01:22 INFO - Downloaded 1302 bytes. 05:01:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:01:22 INFO - Using the following test package requirements: 05:01:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'jsshell-linux-x86_64.zip'], 05:01:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:22 INFO - https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:25 INFO - Downloaded 24028582 bytes. 05:01:25 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 05:01:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:25 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 05:01:26 INFO - Return code: 0 05:01:26 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 05:01:26 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')]} 05:01:26 INFO - https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:29 INFO - Downloaded 24028582 bytes. 05:01:29 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 05:01:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:01:29 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 05:01:30 INFO - Return code: 0 05:01: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')]} 05:01:30 INFO - https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:33 INFO - Downloaded 11132285 bytes. 05:01:33 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 05:01:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:33 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 05:01:33 INFO - Return code: 0 05:01: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')]} 05:01:33 INFO - https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuGObJdOSMCszIQyUVnXkw/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 05:01:38 INFO - Downloaded 55920548 bytes. 05:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:38 INFO - mkdir: /builds/slave/test-pgo/properties 05:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:01:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:01:38 INFO - Contents: 05:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:01:38 INFO - Running post-action listener: _resource_record_post_action 05:01:38 INFO - Running post-action listener: set_extra_try_arguments 05:01:38 INFO - ##### 05:01:38 INFO - ##### Running populate-webroot step. 05:01:38 INFO - ##### 05:01:38 INFO - Running pre-action listener: _resource_record_pre_action 05:01:38 INFO - Running main action method: populate_webroot 05:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:38 INFO - '--tppagecycles', 05:01:38 INFO - '7'], 05:01:38 INFO - 'tests': ['tsvgm']}}, 05:01:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:01:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:01:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'tests': ['damp', 'tps']}, 05:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['damp', 'tps']}, 05:01:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:38 INFO - 'other': {'tests': ['a11yr', 05:01:38 INFO - 'ts_paint', 05:01:38 INFO - 'tpaint', 05:01:38 INFO - 'sessionrestore', 05:01:38 INFO - 'sessionrestore_no_auto_restore']}, 05:01:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['a11yr', 05:01:38 INFO - 'ts_paint', 05:01:38 INFO - 'tpaint', 05:01:38 INFO - 'sessionrestore', 05:01:38 INFO - 'sessionrestore_no_auto_restore']}, 05:01:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['a11yr', 05:01:38 INFO - 'ts_paint', 05:01:38 INFO - 'tpaint', 05:01:38 INFO - 'sessionrestore', 05:01:38 INFO - 'sessionrestore_no_auto_restore']}, 05:01:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['a11yr', 05:01:38 INFO - 'ts_paint', 05:01:38 INFO - 'tpaint', 05:01:38 INFO - 'sessionrestore', 05:01:38 INFO - 'sessionrestore_no_auto_restore']}, 05:01:38 INFO - 'other_l64': {'tests': ['a11yr', 05:01:38 INFO - 'ts_paint', 05:01:38 INFO - 'tpaint', 05:01:38 INFO - 'sessionrestore', 05:01:38 INFO - 'sessionrestore_no_auto_restore']}, 05:01:38 INFO - 'other_nol64': {'tests': ['a11yr', 05:01:38 INFO - 'ts_paint', 05:01:38 INFO - 'tpaint', 05:01:38 INFO - 'sessionrestore', 05:01:38 INFO - 'sessionrestore_no_auto_restore']}, 05:01:38 INFO - 'svgr': {'tests': ['tsvgx', 05:01:38 INFO - 'tsvgr_opacity', 05:01:38 INFO - 'tart', 05:01:38 INFO - 'tscrollx', 05:01:38 INFO - 'cart']}, 05:01:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['tsvgx', 05:01:38 INFO - 'tsvgr_opacity', 05:01:38 INFO - 'tart', 05:01:38 INFO - 'tscrollx', 05:01:38 INFO - 'cart']}, 05:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'tests': ['tp5o']}, 05:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'talos_options': ['--e10s'], 05:01:38 INFO - 'tests': ['tp5o']}, 05:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'talos_options': ['--xperf_path', 05:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:38 INFO - 'tests': ['tp5n']}, 05:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:38 INFO - 'talos_options': ['--e10s', 05:01:38 INFO - '--xperf_path', 05:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:38 INFO - 'tests': ['tp5n']}}, 05:01:38 INFO - 'talos.zip': {'path': '', 05:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:38 INFO - Running post-action listener: _resource_record_post_action 05:01:38 INFO - ##### 05:01:38 INFO - ##### Running create-virtualenv step. 05:01:38 INFO - ##### 05:01:38 INFO - Running pre-action listener: _resource_record_pre_action 05:01:38 INFO - Running main action method: create_virtualenv 05:01:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:01:38 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 05:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:38 INFO - Using real prefix '/usr' 05:01:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:41 INFO - Installing pip.................done. 05:01:41 INFO - Return code: 0 05:01:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:41 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 05:01:41 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 05:01:41 INFO - Using env: {'DISPLAY': ':0', 05:01:41 INFO - 'HOME': '/home/cltbld', 05:01:41 INFO - 'LANG': 'en_US.UTF-8', 05:01:41 INFO - 'LANGUAGE': 'en_US:en', 05:01:41 INFO - 'LOGNAME': 'cltbld', 05:01:41 INFO - 'MAIL': '/var/mail/cltbld', 05:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:41 INFO - 'MOZ_NO_REMOTE': '1', 05:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:41 INFO - 'NO_EM_RESTART': '1', 05:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:41 INFO - 'SHELL': '/bin/bash', 05:01:41 INFO - 'SHLVL': '1', 05:01:41 INFO - 'TERM': 'linux', 05:01:41 INFO - 'TMOUT': '86400', 05:01:41 INFO - 'USER': 'cltbld', 05:01:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:41 INFO - '_': '/tools/buildbot/bin/python'} 05:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:41 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 05:01:41 INFO - Cleaning up... 05:01:41 INFO - Return code: 0 05:01:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:41 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 05:01:41 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 05:01:41 INFO - Using env: {'DISPLAY': ':0', 05:01:41 INFO - 'HOME': '/home/cltbld', 05:01:41 INFO - 'LANG': 'en_US.UTF-8', 05:01:41 INFO - 'LANGUAGE': 'en_US:en', 05:01:41 INFO - 'LOGNAME': 'cltbld', 05:01:41 INFO - 'MAIL': '/var/mail/cltbld', 05:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:41 INFO - 'MOZ_NO_REMOTE': '1', 05:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:41 INFO - 'NO_EM_RESTART': '1', 05:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:41 INFO - 'SHELL': '/bin/bash', 05:01:41 INFO - 'SHLVL': '1', 05:01:41 INFO - 'TERM': 'linux', 05:01:41 INFO - 'TMOUT': '86400', 05:01:41 INFO - 'USER': 'cltbld', 05:01:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:41 INFO - '_': '/tools/buildbot/bin/python'} 05:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:41 INFO - Downloading/unpacking psutil>=0.7.1 05:01:41 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 05:01:41 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 05:01:41 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 05:01:41 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 05:01:41 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 05:01:41 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 05:01:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:43 INFO - Installing collected packages: psutil 05:01:43 INFO - Running setup.py install for psutil 05:01:43 INFO - building 'psutil._psutil_linux' extension 05:01:43 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 05:01:43 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 05:01:43 INFO - building 'psutil._psutil_posix' extension 05:01:43 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 05:01:43 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 05:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:43 INFO - Successfully installed psutil 05:01:43 INFO - Cleaning up... 05:01:43 INFO - Return code: 0 05:01:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:43 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:43 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 05:01:43 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 05:01:43 INFO - Using env: {'DISPLAY': ':0', 05:01:43 INFO - 'HOME': '/home/cltbld', 05:01:43 INFO - 'LANG': 'en_US.UTF-8', 05:01:43 INFO - 'LANGUAGE': 'en_US:en', 05:01:43 INFO - 'LOGNAME': 'cltbld', 05:01:43 INFO - 'MAIL': '/var/mail/cltbld', 05:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:43 INFO - 'MOZ_NO_REMOTE': '1', 05:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:43 INFO - 'NO_EM_RESTART': '1', 05:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:43 INFO - 'SHELL': '/bin/bash', 05:01:43 INFO - 'SHLVL': '1', 05:01:43 INFO - 'TERM': 'linux', 05:01:43 INFO - 'TMOUT': '86400', 05:01:43 INFO - 'USER': 'cltbld', 05:01:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:43 INFO - '_': '/tools/buildbot/bin/python'} 05:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:01:44 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 05:01:44 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 05:01:44 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 05:01:44 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 05:01:44 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 05:01:44 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 05:01:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:01:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:01:45 INFO - Installing collected packages: mozsystemmonitor 05:01:45 INFO - Running setup.py install for mozsystemmonitor 05:01:45 INFO - Successfully installed mozsystemmonitor 05:01:45 INFO - Cleaning up... 05:01:45 INFO - Return code: 0 05:01:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:45 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:45 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 05:01:45 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 05:01:45 INFO - Using env: {'DISPLAY': ':0', 05:01:45 INFO - 'HOME': '/home/cltbld', 05:01:45 INFO - 'LANG': 'en_US.UTF-8', 05:01:45 INFO - 'LANGUAGE': 'en_US:en', 05:01:45 INFO - 'LOGNAME': 'cltbld', 05:01:45 INFO - 'MAIL': '/var/mail/cltbld', 05:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:45 INFO - 'MOZ_NO_REMOTE': '1', 05:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:45 INFO - 'NO_EM_RESTART': '1', 05:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:45 INFO - 'SHELL': '/bin/bash', 05:01:45 INFO - 'SHLVL': '1', 05:01:45 INFO - 'TERM': 'linux', 05:01:45 INFO - 'TMOUT': '86400', 05:01:45 INFO - 'USER': 'cltbld', 05:01:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:45 INFO - '_': '/tools/buildbot/bin/python'} 05:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:01:46 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 05:01:46 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 05:01:46 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 05:01:46 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 05:01:46 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 05:01:46 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 05:01:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:01:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:48 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 05:01:48 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 05:01:48 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 05:01:48 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 05:01:48 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 05:01:48 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 05:01:48 INFO - Downloading docopt-0.6.1.tar.gz 05:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:48 INFO - Running setup.py install for blobuploader 05:01:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:01:48 INFO - Running setup.py install for requests 05:01:49 INFO - Running setup.py install for docopt 05:01:49 INFO - Successfully installed blobuploader requests docopt 05:01:49 INFO - Cleaning up... 05:01:49 INFO - Return code: 0 05:01:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01: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')]} 05:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:49 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:49 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 05:01:49 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 05:01:49 INFO - Using env: {'DISPLAY': ':0', 05:01:49 INFO - 'HOME': '/home/cltbld', 05:01:49 INFO - 'LANG': 'en_US.UTF-8', 05:01:49 INFO - 'LANGUAGE': 'en_US:en', 05:01:49 INFO - 'LOGNAME': 'cltbld', 05:01:49 INFO - 'MAIL': '/var/mail/cltbld', 05:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:49 INFO - 'MOZ_NO_REMOTE': '1', 05:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:49 INFO - 'NO_EM_RESTART': '1', 05:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:49 INFO - 'SHELL': '/bin/bash', 05:01:49 INFO - 'SHLVL': '1', 05:01:49 INFO - 'TERM': 'linux', 05:01:49 INFO - 'TMOUT': '86400', 05:01:49 INFO - 'USER': 'cltbld', 05:01:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:49 INFO - '_': '/tools/buildbot/bin/python'} 05:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:49 INFO - Running setup.py (path:/tmp/pip-75V2a3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:49 INFO - Running setup.py (path:/tmp/pip-4wGMNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:49 INFO - Running setup.py (path:/tmp/pip-y9mtzf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:49 INFO - Running setup.py (path:/tmp/pip-rt9hfw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:49 INFO - Running setup.py (path:/tmp/pip-sCvxlG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:49 INFO - Running setup.py (path:/tmp/pip-dxa820-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:49 INFO - Running setup.py (path:/tmp/pip-kUgvo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:49 INFO - Running setup.py (path:/tmp/pip-cq3BDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:49 INFO - Running setup.py (path:/tmp/pip-I9Yfrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:50 INFO - Running setup.py (path:/tmp/pip-B1dUYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:50 INFO - Running setup.py (path:/tmp/pip-SEstVH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:50 INFO - Running setup.py (path:/tmp/pip-w20DcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:50 INFO - Running setup.py (path:/tmp/pip-DeeVGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:50 INFO - Running setup.py (path:/tmp/pip-WrkRKr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:50 INFO - Running setup.py (path:/tmp/pip-Ee4aXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:50 INFO - Running setup.py (path:/tmp/pip-NeSqwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:50 INFO - Running setup.py (path:/tmp/pip-I6HEkm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:50 INFO - Running setup.py install for manifestparser 05:01:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:01:50 INFO - Running setup.py install for mozcrash 05:01:50 INFO - Running setup.py install for mozdebug 05:01:50 INFO - Running setup.py install for mozdevice 05:01:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Running setup.py install for mozfile 05:01:51 INFO - Running setup.py install for mozhttpd 05:01:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Running setup.py install for mozinfo 05:01:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Running setup.py install for mozInstall 05:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Running setup.py install for mozleak 05:01:51 INFO - Running setup.py install for mozlog 05:01:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Running setup.py install for moznetwork 05:01:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:01:51 INFO - Running setup.py install for mozprocess 05:01:51 INFO - Running setup.py install for mozprofile 05:01:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:01:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:01:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:01:52 INFO - Running setup.py install for mozrunner 05:01:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:01:52 INFO - Running setup.py install for mozscreenshot 05:01:52 INFO - Running setup.py install for moztest 05:01:52 INFO - Running setup.py install for mozversion 05:01:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:52 INFO - Cleaning up... 05:01:52 INFO - Return code: 0 05:01:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:52 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 05:01:52 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 05:01:52 INFO - Using env: {'DISPLAY': ':0', 05:01:52 INFO - 'HOME': '/home/cltbld', 05:01:52 INFO - 'LANG': 'en_US.UTF-8', 05:01:52 INFO - 'LANGUAGE': 'en_US:en', 05:01:52 INFO - 'LOGNAME': 'cltbld', 05:01:52 INFO - 'MAIL': '/var/mail/cltbld', 05:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:52 INFO - 'MOZ_NO_REMOTE': '1', 05:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:52 INFO - 'NO_EM_RESTART': '1', 05:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:52 INFO - 'SHELL': '/bin/bash', 05:01:52 INFO - 'SHLVL': '1', 05:01:52 INFO - 'TERM': 'linux', 05:01:52 INFO - 'TMOUT': '86400', 05:01:52 INFO - 'USER': 'cltbld', 05:01:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:52 INFO - '_': '/tools/buildbot/bin/python'} 05:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:52 INFO - Running setup.py (path:/tmp/pip-60r9eS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:52 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)) 05:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:52 INFO - Running setup.py (path:/tmp/pip-8UO_HJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:52 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)) 05:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:52 INFO - Running setup.py (path:/tmp/pip-fLk7KQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:52 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)) 05:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:52 INFO - Running setup.py (path:/tmp/pip-r2flQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:52 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)) 05:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:52 INFO - Running setup.py (path:/tmp/pip-Tl2IZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:53 INFO - Running setup.py (path:/tmp/pip-itUPAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:53 INFO - Running setup.py (path:/tmp/pip-bQmlQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:53 INFO - Running setup.py (path:/tmp/pip-IrzPGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:53 INFO - Running setup.py (path:/tmp/pip-Yb8iwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:53 INFO - Running setup.py (path:/tmp/pip-6WmBBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:53 INFO - Running setup.py (path:/tmp/pip-gaOQ53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:53 INFO - Running setup.py (path:/tmp/pip-U8KiBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:53 INFO - Running setup.py (path:/tmp/pip-322iKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:53 INFO - Running setup.py (path:/tmp/pip-ggElCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:53 INFO - Running setup.py (path:/tmp/pip-AqsFQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:53 INFO - Running setup.py (path:/tmp/pip-C6E7DZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:53 INFO - Running setup.py (path:/tmp/pip-QPwqwG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:53 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)) 05:01:53 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)) 05:01:53 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)) 05:01:53 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)) 05:01:53 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)) 05:01:53 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)) 05:01:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:55 INFO - Downloading blessings-1.5.1.tar.gz 05:01:55 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 05:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:55 INFO - Installing collected packages: blessings 05:01:55 INFO - Running setup.py install for blessings 05:01:55 INFO - Successfully installed blessings 05:01:55 INFO - Cleaning up... 05:01:55 INFO - Return code: 0 05:01:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:01:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:01:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:01:56 INFO - Reading from file tmpfile_stdout 05:01:56 INFO - Current package versions: 05:01:56 INFO - argparse == 1.2.1 05:01:56 INFO - blessings == 1.5.1 05:01:56 INFO - blobuploader == 1.2.4 05:01:56 INFO - docopt == 0.6.1 05:01:56 INFO - manifestparser == 1.1 05:01:56 INFO - mozInstall == 1.12 05:01:56 INFO - mozcrash == 0.16 05:01:56 INFO - mozdebug == 0.1 05:01:56 INFO - mozdevice == 0.47 05:01:56 INFO - mozfile == 1.2 05:01:56 INFO - mozhttpd == 0.7 05:01:56 INFO - mozinfo == 0.9 05:01:56 INFO - mozleak == 0.1 05:01:56 INFO - mozlog == 3.1 05:01:56 INFO - moznetwork == 0.27 05:01:56 INFO - mozprocess == 0.22 05:01:56 INFO - mozprofile == 0.28 05:01:56 INFO - mozrunner == 6.11 05:01:56 INFO - mozscreenshot == 0.1 05:01:56 INFO - mozsystemmonitor == 0.0 05:01:56 INFO - moztest == 0.7 05:01:56 INFO - mozversion == 1.4 05:01:56 INFO - psutil == 3.1.1 05:01:56 INFO - requests == 1.2.3 05:01:56 INFO - wsgiref == 0.1.2 05:01:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:56 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')]} 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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')]} 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:56 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 05:01:56 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 05:01:56 INFO - Using env: {'DISPLAY': ':0', 05:01:56 INFO - 'HOME': '/home/cltbld', 05:01:56 INFO - 'LANG': 'en_US.UTF-8', 05:01:56 INFO - 'LANGUAGE': 'en_US:en', 05:01:56 INFO - 'LOGNAME': 'cltbld', 05:01:56 INFO - 'MAIL': '/var/mail/cltbld', 05:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:56 INFO - 'MOZ_NO_REMOTE': '1', 05:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:56 INFO - 'NO_EM_RESTART': '1', 05:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:56 INFO - 'SHELL': '/bin/bash', 05:01:56 INFO - 'SHLVL': '1', 05:01:56 INFO - 'TERM': 'linux', 05:01:56 INFO - 'TMOUT': '86400', 05:01:56 INFO - 'USER': 'cltbld', 05:01:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:56 INFO - '_': '/tools/buildbot/bin/python'} 05:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 INFO - Cleaning up... 05:01:56 INFO - Return code: 0 05:01:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:01:56 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')]} 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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')]} 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01:56 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 05:01:56 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 05:01:56 INFO - Using env: {'DISPLAY': ':0', 05:01:56 INFO - 'HOME': '/home/cltbld', 05:01:56 INFO - 'LANG': 'en_US.UTF-8', 05:01:56 INFO - 'LANGUAGE': 'en_US:en', 05:01:56 INFO - 'LOGNAME': 'cltbld', 05:01:56 INFO - 'MAIL': '/var/mail/cltbld', 05:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:56 INFO - 'MOZ_NO_REMOTE': '1', 05:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:56 INFO - 'NO_EM_RESTART': '1', 05:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:56 INFO - 'SHELL': '/bin/bash', 05:01:56 INFO - 'SHLVL': '1', 05:01:56 INFO - 'TERM': 'linux', 05:01:56 INFO - 'TMOUT': '86400', 05:01:56 INFO - 'USER': 'cltbld', 05:01:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:56 INFO - '_': '/tools/buildbot/bin/python'} 05:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:56 INFO - Downloading/unpacking jsonschema 05:01:56 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 05:01:56 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 05:01:56 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 05:01:56 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 05:01:56 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 05:01:56 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 05:01:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:58 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 05:01:58 INFO - Downloading/unpacking functools32 (from jsonschema) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:58 INFO - warning: no files found matching '*.txt' 05:01:58 INFO - no previously-included directories found matching 'build' 05:01:58 INFO - no previously-included directories found matching 'dist' 05:01:58 INFO - no previously-included directories found matching '.git*' 05:01:58 INFO - Installing collected packages: jsonschema, functools32 05:01:58 INFO - Running setup.py install for functools32 05:01:58 INFO - warning: no files found matching '*.txt' 05:01:58 INFO - no previously-included directories found matching 'build' 05:01:58 INFO - no previously-included directories found matching 'dist' 05:01:58 INFO - no previously-included directories found matching '.git*' 05:01:58 INFO - Successfully installed jsonschema functools32 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:01: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')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65d44dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', '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 05:01: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', 'flake8'] in /builds/slave/test-pgo/build 05:01: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 flake8 05:01:58 INFO - Using env: {'DISPLAY': ':0', 05:01:58 INFO - 'HOME': '/home/cltbld', 05:01:58 INFO - 'LANG': 'en_US.UTF-8', 05:01:58 INFO - 'LANGUAGE': 'en_US:en', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MAIL': '/var/mail/cltbld', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SHLVL': '1', 05:01:58 INFO - 'TERM': 'linux', 05:01:58 INFO - 'TMOUT': '86400', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - '_': '/tools/buildbot/bin/python'} 05:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:58 INFO - Downloading/unpacking flake8 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:02:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:02:00 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 05:02:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:02:00 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 05:02:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:00 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 05:02:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:01 INFO - no previously-included directories found matching 'docs/_build' 05:02:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:02:01 INFO - Running setup.py install for pep8 05:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:01 INFO - no previously-included directories found matching 'docs/_build' 05:02:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:02:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:02:01 INFO - Cleaning up... 05:02:01 INFO - Return code: 0 05:02:01 INFO - Running post-action listener: _resource_record_post_action 05:02:01 INFO - Running post-action listener: _start_resource_monitoring 05:02:01 INFO - Starting resource monitoring. 05:02:01 INFO - ##### 05:02:01 INFO - ##### Running install step. 05:02:01 INFO - ##### 05:02:01 INFO - Running pre-action listener: _resource_record_pre_action 05:02:01 INFO - Running main action method: install 05:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:02:01 INFO - Reading from file tmpfile_stdout 05:02:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:02:01 INFO - Reading from file tmpfile_stdout 05:02:01 INFO - Output received: 05:02:01 INFO - Usage: mozinstall [options] installer 05:02:01 INFO - Options: 05:02:01 INFO - -h, --help show this help message and exit 05:02:01 INFO - -d DEST, --destination=DEST 05:02:01 INFO - Directory to install application into. [default: 05:02:01 INFO - "/builds/slave/test-pgo"] 05:02:01 INFO - --app=APP Application being installed. [default: firefox] 05:02:01 INFO - mkdir: /builds/slave/test-pgo/build/application 05:02:01 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'] 05:02:01 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 05:02:17 INFO - Reading from file tmpfile_stdout 05:02:17 INFO - Output received: 05:02:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:02:17 INFO - Running post-action listener: _resource_record_post_action 05:02:17 INFO - ##### 05:02:17 INFO - ##### Running run-tests step. 05:02:17 INFO - ##### 05:02:17 INFO - Running pre-action listener: _resource_record_pre_action 05:02:17 INFO - Running main action method: run_tests 05:02:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:02:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:02:17 INFO - Python 2.7.3 05:02:17 INFO - Return code: 0 05:02:17 INFO - grabbing minidump binary from tooltool 05:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:17 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 0x1cf9840>, '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 0x1c666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:02:17 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 05:02:17 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 05:02:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:17 INFO - Return code: 0 05:02:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:02:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:02:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:02:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:02:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:02:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:02:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:02:18 INFO - Return code: 0 05:02:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:02:18 INFO - Using env: {'DISPLAY': ':0', 05:02:18 INFO - 'HOME': '/home/cltbld', 05:02:18 INFO - 'LANG': 'en_US.UTF-8', 05:02:18 INFO - 'LANGUAGE': 'en_US:en', 05:02:18 INFO - 'LOGNAME': 'cltbld', 05:02:18 INFO - 'MAIL': '/var/mail/cltbld', 05:02:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:02:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:18 INFO - 'MOZ_NO_REMOTE': '1', 05:02:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:18 INFO - 'NO_EM_RESTART': '1', 05:02:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:02:18 INFO - 'SHELL': '/bin/bash', 05:02:18 INFO - 'SHLVL': '1', 05:02:18 INFO - 'TERM': 'linux', 05:02:18 INFO - 'TMOUT': '86400', 05:02:18 INFO - 'USER': 'cltbld', 05:02:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202', 05:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:18 INFO - '_': '/tools/buildbot/bin/python'} 05:02:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:02:19 INFO - mozversion application_buildid: 20160111023004 05:02:19 INFO - mozversion application_changeset: eea6896314ef30abaddf87100ee1b8e188c67508 05:02:19 INFO - mozversion application_display_name: Nightly 05:02:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:19 INFO - mozversion application_name: Firefox 05:02:19 INFO - mozversion application_remotingname: firefox 05:02:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:02:19 INFO - mozversion application_vendor: Mozilla 05:02:19 INFO - mozversion application_version: 46.0a1 05:02:19 INFO - mozversion platform_buildid: 20160111023004 05:02:19 INFO - mozversion platform_changeset: eea6896314ef30abaddf87100ee1b8e188c67508 05:02:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:02:19 INFO - mozversion platform_version: 46.0a1 05:02:19 INFO - using testdate: 1452517339 05:02:19 INFO - actual date: 1452517339 05:02:19 INFO - starting webserver on 'localhost:41128' 05:02:19 INFO - SUITE-START | Running 3 tests 05:02:19 INFO - TEST-START | dromaeo_css 05:02:19 INFO - operating with platform_type : linux_ 05:02:19 INFO - Initialising browser for dromaeo_css test... 05:02:19 INFO - TEST-INFO | started process 6029 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzbQyiw/profile http://localhost:41128/getInfo.html) 05:02:23 INFO - PROCESS | 6029 | __metrics Screen width/height:1600/1200 05:02:23 INFO - PROCESS | 6029 | colorDepth:24 05:02:23 INFO - PROCESS | 6029 | Browser inner width/height: 1024/697 05:02:23 INFO - PROCESS | 6029 | __metrics 05:02:23 INFO - PROCESS | 6029 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:02:23 INFO - PROCESS | 6029 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:24 INFO - TEST-INFO | 6029: exit 0 05:02:24 INFO - Browser initialized. 05:02:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:24 INFO - TEST-INFO | started process 6123 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzbQyiw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:36 INFO - PROCESS | 6123 | RSS: Main: 148754432 05:02:36 INFO - PROCESS | 6123 | 05:03:28 INFO - PROCESS | 6123 | 1452517408084 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] 05:05:36 INFO - PROCESS | 6123 | Cycle 1(1): loaded http://localhost:41128/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41128/tests/dromaeo/cssquery-ext.html) 05:05:37 INFO - PROCESS | 6123 | RSS: Main: 249856000 05:05:37 INFO - PROCESS | 6123 | 05:08:39 INFO - PROCESS | 6123 | Cycle 1(1): loaded http://localhost:41128/tests/dromaeo/cssquery-ext.html (next: http://localhost:41128/tests/dromaeo/cssquery-jquery.html) 05:08:40 INFO - PROCESS | 6123 | RSS: Main: 231243776 05:08:40 INFO - PROCESS | 6123 | 05:11:42 INFO - PROCESS | 6123 | Cycle 1(1): loaded http://localhost:41128/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41128/tests/dromaeo/cssquery-mootools.html) 05:11:42 INFO - PROCESS | 6123 | RSS: Main: 251129856 05:11:42 INFO - PROCESS | 6123 | 05:14:44 INFO - PROCESS | 6123 | Cycle 1(1): loaded http://localhost:41128/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41128/tests/dromaeo/cssquery-prototype.html) 05:14:45 INFO - PROCESS | 6123 | RSS: Main: 211902464 05:14:45 INFO - PROCESS | 6123 | 05:17:47 INFO - PROCESS | 6123 | Cycle 1(1): loaded http://localhost:41128/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41128/tests/dromaeo/cssquery-yui.html) 05:17:48 INFO - PROCESS | 6123 | RSS: Main: 219406336 05:17:48 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | Cycle 1(1): loaded http://localhost:41128/tests/dromaeo/cssquery-yui.html (next: http://localhost:41128/tests/dromaeo/cssquery-dojo.html) 05:20:51 INFO - PROCESS | 6123 | RSS: Main: 256229376 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | __start_tp_report 05:20:51 INFO - PROCESS | 6123 | _x_x_mozilla_page_load 05:20:51 INFO - PROCESS | 6123 | _x_x_mozilla_page_load_details 05:20:51 INFO - PROCESS | 6123 | |i|pagename|runs| 05:20:51 INFO - PROCESS | 6123 | |0;dojo.html;3030.545418187272;3072.6620071792113;3118.2360321721167;3123.6407813101487;3148.5906832111823;4965.453800081988;5021.271915572244;5042.697438153708;5072.644914855957;5087.211482220262;4964.304997300372;5046.495350464952;5062.594992400599;5098.388193416795;5115.744212789355;4596.172688915985;4596.770161491929;4633.050224703928;4664.790084446191;4715.457722361938;4700.670953033289;4702.694324868889;4738.19450693383;4755.072760811643;4767.046590681877;4571.725696458223;4625.653076019312;4666.2767271073035;4733.526647335273;4734.053189362141;4673.158831410345;4685;4691.014886873761;4737.697133288339;4743.146233677937;4658.557437043475;4667.533246675339;4683.227267500858;4683.484816670163;4736.194846876039;4796.3524924135145;4814.75926203692;4874.65877388583;4929.728864912428;4944.728039957801;5435.891282174374;5449.482299181572;5451.909618076401;5456.563474922036;5458.727063646802;5463.421458944398;5467.863303417406;5469.808556700536;5469.835904922858;5499.257600223958;4942.802287908516;5046.924296135524;5137.537621614036;5142.974285128588;5144.356955380577;5601.411851755507;5604.6917419542315;5611.382747897728;5618.6628802272;5625.887482250332;5395.73021348931;5403.891922161613;5406.972965135228;5411.404745477994;5414.025475414384;5300.602454815904;5353.1167357386375;5413.783448662089;5488.17677348401;5511.090670039479;5412.945870541323;5480.671159730429;5504.944950550524;5519.862003449865;5531.3362396511875;5348.786048558014;5351.625386223005;5364.91952620711;5365.517103460707;5372.167314066326;4118.444010058603;4240.045989652303;4240.1307731914885;4269.914601707948;4272.252355837716;3748.269087527906;3800.201957588882;3830.4254361845387;3832.693384529231;3847.03824043989;4988.12707776145;4998.6750861193905;4998.825041123543;5003.54968052877;5021.924671129936;5218.556422704037;5397.190421436816;5404.648697834628;5416.945830541723;5466.753996070186;4917.901641967141;4941.036497882878;4945.134601444733;5011.699298042129;5034.06869729094;4675.812967481263;4706.576408123286;4713.9764301178275;4718.292256161534;4753.35829662998;5576.86057848557;5584.664920104726;5588.524975377139;5593.916091258634;5595.524380427628;5336.7598458068705;5353.4646535346155;5444.891102177855;5452.809151679672;5462.426445223195;5545.528630066489;5575.080111781673;5575.944240557543;5581.944180558143;5593.384727680033;5390.541803946551;5392.568594512508;5393.757280922289;5412.864678383072;5458.5087342139395;5320.627556071038;5371.301730774974;5376.327959005124;5423.186522021729;5454.154606036071;5304.575633949197;5339.439358867263;5342.492463215988;5349.812756553502;5369.382521010134;5309.177077552986;5317.361916570037;5318.255444237887;5325.946740532545;5374.140137577969;5108;5142.97428512855;5222.55608273301;5225.712585807665;5230.790768369375;5343.332083489564;5344.9732751336;5345.1714984177515;5365.463453654604;5384.7576859040655;5243.370795504564;5249.317588713443;5252.763625636932;5254.133068043883;5258.710770907637 05:20:51 INFO - PROCESS | 6123 | |1;ext.html;523.5262087810531;535.9303290572223;553.0321936610931;574.6810520161309;583.9314055278841;30205.697943020565;36436.271274574494;37018.814905925436;37109;37134.07164820874;39779.60220397802;40489.19021619573;40497.392539111934;40505;40532;7239.457040721941;8366.372522060825;8576.957115214414;8579.099194584573;8579.227869491744;7289.708411663553;9987.950060249725;10105.343152695052;10154;10203;9904.950475247613;10010.099091081802;10027.699169024905;10028.699139025804;10031.347962382459;7226.060612120391;7384.261573842627;9876.851847222297;9961.103500684936;9969.75075623108;9803.656872009517;9936.90063099367;9939.900600994042;9941.602335906555;9943.801123977551;35314;35979.64020359789;35981.820090899375;36013.27973440543;36075.278494430226;3248.4640034394297;3347.6317605063423;3538.3661832155694;3574.696150827183;3801.4487899254455;28020.43959120806;30291.545626815616;30401;30588.694113058806;30904.53643195354;3982.6216509431556;3999.8000099994883;4043.2317859606583;4120.690948178869;4123.278426275389;283965.2827773773;285053;285147;286386;393462;45625;60040;61023.69488152619;61444.38555614387;61451.6927415369;53780;54341.72829135908;54500;54539;54583;14590.927045364706;14732.337044833008;14784.704305913821;14786.112833229825;14845.109293442429;11172.273802202993;11311.660650180507;11368.03371713397;11440.94279528597;11527.827082593767;19604.82371057741;19921.605487616016;19955.900220499094;19971.700424493643;20011.59976800485;7320.450966177558;7481.962590187014;7599.924000760032;7620.923790762133;7707.342921271954;924.6024209589806;987.456898705709;1004.9247305383316;1060.1412855587;1119.1829964126234;28707.712922870505;28919.277018074717;29163.8555300679;29534.261643459085;29715.851420742758;1044.300318786415;1063.7978784031009;1085.7448499602588;1090.487470888681;1110.3504449896739;13915.930420348035;13924.721505569833;13946.16323020622;14013.089149205269;14177.22025288619;318260;323074;323683;324283;324720;50968.23547646788;51314.46056618307;51334;51359.22961155586;51390.48609513857;1338.6051114921122;1347.5148946379295;1352.499575157198;1353.7360214758028;1365.692719138166;27015.864920676056;28088;28090.157295281173;28099.71900281053;29643.555346670248;43737.78131109324;43814.34278485762;44497.77751111224;48940;50119.24821127759;203243;204554;205762;205980;206247;27834;28490.287742806595;28653.426931461672;28868.422631546833;28924.855375722986;31199;32540.18649533686;39068;40671.796641016605;41534.169316614105;33800.3239935195;34381;34797.652023479444;35039.47440788339;35243.47134793032;35464.290714186085;36596.63403365932;36682.44976325411;37234.765914045245;40428.59571404248;34957;35133.47299790556;35201.1199720009;36216.81891590525;36332.81833590815;28428.289292767848;29340.266493337836;30166.09501714952;30291.08974103181;30418.239544010692;24473.755262447146;24589.262322130366;24739.562544902925;24832.130875419272;24924.626130607692 05:20:51 INFO - PROCESS | 6123 | |2;jquery.html;349.0558040500446;349.4967247164084;354.03878469954077;354.6418117701121;354.69141846593453;13330.866691333084;13745.03784735069;15789.921050394747;15886.84113158868;16674.166291685397;15061;15114.319855606496;15695.60760980976;15775.84224157758;15803.288852001659;5074.873128171797;5306.946930530703;5510.228568000463;5540.9168862467095;5542.612017158801;3750.8124593770203;3913.236918800835;5305.495977882095;5435.565154787627;5507.5593952483705;5261.763220655061;5467.152591348327;5467.507924286813;5496.983058134258;5505.807296744615;5498.532624726883;5511.476409741068;5519.420460851633;5537.861553461175;5539;5121.129408000649;5255.080360936859;5263.894722105575;5268;5304.469553044703;18549.721754173697;18626.90686546572;18970.05149742521;19261.51846203842;19308.4207473776;2117.6929345245007;2156.4932240923526;2207.9668804967937;2257.6500642400456;2310.6649535817382;9343.392679475812;9349.76625584359;9414.764630884214;9709.077637624414;9743.464109473976;1836.5592257858152;1852.110986726379;1863.7856646485693;1873.5878106816615;1885.8868467891832;53249.2012619811;53676.73161634167;54638.18042729362;54937.1759423609;54992.72503637496;9703.708888733348;9893.258005649604;9909.355891867006;9981.650642227487;10038.899611003797;12686.365681715877;12730.618081457571;12735.981121510256;12837.52368477637;12893.290869002294;7317.389267164381;7323.853522929511;7515.849683006419;7519.8496030079095;7574;7254.673539690727;7260.709571617076;7290.671919763623;7304.342609165201;7325.5970921598755;3880.7865567394065;4198.9370159447635;4269.380939763717;4307.8492252771;4333.804978775963;1705.9914700426418;1744.7121224997986;1754.561359660085;1771.9025453599918;1772.485979066082;868.2966796894535;910.5083255042204;957.9616815327448;993.3940296419179;1028.3793137545704;15594.844051559567;15835;15916.840831591768;16231;16249.837501624832;941.1717688434271;951.9048095190426;962.4754508792724;978.8189185000798;998.0269237493386;7655.46411751172;8986.955065224633;9128.634854605742;9316.534173291308;9326.487043212688;363607;367420;367936;368456;403743;55273;61250;62247.6887615559;64168.67915660392;64497.355026449135;1015.57345914716;1051.4269723000982;1116.9385683787307;1175.2595864605414;1177.3936422742295;13213.42747429704;14033.438662453796;14771.556853294418;14805;15019.624509387353;30665.693343066283;30930;31227.84386078055;32768;34266.48600271048;42437.78781106075;42740;44401.33397999097;44416.333754994346;45823;7098.929010709827;7166.749163779451;7253.165885923187;7339.669714862737;7395.445341599294;9495.19290860257;9687.66093186735;10025.298229123891;10031.949840251043;10186.898131018892;8560.14398560139;8868.131976980492;8953.865692014755;8984.505852177932;9207.447553146565;9361.4383137012;9422.95288523553;9532.809343813224;9542.85685714701;9682.70951871445;9052.592633331384;9187.173154416134;9238.815223695623;9448.149666530046;9792.314537982273;6705.698243578953;7202.71189152428;7217.133943926552;7253.274672532704;7254.709811607477;7849.411294153076;9573.952130239304;9596.088371604686;9624.230061594915;9655.806883862424 05:20:51 INFO - PROCESS | 6123 | |3;mootools.html;1282.6152154353692;1415.3489394878357;1420.4389266239837;1552.518719197049;1763.5150333658241;6650.235222949356;7111.573305601668;7294;7301.817454563638;7303.6348182590855;7191.460640451974;7324.63376831159;7353.77938661841;7364.77905662831;7367.705291788336;1951.375559820858;1994.0827219479056;2190.113004233288;2271.3980795089315;2299.0803678528555;2234.8323875709307;2241.383619504633;2242.0247192471247;2243.349428665685;2244.259394399844;2146.6350720377495;2260.1863329201474;2274.1585613323095;2274.8521346112534;2277.39648993017;2174.56508698261;2209.569134018859;2213.4687674958054;2231.2079211879873;2234.575430668168;2193.9890300548554;2210.6794514795265;2218.4232099654046;2223.7665045170347;2251.808596269319;7444.36722878556;7491.288327608869;7503.924960750377;7505.1369092554505;7523.887141692824;4617.422822147231;4765.761711914391;4776.164171270014;4782.0914026334885;4784.30627559002;3015.7738169637364;3090.134762266569;3120.4851199552045;3137.9372412551847;3165.2561648012697;954.494118117392;976.9706908792748;994.3785134291068;1033.1218464305355;1053.1048608682636;9996.800063998751;10139.340942838691;10227.897721022844;10239.539220735085;10242.129418999393;4088.5298190707854;4226.788660567021;4240.893977650521;4257.297545904891;4284.078923031563;8082.393820463371;8101.149379315087;8115.472494287852;8126.39052071097;8130.918690813016;4634.420697412824;4723.598494128038;4728.929066064012;4730.834420795256;4739.099571081483;4329.09089091288;4329.783510824446;4330;4332.935005974913;4334.674899382559;3184.1880320518585;3222.4360736870954;3246.3020450603235;3369.0735047861544;3441.0365097772665;933.808569243317;941.4539567051094;964.2045312616979;982.2976571751232;1024.6772266735954;1314.3362601885985;1317.7101037771674;1326.7943468762357;1333.8666133386585;1361.754884120848;6782.423494002966;6795.048693182958;6802;6802.081718967975;6972.651367431608;1098.7143342730787;1104.0852150323153;1104.1442881766695;1107.2028139739375;1134.3647557367901;5600.159976003632;5663.150527420919;5679.204911312419;5681.602287839894;5686.147077938343;8906.554672266491;8960.955195223982;9026.277897768163;9045.638174473079;9188.724338269863;8978;8987.640494380152;9070.18368346852;9087.045860184717;9088.681896133603;6954.687039083254;7066.787996360117;7114.50198486101;7184.497085203986;7233.710651573878;6842.55523390978;6853.588784672936;6880.415164711056;6882.277360877236;6890.345417185359;7897.921020789719;8115.1479094694205;8131.430799843954;8242.917570824215;8254.42219044685;8196.959015204886;8328.708495202638;8364.874526882224;8371.706990255312;8532.317414606692;6401.8719625608155;6512.511561632802;6790.151231096113;6976.581405115507;6991.196012458632;6500.642464664489;6622.437092847162;6905.551139175937;7062.964685176541;7063.364297213276;6541.672916354259;6568.1789776277965;6680.565763225375;6817.250102488623;6850.280720524273;6548.050532672831;6573.704183311858;6607.7356905725155;6729.629870356982;6746.089277947414;6707.228668703162;6729.259781424137;6734.56225345351;6744.966275168593;6752.358525940028;6169.96915015422;6189.133521307111;6372.553921225655;6409.4231519163495;6413.743450261937;6311.779087731908;6342.334054924167;6350.174477317919;6351.2696039956;6352.968235158794 05:20:51 INFO - PROCESS | 6123 | |4;prototype.html;320.1069017441339;326.88232236394896;327.58724007750243;334.67202141900935;336.96630336966297;5833.416658334165;5842.328132264791;5858.355580886099;5859.414058594139;5878.088896221093;5608.551315894729;5659.51894089003;5746.569007324447;5781.017227071397;5796.333421656511;4499.865004049884;4506.121306345264;4518.751468669222;4519.887002824923;4546.8408605698805;4317.43873296471;4521.796519156645;4522.253828118356;4528.682992190548;4530.184566777979;4353.064091220387;4362.760048197348;4457.242268814293;4459.331100334959;4471.66462515311;4434.201843668138;4438.977805110986;4443.4445694288215;4445.177642136216;4446.97776511117;3932.6067393260732;3943.369060950234;3945.60543945606;3953.743006704555;3961.3859851723028;5477.3427188737205;5605.5515558755205;5608.2428872102155;5621.269234999424;5624.3813180550105;5221.921671174935;5228.111221092386;5230.92153617696;5231.60762942777;5232.843014709565;6130.141780150782;6154.938450615481;6156.6613836238985;6159.137720719103;6160.969195153995;4373.037931655031;4374.0595771908875;4374.978125109354;4376.89057773555;4378.387025816356;6294.779682711083;6435.678216089177;6438.452731517827;6438.710258038353;6449.12936753537;4492.910141797146;4497.392851964943;4499.437570303712;4500.144972455223;4500.144972455289;4555.772211389417;4556.726596404226;4560.8175672973375;4560.885977850514;4561.657875659339;5181.326427564468;5215.530602245816;5226.555742761908;5246.291750613695;5259.263703081571;6058.969705151446;6204.410580994799;6218.875622487525;6224.688765561795;6226.346233645402;1586.698527279813;1599.7680336351398;1600.8239093699683;1602.206907580755;1602.7115119278642;1085.2132204152085;1089.2647462962468;1092.4865313302735;1094.0536435982976;1115.6151127860876;5780.479756821906;5780.624259423124;5780.768769249267;5786;5792.304923409218;6284.43440090385;6357.841053973595;6358.968205158944;6361.2048493938255;6366.649834259068;5658.264425624642;5734.598578099576;5782.277215348082;5900.586958912835;5928.288605367384;3433.5193072969805;3450.1374656335915;3463.0303515015835;3466.791992480459;3468.618451970281;6573.901391479131;6573.901391479131;6575.079488871562;6580.11168492257;6586.077949087132;6394.136791533084;6566.343365663491;6592.208934927839;6611.33886611335;6617.239017512951;6590.934090659128;6592.472602191909;6597.208334999831;6599.703013364506;6606.768763093269;6399.424051835171;6441.677916104082;6448.322926092693;6450.483961282992;6455.548111632328;6171.753129874754;6347.71435285404;6356.555041147075;6359.141515895295;6362.522810789117;6546.083548303337;6563.835904102436;6574.178227721535;6605.075289459575;6615.305392933865;4376.409184760144;4384.145091707086;4387.14450682114;4392.846250381222;4394.692371533962;6288.308286088435;6448.322926092693;6458;6461.450776683847;6461.67691615408;6274.968625156845;6287.905681414874;6289.591176573508;6299.842503937438;6299.874002520016;6235.657038862906;6270.49836013127;6274.435300822765;6280.466160376419;6282.811515654537;5932.406759324033;6143.32423433413;6155.538334625011;6159.384061593984;6163.599366041372;6314.305426403183;6314.8737025258315;6323.557350985387;6325.209348831396;6332.176817013758;6171.13604095418;6177.444030037318;6184.134221209124;6185.536084793568;6188.319284878569 05:20:51 INFO - PROCESS | 6123 | |5;yui.html;736.1476263703559;769.1500891514876;846.2003406780588;852.467207995003;857.987130193047;13210.075294729373;13271;13406.731865362686;13417;13438.932805335971;12425.56510522132;12468.93765531171;12481.25112493251;12496.312702801342;12497.687557811036;660.1945626335862;668.6523008035819;781.8240895798457;792.5007245435382;803.509858986021;796.1361922314296;797.1988151907325;799.312591171592;803.6825453945688;806.1374329467473;833.7623777223492;840.6805413942693;842.2377748137915;842.7176895739904;845.5180547088162;674.8616533610598;681.9863602727943;823.3372135430945;841.1630427724454;842.7050532313702;615.8368032471399;616.202018386191;621.1273161208509;623.2894500269696;623.8877002139614;13026.80459793104;13108.737825243441;13130.277834719087;13201.669958251121;13216;10888.61889833852;11149;11390.886091139148;11466.48400821965;11699;9471.431714097176;9571.808563828685;9614.663486778;9658.823354465863;9685.90314096857;3532.858685652571;3561.3767590671787;3604.9098772530633;3613.0967258185456;3699.72252081095;43297;43741.34387984183;43830.56169438329;44178.33732494015;44191.77904110491;9227.769305767275;9236.815263694689;9693.757656058655;9768.560414781352;10080.04239597237;17482.125893705517;17644.117794110243;17709.911450442924;17724.822751772575;17763.555911102067;7423.369013633902;7498.512596681198;7616.7334143304715;7645.426593005547;7928.6035698214855;4352.7823608819435;4376.868693939187;4389.363542286351;4443.466783985942;4467.396901418332;2941.867615957287;2950.5131653276967;2955.926101847471;2981.4484320400798;2990.551417287424;579.3135134865198;589.5637228450915;599.8530360061812;604.338249616669;609.4849851875158;533.8905524367495;536.4903341825282;600.051917969607;638.6838514935137;687.2337343861658;8156.632951517196;8901.910980890108;9197.218236449842;9204.585793639302;9423.90576094244;466.83427383279127;605.9333473317931;629.1443636654146;660.6927778582982;691.5746815708303;4100.36444351126;4197.4753155855515;4214.241436541452;4393.648508119343;4480.753558554311;51208.74395628073;51629;51688.22467662988;51747;51766.74116629393;48502.757486212344;50961;51230;51819.740901296005;52144.739276304135;47188.5281147191;47457.28814067792;48162;48528.5147148524;49988.50011499839;8783.604737786687;8813.955930220307;8978.371513993958;9018.729438116867;9056.501892395981;33757;33780.493292601124;34690.82654586812;34837.82581087078;35095.12262193466;39806.40290395589;39938.40092398558;42687.57312426836;43227.78386108175;43302.35046474243;10818.945905270739;10892.128629709763;11206.495707693337;11399.316041037233;11594.594189203675;11745.647630571097;11746.76506469883;11940.283582985048;13015.154014988995;13031.02267329973;11053.668389948314;11211.831822522505;11614.593489228175;11654.94172529166;11845.940770296438;10858;11115.555377784798;11195.72010699739;11469.770604587695;11604.30374177552;11470.483828227916;11512.712182195177;11574.537018519164;11655.475503602189;11970.820437693616;9214.493202873638;9529.952350238482;9572.664956726481;9695.757606059906;9896.307258492125;8797.296216302808;9414.340996130206;9494.240460762985;9564.473953932322;9807.509624518889 05:20:51 INFO - PROCESS | 6123 | __end_tp_report 05:20:51 INFO - PROCESS | 6123 | __start_cc_report 05:20:51 INFO - PROCESS | 6123 | _x_x_mozilla_cycle_collect,894 05:20:51 INFO - PROCESS | 6123 | __end_cc_report 05:20:51 INFO - PROCESS | 6123 | __startTimestamp1452518451443__endTimestamp 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | ------- Summary: start ------- 05:20:51 INFO - PROCESS | 6123 | Number of tests: 6 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | [#0] dojo.html Cycles:165 Average:5052.44 Median:5249.32 stddev:537.13 (10.2%) stddev-sans-first:514.82 05:20:51 INFO - PROCESS | 6123 | Values: 3030.5 3072.7 3118.2 3123.6 3148.6 4965.5 5021.3 5042.7 5072.6 5087.2 4964.3 5046.5 5062.6 5098.4 5115.7 4596.2 4596.8 4633.1 4664.8 4715.5 4700.7 4702.7 4738.2 4755.1 4767.0 4571.7 4625.7 4666.3 4733.5 4734.1 4673.2 4685.0 4691.0 4737.7 4743.1 4658.6 4667.5 4683.2 4683.5 4736.2 4796.4 4814.8 4874.7 4929.7 4944.7 5435.9 5449.5 5451.9 5456.6 5458.7 5463.4 5467.9 5469.8 5469.8 5499.3 4942.8 5046.9 5137.5 5143.0 5144.4 5601.4 5604.7 5611.4 5618.7 5625.9 5395.7 5403.9 5407.0 5411.4 5414.0 5300.6 5353.1 5413.8 5488.2 5511.1 5412.9 5480.7 5504.9 5519.9 5531.3 5348.8 5351.6 5364.9 5365.5 5372.2 4118.4 4240.0 4240.1 4269.9 4272.3 3748.3 3800.2 3830.4 3832.7 3847.0 4988.1 4998.7 4998.8 5003.5 5021.9 5218.6 5397.2 5404.6 5416.9 5466.8 4917.9 4941.0 4945.1 5011.7 5034.1 4675.8 4706.6 4714.0 4718.3 4753.4 5576.9 5584.7 5588.5 5593.9 5595.5 5336.8 5353.5 5444.9 5452.8 5462.4 5545.5 5575.1 5575.9 5581.9 5593.4 5390.5 5392.6 5393.8 5412.9 5458.5 5320.6 5371.3 5376.3 5423.2 5454.2 5304.6 5339.4 5342.5 5349.8 5369.4 5309.2 5317.4 5318.3 5325.9 5374.1 5108.0 5143.0 5222.6 5225.7 5230.8 5343.3 5345.0 5345.2 5365.5 5384.8 5243.4 5249.3 5252.8 5254.1 5258.7 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | [#1] ext.html Cycles:180 Average:44360.99 Median:34589.33 stddev:74433.88 (215.2%) stddev-sans-first:74569.91 05:20:51 INFO - PROCESS | 6123 | Values: 523.5 535.9 553.0 574.7 583.9 30205.7 36436.3 37018.8 37109.0 37134.1 39779.6 40489.2 40497.4 40505.0 40532.0 7239.5 8366.4 8577.0 8579.1 8579.2 7289.7 9988.0 10105.3 10154.0 10203.0 9905.0 10010.1 10027.7 10028.7 10031.3 7226.1 7384.3 9876.9 9961.1 9969.8 9803.7 9936.9 9939.9 9941.6 9943.8 35314.0 35979.6 35981.8 36013.3 36075.3 3248.5 3347.6 3538.4 3574.7 3801.4 28020.4 30291.5 30401.0 30588.7 30904.5 3982.6 3999.8 4043.2 4120.7 4123.3 283965.3 285053.0 285147.0 286386.0 393462.0 45625.0 60040.0 61023.7 61444.4 61451.7 53780.0 54341.7 54500.0 54539.0 54583.0 14590.9 14732.3 14784.7 14786.1 14845.1 11172.3 11311.7 11368.0 11440.9 11527.8 19604.8 19921.6 19955.9 19971.7 20011.6 7320.5 7482.0 7599.9 7620.9 7707.3 924.6 987.5 1004.9 1060.1 1119.2 28707.7 28919.3 29163.9 29534.3 29715.9 1044.3 1063.8 1085.7 1090.5 1110.4 13915.9 13924.7 13946.2 14013.1 14177.2 318260.0 323074.0 323683.0 324283.0 324720.0 50968.2 51314.5 51334.0 51359.2 51390.5 1338.6 1347.5 1352.5 1353.7 1365.7 27015.9 28088.0 28090.2 28099.7 29643.6 43737.8 43814.3 44497.8 48940.0 50119.2 203243.0 204554.0 205762.0 205980.0 206247.0 27834.0 28490.3 28653.4 28868.4 28924.9 31199.0 32540.2 39068.0 40671.8 41534.2 33800.3 34381.0 34797.7 35039.5 35243.5 35464.3 36596.6 36682.4 37234.8 40428.6 34957.0 35133.5 35201.1 36216.8 36332.8 28428.3 29340.3 30166.1 30291.1 30418.2 24473.8 24589.3 24739.6 24832.1 24924.6 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | [#2] jquery.html Cycles:180 Average:22296.97 Median:29278.07 stddev:61321.38 (209.4%) stddev-sans-first:61471.26 05:20:51 INFO - PROCESS | 6123 | Values: 349.1 349.5 354.0 354.6 354.7 13330.9 13745.0 15789.9 15886.8 16674.2 15061.0 15114.3 15695.6 15775.8 15803.3 5074.9 5306.9 5510.2 5540.9 5542.6 3750.8 3913.2 5305.5 5435.6 5507.6 5261.8 5467.2 5467.5 5497.0 5505.8 5498.5 5511.5 5519.4 5537.9 5539.0 5121.1 5255.1 5263.9 5268.0 5304.5 18549.7 18626.9 18970.1 19261.5 19308.4 2117.7 2156.5 2208.0 2257.7 2310.7 9343.4 9349.8 9414.8 9709.1 9743.5 1836.6 1852.1 1863.8 1873.6 1885.9 53249.2 53676.7 54638.2 54937.2 54992.7 9703.7 9893.3 9909.4 9981.7 10038.9 12686.4 12730.6 12736.0 12837.5 12893.3 7317.4 7323.9 7515.8 7519.8 7574.0 7254.7 7260.7 7290.7 7304.3 7325.6 3880.8 4198.9 4269.4 4307.8 4333.8 1706.0 1744.7 1754.6 1771.9 1772.5 868.3 910.5 958.0 993.4 1028.4 15594.8 15835.0 15916.8 16231.0 16249.8 941.2 951.9 962.5 978.8 998.0 7655.5 8987.0 9128.6 9316.5 9326.5 363607.0 367420.0 367936.0 368456.0 403743.0 55273.0 61250.0 62247.7 64168.7 64497.4 1015.6 1051.4 1116.9 1175.3 1177.4 13213.4 14033.4 14771.6 14805.0 15019.6 30665.7 30930.0 31227.8 32768.0 34266.5 42437.8 42740.0 44401.3 44416.3 45823.0 7098.9 7166.7 7253.2 7339.7 7395.4 9495.2 9687.7 10025.3 10031.9 10186.9 8560.1 8868.1 8953.9 8984.5 9207.4 9361.4 9423.0 9532.8 9542.9 9682.7 9052.6 9187.2 9238.8 9448.1 9792.3 6705.7 7202.7 7217.1 7253.3 7254.7 7849.4 9574.0 9596.1 9624.2 9655.8 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | [#3] mootools.html Cycles:180 Average:5247.40 Median:6405.65 stddev:2664.86 (41.6%) stddev-sans-first:2655.67 05:20:51 INFO - PROCESS | 6123 | Values: 1282.6 1415.3 1420.4 1552.5 1763.5 6650.2 7111.6 7294.0 7301.8 7303.6 7191.5 7324.6 7353.8 7364.8 7367.7 1951.4 1994.1 2190.1 2271.4 2299.1 2234.8 2241.4 2242.0 2243.3 2244.3 2146.6 2260.2 2274.2 2274.9 2277.4 2174.6 2209.6 2213.5 2231.2 2234.6 2194.0 2210.7 2218.4 2223.8 2251.8 7444.4 7491.3 7503.9 7505.1 7523.9 4617.4 4765.8 4776.2 4782.1 4784.3 3015.8 3090.1 3120.5 3137.9 3165.3 954.5 977.0 994.4 1033.1 1053.1 9996.8 10139.3 10227.9 10239.5 10242.1 4088.5 4226.8 4240.9 4257.3 4284.1 8082.4 8101.1 8115.5 8126.4 8130.9 4634.4 4723.6 4728.9 4730.8 4739.1 4329.1 4329.8 4330.0 4332.9 4334.7 3184.2 3222.4 3246.3 3369.1 3441.0 933.8 941.5 964.2 982.3 1024.7 1314.3 1317.7 1326.8 1333.9 1361.8 6782.4 6795.0 6802.0 6802.1 6972.7 1098.7 1104.1 1104.1 1107.2 1134.4 5600.2 5663.2 5679.2 5681.6 5686.1 8906.6 8961.0 9026.3 9045.6 9188.7 8978.0 8987.6 9070.2 9087.0 9088.7 6954.7 7066.8 7114.5 7184.5 7233.7 6842.6 6853.6 6880.4 6882.3 6890.3 7897.9 8115.1 8131.4 8242.9 8254.4 8197.0 8328.7 8364.9 8371.7 8532.3 6401.9 6512.5 6790.2 6976.6 6991.2 6500.6 6622.4 6905.6 7063.0 7063.4 6541.7 6568.2 6680.6 6817.3 6850.3 6548.1 6573.7 6607.7 6729.6 6746.1 6707.2 6729.3 6734.6 6745.0 6752.4 6170.0 6189.1 6372.6 6409.4 6413.7 6311.8 6342.3 6350.2 6351.3 6353.0 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | [#4] prototype.html Cycles:180 Average:5196.54 Median:5789.15 stddev:1550.80 (26.8%) stddev-sans-first:1511.35 05:20:51 INFO - PROCESS | 6123 | Values: 320.1 326.9 327.6 334.7 337.0 5833.4 5842.3 5858.4 5859.4 5878.1 5608.6 5659.5 5746.6 5781.0 5796.3 4499.9 4506.1 4518.8 4519.9 4546.8 4317.4 4521.8 4522.3 4528.7 4530.2 4353.1 4362.8 4457.2 4459.3 4471.7 4434.2 4439.0 4443.4 4445.2 4447.0 3932.6 3943.4 3945.6 3953.7 3961.4 5477.3 5605.6 5608.2 5621.3 5624.4 5221.9 5228.1 5230.9 5231.6 5232.8 6130.1 6154.9 6156.7 6159.1 6161.0 4373.0 4374.1 4375.0 4376.9 4378.4 6294.8 6435.7 6438.5 6438.7 6449.1 4492.9 4497.4 4499.4 4500.1 4500.1 4555.8 4556.7 4560.8 4560.9 4561.7 5181.3 5215.5 5226.6 5246.3 5259.3 6059.0 6204.4 6218.9 6224.7 6226.3 1586.7 1599.8 1600.8 1602.2 1602.7 1085.2 1089.3 1092.5 1094.1 1115.6 5780.5 5780.6 5780.8 5786.0 5792.3 6284.4 6357.8 6359.0 6361.2 6366.6 5658.3 5734.6 5782.3 5900.6 5928.3 3433.5 3450.1 3463.0 3466.8 3468.6 6573.9 6573.9 6575.1 6580.1 6586.1 6394.1 6566.3 6592.2 6611.3 6617.2 6590.9 6592.5 6597.2 6599.7 6606.8 6399.4 6441.7 6448.3 6450.5 6455.5 6171.8 6347.7 6356.6 6359.1 6362.5 6546.1 6563.8 6574.2 6605.1 6615.3 4376.4 4384.1 4387.1 4392.8 4394.7 6288.3 6448.3 6458.0 6461.5 6461.7 6275.0 6287.9 6289.6 6299.8 6299.9 6235.7 6270.5 6274.4 6280.5 6282.8 5932.4 6143.3 6155.5 6159.4 6163.6 6314.3 6314.9 6323.6 6325.2 6332.2 6171.1 6177.4 6184.1 6185.5 6188.3 05:20:51 INFO - PROCESS | 6123 | 05:20:51 INFO - PROCESS | 6123 | [#5] yui.html Cycles:180 Average:13389.81 Median:48515.64 stddev:15187.88 (31.3%) stddev-sans-first:15200.76 05:20:51 INFO - PROCESS | 6123 | Values: 736.1 769.2 846.2 852.5 858.0 13210.1 13271.0 13406.7 13417.0 13438.9 12425.6 12468.9 12481.3 12496.3 12497.7 660.2 668.7 781.8 792.5 803.5 796.1 797.2 799.3 803.7 806.1 833.8 840.7 842.2 842.7 845.5 674.9 682.0 823.3 841.2 842.7 615.8 616.2 621.1 623.3 623.9 13026.8 13108.7 13130.3 13201.7 13216.0 10888.6 11149.0 11390.9 11466.5 11699.0 9471.4 9571.8 9614.7 9658.8 9685.9 3532.9 3561.4 3604.9 3613.1 3699.7 43297.0 43741.3 43830.6 44178.3 44191.8 9227.8 9236.8 9693.8 9768.6 10080.0 17482.1 17644.1 17709.9 17724.8 17763.6 7423.4 7498.5 7616.7 7645.4 7928.6 4352.8 4376.9 4389.4 4443.5 4467.4 2941.9 2950.5 2955.9 2981.4 2990.6 579.3 589.6 599.9 604.3 609.5 533.9 536.5 600.1 638.7 687.2 8156.6 8901.9 9197.2 9204.6 9423.9 466.8 605.9 629.1 660.7 691.6 4100.4 4197.5 4214.2 4393.6 4480.8 51208.7 51629.0 51688.2 51747.0 51766.7 48502.8 50961.0 51230.0 51819.7 52144.7 47188.5 47457.3 48162.0 48528.5 49988.5 8783.6 8814.0 8978.4 9018.7 9056.5 33757.0 33780.5 34690.8 34837.8 35095.1 39806.4 39938.4 42687.6 43227.8 43302.4 10818.9 10892.1 11206.5 11399.3 11594.6 11745.6 11746.8 11940.3 13015.2 13031.0 11053.7 11211.8 11614.6 11654.9 11845.9 10858.0 11115.6 11195.7 11469.8 11604.3 11470.5 11512.7 11574.5 11655.5 11970.8 9214.5 9530.0 9572.7 9695.8 9896.3 8797.3 9414.3 9494.2 9564.5 9807.5 05:20:51 INFO - PROCESS | 6123 | -------- Summary: end -------- 05:20:51 INFO - PROCESS | 6123 | 05:20:52 INFO - TEST-INFO | 6123: exit 0 05:20:52 INFO - TEST-OK | dromaeo_css | took 1113074ms 05:20:52 INFO - TEST-START | kraken 05:20:52 INFO - operating with platform_type : linux_ 05:20:52 INFO - Initialising browser for kraken test... 05:20:52 INFO - TEST-INFO | started process 6313 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdO5ppR/profile http://localhost:41128/getInfo.html) 05:20:56 INFO - PROCESS | 6313 | __metrics Screen width/height:1600/1200 05:20:56 INFO - PROCESS | 6313 | colorDepth:24 05:20:56 INFO - PROCESS | 6313 | Browser inner width/height: 1024/697 05:20:56 INFO - PROCESS | 6313 | __metrics 05:20:56 INFO - PROCESS | 6313 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:20:56 INFO - PROCESS | 6313 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:57 INFO - TEST-INFO | 6313: exit 0 05:20:57 INFO - Browser initialized. 05:20:57 INFO - Running cycle 1/1 for kraken test... 05:20:57 INFO - TEST-INFO | started process 6397 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdO5ppR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:09 INFO - PROCESS | 6397 | RSS: Main: 149127168 05:21:09 INFO - PROCESS | 6397 | 05:21:11 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41128/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:12 INFO - PROCESS | 6397 | RSS: Main: 185044992 05:21:12 INFO - PROCESS | 6397 | 05:21:15 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41128/tests/kraken/driver.html?testName=audio-dft) 05:21:15 INFO - PROCESS | 6397 | RSS: Main: 175661056 05:21:15 INFO - PROCESS | 6397 | 05:21:18 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41128/tests/kraken/driver.html?testName=audio-fft) 05:21:19 INFO - PROCESS | 6397 | RSS: Main: 161558528 05:21:19 INFO - PROCESS | 6397 | 05:21:21 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41128/tests/kraken/driver.html?testName=audio-oscillator) 05:21:21 INFO - PROCESS | 6397 | RSS: Main: 163733504 05:21:21 INFO - PROCESS | 6397 | 05:21:24 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41128/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:24 INFO - PROCESS | 6397 | RSS: Main: 165261312 05:21:24 INFO - PROCESS | 6397 | 05:21:27 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41128/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:28 INFO - PROCESS | 6397 | RSS: Main: 164155392 05:21:28 INFO - PROCESS | 6397 | 05:21:31 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41128/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:32 INFO - PROCESS | 6397 | RSS: Main: 164556800 05:21:32 INFO - PROCESS | 6397 | 05:21:34 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41128/tests/kraken/driver.html?testName=json-parse-financial) 05:21:35 INFO - PROCESS | 6397 | RSS: Main: 164749312 05:21:35 INFO - PROCESS | 6397 | 05:21:36 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41128/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:37 INFO - PROCESS | 6397 | RSS: Main: 174813184 05:21:37 INFO - PROCESS | 6397 | 05:21:39 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:21:39 INFO - PROCESS | 6397 | RSS: Main: 173858816 05:21:39 INFO - PROCESS | 6397 | 05:21:42 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:21:42 INFO - PROCESS | 6397 | RSS: Main: 187293696 05:21:42 INFO - PROCESS | 6397 | 05:21:44 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:45 INFO - PROCESS | 6397 | RSS: Main: 189087744 05:21:45 INFO - PROCESS | 6397 | 05:21:48 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:21:48 INFO - PROCESS | 6397 | RSS: Main: 189526016 05:21:48 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:41128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41128/tests/kraken/driver.html?testName=ai-astar) 05:21:50 INFO - PROCESS | 6397 | RSS: Main: 247263232 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | __start_tp_report 05:21:50 INFO - PROCESS | 6397 | _x_x_mozilla_page_load 05:21:50 INFO - PROCESS | 6397 | _x_x_mozilla_page_load_details 05:21:50 INFO - PROCESS | 6397 | |i|pagename|runs| 05:21:50 INFO - PROCESS | 6397 | |0;ai-astar;111;111;105;111;112;113;100;111;112;112 05:21:50 INFO - PROCESS | 6397 | |1;audio-beat-detection;155;129;149;165;125;154;153;128;167;129 05:21:50 INFO - PROCESS | 6397 | |2;audio-dft;161;162;158;159;160;163;159;161;161;162 05:21:50 INFO - PROCESS | 6397 | |3;audio-fft;75;73;82;95;74;73;70;119;97;74 05:21:50 INFO - PROCESS | 6397 | |4;audio-oscillator;97;95;138;97;96;96;136;97;96;139 05:21:50 INFO - PROCESS | 6397 | |5;imaging-gaussian-blur;109;110;109;109;110;110;109;111;110;110 05:21:50 INFO - PROCESS | 6397 | |6;imaging-darkroom;147;145;145;145;146;145;145;146;146;146 05:21:50 INFO - PROCESS | 6397 | |7;imaging-desaturate;96;96;96;97;96;97;95;96;96;95 05:21:50 INFO - PROCESS | 6397 | |8;json-parse-financial;55;56;57;55;54;56;54;64;52;53 05:21:50 INFO - PROCESS | 6397 | |9;json-stringify-tinderbox;67;68;68;68;68;68;69;68;68;68 05:21:50 INFO - PROCESS | 6397 | |10;stanford-crypto-aes;85;85;87;88;85;93;84;85;85;86 05:21:50 INFO - PROCESS | 6397 | |11;stanford-crypto-ccm;123;119;117;115;120;130;128;116;122;120 05:21:50 INFO - PROCESS | 6397 | |12;stanford-crypto-pbkdf2;143;145;152;150;150;147;150;149;143;142 05:21:50 INFO - PROCESS | 6397 | |13;stanford-crypto-sha256-iterative;69;67;69;66;68;69;67;67;67;67 05:21:50 INFO - PROCESS | 6397 | __end_tp_report 05:21:50 INFO - PROCESS | 6397 | __start_cc_report 05:21:50 INFO - PROCESS | 6397 | _x_x_mozilla_cycle_collect,978 05:21:50 INFO - PROCESS | 6397 | __end_cc_report 05:21:50 INFO - PROCESS | 6397 | __startTimestamp1452518510661__endTimestamp 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | ------- Summary: start ------- 05:21:50 INFO - PROCESS | 6397 | Number of tests: 14 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:4.08 (3.7%) stddev-sans-first:4.30 05:21:50 INFO - PROCESS | 6397 | Values: 111.0 111.0 105.0 111.0 112.0 113.0 100.0 111.0 112.0 112.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:153.50 stddev:16.14 (10.5%) stddev-sans-first:16.74 05:21:50 INFO - PROCESS | 6397 | Values: 155.0 129.0 149.0 165.0 125.0 154.0 153.0 128.0 167.0 129.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 05:21:50 INFO - PROCESS | 6397 | Values: 161.0 162.0 158.0 159.0 160.0 163.0 159.0 161.0 161.0 162.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#3] audio-fft Cycles:10 Average:83.20 Median:74.50 stddev:15.75 (21.1%) stddev-sans-first:16.42 05:21:50 INFO - PROCESS | 6397 | Values: 75.0 73.0 82.0 95.0 74.0 73.0 70.0 119.0 97.0 74.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:96.00 stddev:20.01 (20.8%) stddev-sans-first:20.77 05:21:50 INFO - PROCESS | 6397 | Values: 97.0 95.0 138.0 97.0 96.0 96.0 136.0 97.0 96.0 139.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 05:21:50 INFO - PROCESS | 6397 | Values: 109.0 110.0 109.0 109.0 110.0 110.0 109.0 111.0 110.0 110.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:21:50 INFO - PROCESS | 6397 | Values: 147.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:21:50 INFO - PROCESS | 6397 | Values: 96.0 96.0 96.0 97.0 96.0 97.0 95.0 96.0 96.0 95.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:3.31 (6.0%) stddev-sans-first:3.50 05:21:50 INFO - PROCESS | 6397 | Values: 55.0 56.0 57.0 55.0 54.0 56.0 54.0 64.0 52.0 53.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 05:21:50 INFO - PROCESS | 6397 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.50 stddev:2.63 (3.1%) stddev-sans-first:2.74 05:21:50 INFO - PROCESS | 6397 | Values: 85.0 85.0 87.0 88.0 85.0 93.0 84.0 85.0 85.0 86.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.00 stddev:4.92 (4.1%) stddev-sans-first:5.17 05:21:50 INFO - PROCESS | 6397 | Values: 123.0 119.0 117.0 115.0 120.0 130.0 128.0 116.0 122.0 120.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:149.50 stddev:3.60 (2.4%) stddev-sans-first:3.50 05:21:50 INFO - PROCESS | 6397 | Values: 143.0 145.0 152.0 150.0 150.0 147.0 150.0 149.0 143.0 142.0 05:21:50 INFO - PROCESS | 6397 | 05:21:50 INFO - PROCESS | 6397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 05:21:50 INFO - PROCESS | 6397 | Values: 69.0 67.0 69.0 66.0 68.0 69.0 67.0 67.0 67.0 67.0 05:21:50 INFO - PROCESS | 6397 | -------- Summary: end -------- 05:21:50 INFO - PROCESS | 6397 | 05:21:51 INFO - TEST-INFO | 6397: exit 0 05:21:51 INFO - TEST-OK | kraken | took 59397ms 05:21:51 INFO - TEST-START | v8_7 05:21:51 INFO - operating with platform_type : linux_ 05:21:51 INFO - Initialising browser for v8_7 test... 05:21:51 INFO - TEST-INFO | started process 6649 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdTFEhR/profile http://localhost:41128/getInfo.html) 05:21:55 INFO - PROCESS | 6649 | __metrics Screen width/height:1600/1200 05:21:55 INFO - PROCESS | 6649 | colorDepth:24 05:21:55 INFO - PROCESS | 6649 | Browser inner width/height: 1024/697 05:21:55 INFO - PROCESS | 6649 | __metrics 05:21:55 INFO - PROCESS | 6649 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:21:55 INFO - PROCESS | 6649 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:57 INFO - TEST-INFO | 6649: exit 0 05:21:57 INFO - Browser initialized. 05:21:57 INFO - Running cycle 1/1 for v8_7 test... 05:21:57 INFO - TEST-INFO | started process 6728 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdTFEhR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:08 INFO - PROCESS | 6728 | RSS: Main: 148574208 05:22:08 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | Cycle 1(1): loaded http://localhost:41128/tests/v8_7/run.html (next: http://localhost:41128/tests/v8_7/run.html) 05:22:31 INFO - PROCESS | 6728 | RSS: Main: 594472960 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | __start_tp_report 05:22:31 INFO - PROCESS | 6728 | _x_x_mozilla_page_load 05:22:31 INFO - PROCESS | 6728 | _x_x_mozilla_page_load_details 05:22:31 INFO - PROCESS | 6728 | |i|pagename|runs| 05:22:31 INFO - PROCESS | 6728 | |0;Richards;166.38935108153078 05:22:31 INFO - PROCESS | 6728 | |1;DeltaBlue;191.46084625694044 05:22:31 INFO - PROCESS | 6728 | |2;Encrypt;280.42624789680315 05:22:31 INFO - PROCESS | 6728 | |3;Decrypt;5175.257731958763 05:22:31 INFO - PROCESS | 6728 | |4;RayTrace;1104.9723756906078 05:22:31 INFO - PROCESS | 6728 | |5;Earley;777.000777000777 05:22:31 INFO - PROCESS | 6728 | |6;Boyer;12120.481927710844 05:22:31 INFO - PROCESS | 6728 | |7;RegExp;42520.833333333336 05:22:31 INFO - PROCESS | 6728 | |8;Splay;614.6341463414634 05:22:31 INFO - PROCESS | 6728 | |9;NavierStokes;4840.579710144928 05:22:31 INFO - PROCESS | 6728 | __end_tp_report 05:22:31 INFO - PROCESS | 6728 | __startTimestamp1452518551557__endTimestamp 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | ------- Summary: start ------- 05:22:31 INFO - PROCESS | 6728 | Number of tests: 10 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 166.4 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#1] DeltaBlue Cycles:1 Average:191.46 Median:191.46 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 191.5 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 280.4 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 5175.3 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 1105.0 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#5] Earley Cycles:1 Average:777.00 Median:777.00 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 777.0 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 12120.5 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#7] RegExp Cycles:1 Average:42520.83 Median:42520.83 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 42520.8 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#8] Splay Cycles:1 Average:614.63 Median:614.63 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 614.6 05:22:31 INFO - PROCESS | 6728 | 05:22:31 INFO - PROCESS | 6728 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:22:31 INFO - PROCESS | 6728 | Values: 4840.6 05:22:31 INFO - PROCESS | 6728 | -------- Summary: end -------- 05:22:31 INFO - PROCESS | 6728 | 05:22:32 INFO - TEST-INFO | 6728: exit 0 05:22:32 INFO - TEST-OK | v8_7 | took 40898ms 05:22:32 INFO - SUITE-END | took 1213s 05:22:32 INFO - Completed test suite (00:20:13) 05:22:32 INFO - Working with test: dromaeo_css 05:22:32 INFO - Generating results file: dromaeo_css 05:22:32 INFO - Working with test: kraken 05:22:32 INFO - Generating results file: kraken 05:22:32 INFO - javascript benchmark 05:22:32 INFO - Working with test: v8_7 05:22:32 INFO - Generating results file: v8_7 05:22:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:22:32 INFO - process_Request line: dromaeo_css 6696.46 graph.html#tests=[[72,201,35]] 05:22:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:32 INFO - process_Request line: kraken 1504.60 graph.html#tests=[[232,201,35]] 05:22:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:32 INFO - process_Request line: v8_7 20030.43 graph.html#tests=[[230,201,35]] 05:22:32 INFO - RETURN: dromaeo_css: 6696.46 05:22:32 INFO - RETURN: kraken: 1504.60 05:22:32 INFO - RETURN: v8_7: 20030.43 05:22:32 INFO - javascript benchmark 05:22:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3030.545418187272, 3072.6620071792113, 3118.2360321721167, 3123.6407813101487, 3148.5906832111823, 4965.453800081988, 5021.271915572244, 5042.697438153708, 5072.644914855957, 5087.211482220262, 4964.304997300372, 5046.495350464952, 5062.594992400599, 5098.388193416795, 5115.744212789355, 4596.172688915985, 4596.770161491929, 4633.050224703928, 4664.790084446191, 4715.457722361938, 4700.670953033289, 4702.694324868889, 4738.19450693383, 4755.072760811643, 4767.046590681877, 4571.725696458223, 4625.653076019312, 4666.2767271073035, 4733.526647335273, 4734.053189362141, 4673.158831410345, 4685.0, 4691.014886873761, 4737.697133288339, 4743.146233677937, 4658.557437043475, 4667.533246675339, 4683.227267500858, 4683.484816670163, 4736.194846876039, 4796.3524924135145, 4814.75926203692, 4874.65877388583, 4929.728864912428, 4944.728039957801, 5435.891282174374, 5449.482299181572, 5451.909618076401, 5456.563474922036, 5458.727063646802, 5463.421458944398, 5467.863303417406, 5469.808556700536, 5469.835904922858, 5499.257600223958, 4942.802287908516, 5046.924296135524, 5137.537621614036, 5142.974285128588, 5144.356955380577, 5601.411851755507, 5604.6917419542315, 5611.382747897728, 5618.6628802272, 5625.887482250332, 5395.73021348931, 5403.891922161613, 5406.972965135228, 5411.404745477994, 5414.025475414384, 5300.602454815904, 5353.1167357386375, 5413.783448662089, 5488.17677348401, 5511.090670039479, 5412.945870541323, 5480.671159730429, 5504.944950550524, 5519.862003449865, 5531.3362396511875, 5348.786048558014, 5351.625386223005, 5364.91952620711, 5365.517103460707, 5372.167314066326, 4118.444010058603, 4240.045989652303, 4240.1307731914885, 4269.914601707948, 4272.252355837716, 3748.269087527906, 3800.201957588882, 3830.4254361845387, 3832.693384529231, 3847.03824043989, 4988.12707776145, 4998.6750861193905, 4998.825041123543, 5003.54968052877, 5021.924671129936, 5218.556422704037, 5397.190421436816, 5404.648697834628, 5416.945830541723, 5466.753996070186, 4917.901641967141, 4941.036497882878, 4945.134601444733, 5011.699298042129, 5034.06869729094, 4675.812967481263, 4706.576408123286, 4713.9764301178275, 4718.292256161534, 4753.35829662998, 5576.86057848557, 5584.664920104726, 5588.524975377139, 5593.916091258634, 5595.524380427628, 5336.7598458068705, 5353.4646535346155, 5444.891102177855, 5452.809151679672, 5462.426445223195, 5545.528630066489, 5575.080111781673, 5575.944240557543, 5581.944180558143, 5593.384727680033, 5390.541803946551, 5392.568594512508, 5393.757280922289, 5412.864678383072, 5458.5087342139395, 5320.627556071038, 5371.301730774974, 5376.327959005124, 5423.186522021729, 5454.154606036071, 5304.575633949197, 5339.439358867263, 5342.492463215988, 5349.812756553502, 5369.382521010134, 5309.177077552986, 5317.361916570037, 5318.255444237887, 5325.946740532545, 5374.140137577969, 5108.0, 5142.97428512855, 5222.55608273301, 5225.712585807665, 5230.790768369375, 5343.332083489564, 5344.9732751336, 5345.1714984177515, 5365.463453654604, 5384.7576859040655, 5243.370795504564, 5249.317588713443, 5252.763625636932, 5254.133068043883, 5258.710770907637], "unit": "score", "name": "dojo.html", "value": 5019.238778044754}, {"lowerIsBetter": false, "replicates": [523.5262087810531, 535.9303290572223, 553.0321936610931, 574.6810520161309, 583.9314055278841, 30205.697943020565, 36436.271274574494, 37018.814905925436, 37109.0, 37134.07164820874, 39779.60220397802, 40489.19021619573, 40497.392539111934, 40505.0, 40532.0, 7239.457040721941, 8366.372522060825, 8576.957115214414, 8579.099194584573, 8579.227869491744, 7289.708411663553, 9987.950060249725, 10105.343152695052, 10154.0, 10203.0, 9904.950475247613, 10010.099091081802, 10027.699169024905, 10028.699139025804, 10031.347962382459, 7226.060612120391, 7384.261573842627, 9876.851847222297, 9961.103500684936, 9969.75075623108, 9803.656872009517, 9936.90063099367, 9939.900600994042, 9941.602335906555, 9943.801123977551, 35314.0, 35979.64020359789, 35981.820090899375, 36013.27973440543, 36075.278494430226, 3248.4640034394297, 3347.6317605063423, 3538.3661832155694, 3574.696150827183, 3801.4487899254455, 28020.43959120806, 30291.545626815616, 30401.0, 30588.694113058806, 30904.53643195354, 3982.6216509431556, 3999.8000099994883, 4043.2317859606583, 4120.690948178869, 4123.278426275389, 283965.2827773773, 285053.0, 285147.0, 286386.0, 393462.0, 45625.0, 60040.0, 61023.69488152619, 61444.38555614387, 61451.6927415369, 53780.0, 54341.72829135908, 54500.0, 54539.0, 54583.0, 14590.927045364706, 14732.337044833008, 14784.704305913821, 14786.112833229825, 14845.109293442429, 11172.273802202993, 11311.660650180507, 11368.03371713397, 11440.94279528597, 11527.827082593767, 19604.82371057741, 19921.605487616016, 19955.900220499094, 19971.700424493643, 20011.59976800485, 7320.450966177558, 7481.962590187014, 7599.924000760032, 7620.923790762133, 7707.342921271954, 924.6024209589806, 987.456898705709, 1004.9247305383316, 1060.1412855587, 1119.1829964126234, 28707.712922870505, 28919.277018074717, 29163.8555300679, 29534.261643459085, 29715.851420742758, 1044.300318786415, 1063.7978784031009, 1085.7448499602588, 1090.487470888681, 1110.3504449896739, 13915.930420348035, 13924.721505569833, 13946.16323020622, 14013.089149205269, 14177.22025288619, 318260.0, 323074.0, 323683.0, 324283.0, 324720.0, 50968.23547646788, 51314.46056618307, 51334.0, 51359.22961155586, 51390.48609513857, 1338.6051114921122, 1347.5148946379295, 1352.499575157198, 1353.7360214758028, 1365.692719138166, 27015.864920676056, 28088.0, 28090.157295281173, 28099.71900281053, 29643.555346670248, 43737.78131109324, 43814.34278485762, 44497.77751111224, 48940.0, 50119.24821127759, 203243.0, 204554.0, 205762.0, 205980.0, 206247.0, 27834.0, 28490.287742806595, 28653.426931461672, 28868.422631546833, 28924.855375722986, 31199.0, 32540.18649533686, 39068.0, 40671.796641016605, 41534.169316614105, 33800.3239935195, 34381.0, 34797.652023479444, 35039.47440788339, 35243.47134793032, 35464.290714186085, 36596.63403365932, 36682.44976325411, 37234.765914045245, 40428.59571404248, 34957.0, 35133.47299790556, 35201.1199720009, 36216.81891590525, 36332.81833590815, 28428.289292767848, 29340.266493337836, 30166.09501714952, 30291.08974103181, 30418.239544010692, 24473.755262447146, 24589.262322130366, 24739.562544902925, 24832.130875419272, 24924.626130607692], "unit": "score", "name": "ext.html", "value": 18123.69815070767}, {"lowerIsBetter": false, "replicates": [349.0558040500446, 349.4967247164084, 354.03878469954077, 354.6418117701121, 354.69141846593453, 13330.866691333084, 13745.03784735069, 15789.921050394747, 15886.84113158868, 16674.166291685397, 15061.0, 15114.319855606496, 15695.60760980976, 15775.84224157758, 15803.288852001659, 5074.873128171797, 5306.946930530703, 5510.228568000463, 5540.9168862467095, 5542.612017158801, 3750.8124593770203, 3913.236918800835, 5305.495977882095, 5435.565154787627, 5507.5593952483705, 5261.763220655061, 5467.152591348327, 5467.507924286813, 5496.983058134258, 5505.807296744615, 5498.532624726883, 5511.476409741068, 5519.420460851633, 5537.861553461175, 5539.0, 5121.129408000649, 5255.080360936859, 5263.894722105575, 5268.0, 5304.469553044703, 18549.721754173697, 18626.90686546572, 18970.05149742521, 19261.51846203842, 19308.4207473776, 2117.6929345245007, 2156.4932240923526, 2207.9668804967937, 2257.6500642400456, 2310.6649535817382, 9343.392679475812, 9349.76625584359, 9414.764630884214, 9709.077637624414, 9743.464109473976, 1836.5592257858152, 1852.110986726379, 1863.7856646485693, 1873.5878106816615, 1885.8868467891832, 53249.2012619811, 53676.73161634167, 54638.18042729362, 54937.1759423609, 54992.72503637496, 9703.708888733348, 9893.258005649604, 9909.355891867006, 9981.650642227487, 10038.899611003797, 12686.365681715877, 12730.618081457571, 12735.981121510256, 12837.52368477637, 12893.290869002294, 7317.389267164381, 7323.853522929511, 7515.849683006419, 7519.8496030079095, 7574.0, 7254.673539690727, 7260.709571617076, 7290.671919763623, 7304.342609165201, 7325.5970921598755, 3880.7865567394065, 4198.9370159447635, 4269.380939763717, 4307.8492252771, 4333.804978775963, 1705.9914700426418, 1744.7121224997986, 1754.561359660085, 1771.9025453599918, 1772.485979066082, 868.2966796894535, 910.5083255042204, 957.9616815327448, 993.3940296419179, 1028.3793137545704, 15594.844051559567, 15835.0, 15916.840831591768, 16231.0, 16249.837501624832, 941.1717688434271, 951.9048095190426, 962.4754508792724, 978.8189185000798, 998.0269237493386, 7655.46411751172, 8986.955065224633, 9128.634854605742, 9316.534173291308, 9326.487043212688, 363607.0, 367420.0, 367936.0, 368456.0, 403743.0, 55273.0, 61250.0, 62247.6887615559, 64168.67915660392, 64497.355026449135, 1015.57345914716, 1051.4269723000982, 1116.9385683787307, 1175.2595864605414, 1177.3936422742295, 13213.42747429704, 14033.438662453796, 14771.556853294418, 14805.0, 15019.624509387353, 30665.693343066283, 30930.0, 31227.84386078055, 32768.0, 34266.48600271048, 42437.78781106075, 42740.0, 44401.33397999097, 44416.333754994346, 45823.0, 7098.929010709827, 7166.749163779451, 7253.165885923187, 7339.669714862737, 7395.445341599294, 9495.19290860257, 9687.66093186735, 10025.298229123891, 10031.949840251043, 10186.898131018892, 8560.14398560139, 8868.131976980492, 8953.865692014755, 8984.505852177932, 9207.447553146565, 9361.4383137012, 9422.95288523553, 9532.809343813224, 9542.85685714701, 9682.70951871445, 9052.592633331384, 9187.173154416134, 9238.815223695623, 9448.149666530046, 9792.314537982273, 6705.698243578953, 7202.71189152428, 7217.133943926552, 7253.274672532704, 7254.709811607477, 7849.411294153076, 9573.952130239304, 9596.088371604686, 9624.230061594915, 9655.806883862424], "unit": "score", "name": "jquery.html", "value": 7860.210181006725}, {"lowerIsBetter": false, "replicates": [1282.6152154353692, 1415.3489394878357, 1420.4389266239837, 1552.518719197049, 1763.5150333658241, 6650.235222949356, 7111.573305601668, 7294.0, 7301.817454563638, 7303.6348182590855, 7191.460640451974, 7324.63376831159, 7353.77938661841, 7364.77905662831, 7367.705291788336, 1951.375559820858, 1994.0827219479056, 2190.113004233288, 2271.3980795089315, 2299.0803678528555, 2234.8323875709307, 2241.383619504633, 2242.0247192471247, 2243.349428665685, 2244.259394399844, 2146.6350720377495, 2260.1863329201474, 2274.1585613323095, 2274.8521346112534, 2277.39648993017, 2174.56508698261, 2209.569134018859, 2213.4687674958054, 2231.2079211879873, 2234.575430668168, 2193.9890300548554, 2210.6794514795265, 2218.4232099654046, 2223.7665045170347, 2251.808596269319, 7444.36722878556, 7491.288327608869, 7503.924960750377, 7505.1369092554505, 7523.887141692824, 4617.422822147231, 4765.761711914391, 4776.164171270014, 4782.0914026334885, 4784.30627559002, 3015.7738169637364, 3090.134762266569, 3120.4851199552045, 3137.9372412551847, 3165.2561648012697, 954.494118117392, 976.9706908792748, 994.3785134291068, 1033.1218464305355, 1053.1048608682636, 9996.800063998751, 10139.340942838691, 10227.897721022844, 10239.539220735085, 10242.129418999393, 4088.5298190707854, 4226.788660567021, 4240.893977650521, 4257.297545904891, 4284.078923031563, 8082.393820463371, 8101.149379315087, 8115.472494287852, 8126.39052071097, 8130.918690813016, 4634.420697412824, 4723.598494128038, 4728.929066064012, 4730.834420795256, 4739.099571081483, 4329.09089091288, 4329.783510824446, 4330.0, 4332.935005974913, 4334.674899382559, 3184.1880320518585, 3222.4360736870954, 3246.3020450603235, 3369.0735047861544, 3441.0365097772665, 933.808569243317, 941.4539567051094, 964.2045312616979, 982.2976571751232, 1024.6772266735954, 1314.3362601885985, 1317.7101037771674, 1326.7943468762357, 1333.8666133386585, 1361.754884120848, 6782.423494002966, 6795.048693182958, 6802.0, 6802.081718967975, 6972.651367431608, 1098.7143342730787, 1104.0852150323153, 1104.1442881766695, 1107.2028139739375, 1134.3647557367901, 5600.159976003632, 5663.150527420919, 5679.204911312419, 5681.602287839894, 5686.147077938343, 8906.554672266491, 8960.955195223982, 9026.277897768163, 9045.638174473079, 9188.724338269863, 8978.0, 8987.640494380152, 9070.18368346852, 9087.045860184717, 9088.681896133603, 6954.687039083254, 7066.787996360117, 7114.50198486101, 7184.497085203986, 7233.710651573878, 6842.55523390978, 6853.588784672936, 6880.415164711056, 6882.277360877236, 6890.345417185359, 7897.921020789719, 8115.1479094694205, 8131.430799843954, 8242.917570824215, 8254.42219044685, 8196.959015204886, 8328.708495202638, 8364.874526882224, 8371.706990255312, 8532.317414606692, 6401.8719625608155, 6512.511561632802, 6790.151231096113, 6976.581405115507, 6991.196012458632, 6500.642464664489, 6622.437092847162, 6905.551139175937, 7062.964685176541, 7063.364297213276, 6541.672916354259, 6568.1789776277965, 6680.565763225375, 6817.250102488623, 6850.280720524273, 6548.050532672831, 6573.704183311858, 6607.7356905725155, 6729.629870356982, 6746.089277947414, 6707.228668703162, 6729.259781424137, 6734.56225345351, 6744.966275168593, 6752.358525940028, 6169.96915015422, 6189.133521307111, 6372.553921225655, 6409.4231519163495, 6413.743450261937, 6311.779087731908, 6342.334054924167, 6350.174477317919, 6351.2696039956, 6352.968235158794], "unit": "score", "name": "mootools.html", "value": 4338.803421927299}, {"lowerIsBetter": false, "replicates": [320.1069017441339, 326.88232236394896, 327.58724007750243, 334.67202141900935, 336.96630336966297, 5833.416658334165, 5842.328132264791, 5858.355580886099, 5859.414058594139, 5878.088896221093, 5608.551315894729, 5659.51894089003, 5746.569007324447, 5781.017227071397, 5796.333421656511, 4499.865004049884, 4506.121306345264, 4518.751468669222, 4519.887002824923, 4546.8408605698805, 4317.43873296471, 4521.796519156645, 4522.253828118356, 4528.682992190548, 4530.184566777979, 4353.064091220387, 4362.760048197348, 4457.242268814293, 4459.331100334959, 4471.66462515311, 4434.201843668138, 4438.977805110986, 4443.4445694288215, 4445.177642136216, 4446.97776511117, 3932.6067393260732, 3943.369060950234, 3945.60543945606, 3953.743006704555, 3961.3859851723028, 5477.3427188737205, 5605.5515558755205, 5608.2428872102155, 5621.269234999424, 5624.3813180550105, 5221.921671174935, 5228.111221092386, 5230.92153617696, 5231.60762942777, 5232.843014709565, 6130.141780150782, 6154.938450615481, 6156.6613836238985, 6159.137720719103, 6160.969195153995, 4373.037931655031, 4374.0595771908875, 4374.978125109354, 4376.89057773555, 4378.387025816356, 6294.779682711083, 6435.678216089177, 6438.452731517827, 6438.710258038353, 6449.12936753537, 4492.910141797146, 4497.392851964943, 4499.437570303712, 4500.144972455223, 4500.144972455289, 4555.772211389417, 4556.726596404226, 4560.8175672973375, 4560.885977850514, 4561.657875659339, 5181.326427564468, 5215.530602245816, 5226.555742761908, 5246.291750613695, 5259.263703081571, 6058.969705151446, 6204.410580994799, 6218.875622487525, 6224.688765561795, 6226.346233645402, 1586.698527279813, 1599.7680336351398, 1600.8239093699683, 1602.206907580755, 1602.7115119278642, 1085.2132204152085, 1089.2647462962468, 1092.4865313302735, 1094.0536435982976, 1115.6151127860876, 5780.479756821906, 5780.624259423124, 5780.768769249267, 5786.0, 5792.304923409218, 6284.43440090385, 6357.841053973595, 6358.968205158944, 6361.2048493938255, 6366.649834259068, 5658.264425624642, 5734.598578099576, 5782.277215348082, 5900.586958912835, 5928.288605367384, 3433.5193072969805, 3450.1374656335915, 3463.0303515015835, 3466.791992480459, 3468.618451970281, 6573.901391479131, 6573.901391479131, 6575.079488871562, 6580.11168492257, 6586.077949087132, 6394.136791533084, 6566.343365663491, 6592.208934927839, 6611.33886611335, 6617.239017512951, 6590.934090659128, 6592.472602191909, 6597.208334999831, 6599.703013364506, 6606.768763093269, 6399.424051835171, 6441.677916104082, 6448.322926092693, 6450.483961282992, 6455.548111632328, 6171.753129874754, 6347.71435285404, 6356.555041147075, 6359.141515895295, 6362.522810789117, 6546.083548303337, 6563.835904102436, 6574.178227721535, 6605.075289459575, 6615.305392933865, 4376.409184760144, 4384.145091707086, 4387.14450682114, 4392.846250381222, 4394.692371533962, 6288.308286088435, 6448.322926092693, 6458.0, 6461.450776683847, 6461.67691615408, 6274.968625156845, 6287.905681414874, 6289.591176573508, 6299.842503937438, 6299.874002520016, 6235.657038862906, 6270.49836013127, 6274.435300822765, 6280.466160376419, 6282.811515654537, 5932.406759324033, 6143.32423433413, 6155.538334625011, 6159.384061593984, 6163.599366041372, 6314.305426403183, 6314.8737025258315, 6323.557350985387, 6325.209348831396, 6332.176817013758, 6171.13604095418, 6177.444030037318, 6184.134221209124, 6185.536084793568, 6188.319284878569], "unit": "score", "name": "prototype.html", "value": 4695.208357088259}, {"lowerIsBetter": false, "replicates": [736.1476263703559, 769.1500891514876, 846.2003406780588, 852.467207995003, 857.987130193047, 13210.075294729373, 13271.0, 13406.731865362686, 13417.0, 13438.932805335971, 12425.56510522132, 12468.93765531171, 12481.25112493251, 12496.312702801342, 12497.687557811036, 660.1945626335862, 668.6523008035819, 781.8240895798457, 792.5007245435382, 803.509858986021, 796.1361922314296, 797.1988151907325, 799.312591171592, 803.6825453945688, 806.1374329467473, 833.7623777223492, 840.6805413942693, 842.2377748137915, 842.7176895739904, 845.5180547088162, 674.8616533610598, 681.9863602727943, 823.3372135430945, 841.1630427724454, 842.7050532313702, 615.8368032471399, 616.202018386191, 621.1273161208509, 623.2894500269696, 623.8877002139614, 13026.80459793104, 13108.737825243441, 13130.277834719087, 13201.669958251121, 13216.0, 10888.61889833852, 11149.0, 11390.886091139148, 11466.48400821965, 11699.0, 9471.431714097176, 9571.808563828685, 9614.663486778, 9658.823354465863, 9685.90314096857, 3532.858685652571, 3561.3767590671787, 3604.9098772530633, 3613.0967258185456, 3699.72252081095, 43297.0, 43741.34387984183, 43830.56169438329, 44178.33732494015, 44191.77904110491, 9227.769305767275, 9236.815263694689, 9693.757656058655, 9768.560414781352, 10080.04239597237, 17482.125893705517, 17644.117794110243, 17709.911450442924, 17724.822751772575, 17763.555911102067, 7423.369013633902, 7498.512596681198, 7616.7334143304715, 7645.426593005547, 7928.6035698214855, 4352.7823608819435, 4376.868693939187, 4389.363542286351, 4443.466783985942, 4467.396901418332, 2941.867615957287, 2950.5131653276967, 2955.926101847471, 2981.4484320400798, 2990.551417287424, 579.3135134865198, 589.5637228450915, 599.8530360061812, 604.338249616669, 609.4849851875158, 533.8905524367495, 536.4903341825282, 600.051917969607, 638.6838514935137, 687.2337343861658, 8156.632951517196, 8901.910980890108, 9197.218236449842, 9204.585793639302, 9423.90576094244, 466.83427383279127, 605.9333473317931, 629.1443636654146, 660.6927778582982, 691.5746815708303, 4100.36444351126, 4197.4753155855515, 4214.241436541452, 4393.648508119343, 4480.753558554311, 51208.74395628073, 51629.0, 51688.22467662988, 51747.0, 51766.74116629393, 48502.757486212344, 50961.0, 51230.0, 51819.740901296005, 52144.739276304135, 47188.5281147191, 47457.28814067792, 48162.0, 48528.5147148524, 49988.50011499839, 8783.604737786687, 8813.955930220307, 8978.371513993958, 9018.729438116867, 9056.501892395981, 33757.0, 33780.493292601124, 34690.82654586812, 34837.82581087078, 35095.12262193466, 39806.40290395589, 39938.40092398558, 42687.57312426836, 43227.78386108175, 43302.35046474243, 10818.945905270739, 10892.128629709763, 11206.495707693337, 11399.316041037233, 11594.594189203675, 11745.647630571097, 11746.76506469883, 11940.283582985048, 13015.154014988995, 13031.02267329973, 11053.668389948314, 11211.831822522505, 11614.593489228175, 11654.94172529166, 11845.940770296438, 10858.0, 11115.555377784798, 11195.72010699739, 11469.770604587695, 11604.30374177552, 11470.483828227916, 11512.712182195177, 11574.537018519164, 11655.475503602189, 11970.820437693616, 9214.493202873638, 9529.952350238482, 9572.664956726481, 9695.757606059906, 9896.307258492125, 8797.296216302808, 9414.340996130206, 9494.240460762985, 9564.473953932322, 9807.509624518889], "unit": "score", "name": "yui.html", "value": 6189.9759923978945}], "name": "dromaeo_css", "value": 6696.460843951958}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 111.0, 112.0, 113.0, 100.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 149.0, 165.0, 125.0, 154.0, 153.0, 128.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 158.0, 159.0, 160.0, 163.0, 159.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 82.0, 95.0, 74.0, 73.0, 70.0, 119.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 138.0, 97.0, 96.0, 96.0, 136.0, 97.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 55.0, 54.0, 56.0, 54.0, 64.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 88.0, 85.0, 93.0, 84.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [123.0, 119.0, 117.0, 115.0, 120.0, 130.0, 128.0, 116.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [143.0, 145.0, 152.0, 150.0, 150.0, 147.0, 150.0, 149.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 66.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1504.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [191.46084625694044], "unit": "score", "name": "DeltaBlue", "value": 345.33431399999995}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [777.000777000777], "unit": "score", "name": "Earley", "value": 857.737881}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [42520.833333333336], "unit": "score", "name": "RegExp", "value": 21.42443900048995}, {"lowerIsBetter": false, "replicates": [614.6341463414634], "unit": "score", "name": "Splay", "value": 132.58456349206355}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20030.42559530061}]} 05:22:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20030.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6696.46"}}} 05:22:32 INFO - Return code: 0 05:22:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:32 INFO - # TBPL SUCCESS # 05:22:32 INFO - Running post-action listener: _resource_record_post_action 05:22:32 INFO - Running post-run listener: _resource_record_post_run 05:22:33 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 562577408; Read time: 0; Write time: 420708 05:22:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 175271936; Read time: 0; Write time: 172764 05:22:33 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 323215360; Read time: 0; Write time: 208656 05:22:33 INFO - Running post-run listener: _upload_blobber_files 05:22:33 INFO - Blob upload gear active. 05:22:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:22:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:22:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:22:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:22:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:35 INFO - (blobuploader) - INFO - Done attempting. 05:22:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:36 INFO - (blobuploader) - INFO - Done attempting. 05:22:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:36 INFO - Return code: 0 05:22:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:22:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/78e36cc6f19ac74c864629f791a0e91a4bb6a18eefa3f5be3645c693ba1e1f436b19733d66950af793522d7ee6e4a6d4ae46896ec6eb8cffa46ec7bbcb56e77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/709c3801cf5e27b72f1180de0015d76e276c9e4efb5449adc8d96ba41808df525d13ac49e7b305b2c19ece489a5d6e24886363c8cc30a5bc89df76a8b6b47db3"} 05:22:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:22:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:22:36 INFO - Contents: 05:22:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/78e36cc6f19ac74c864629f791a0e91a4bb6a18eefa3f5be3645c693ba1e1f436b19733d66950af793522d7ee6e4a6d4ae46896ec6eb8cffa46ec7bbcb56e77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/709c3801cf5e27b72f1180de0015d76e276c9e4efb5449adc8d96ba41808df525d13ac49e7b305b2c19ece489a5d6e24886363c8cc30a5bc89df76a8b6b47db3"} 05:22:36 INFO - Copying logs to upload dir... 05:22:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.818343 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-11 05:22:36.278654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:22:36.282210) ========= 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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/78e36cc6f19ac74c864629f791a0e91a4bb6a18eefa3f5be3645c693ba1e1f436b19733d66950af793522d7ee6e4a6d4ae46896ec6eb8cffa46ec7bbcb56e77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/709c3801cf5e27b72f1180de0015d76e276c9e4efb5449adc8d96ba41808df525d13ac49e7b305b2c19ece489a5d6e24886363c8cc30a5bc89df76a8b6b47db3"} build_url:https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/SuGObJdOSMCszIQyUVnXkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/78e36cc6f19ac74c864629f791a0e91a4bb6a18eefa3f5be3645c693ba1e1f436b19733d66950af793522d7ee6e4a6d4ae46896ec6eb8cffa46ec7bbcb56e77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/709c3801cf5e27b72f1180de0015d76e276c9e4efb5449adc8d96ba41808df525d13ac49e7b305b2c19ece489a5d6e24886363c8cc30a5bc89df76a8b6b47db3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:22:36.307056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:22:36.307419) ========= 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=eca2ab57546de7b41f256b19000001ef-1452517278.972697-1908829202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:22:36.393867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:22:36.394216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:22:36.394558) ========= ========= Total master_lag: 0.22 =========