builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1452791054.14 results: success (0) buildid: 20160114060719 builduid: bcc34891ba2d4ed5a054dd5e69bc73b0 revision: 27eb5e90eeee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.145271) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.145745) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.146031) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004562 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.167484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.167830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.182852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.183240) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.231912) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.235262) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.235667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.235995) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 09:04:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-14 09:04:14 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.341947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.345351) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022879 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.395013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:14.397740) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee --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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 09:04:15,079 Setting DEBUG logging. 2016-01-14 09:04:15,079 attempt 1/10 2016-01-14 09:04:15,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27eb5e90eeee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 09:04:15,446 unpacking tar archive at: mozilla-central-27eb5e90eeee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:15.103932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:15.106848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:15.121158) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:15.121529) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 09:04:15.122042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-14 09:04:15.122388) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:15 INFO - MultiFileLogger online at 20160114 09:04:15 in /builds/slave/test-pgo 09:04:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:04:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:04:15 INFO - {'append_to_log': False, 09:04:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:04:15 INFO - 'blob_upload_branch': 'Firefox', 09:04:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:04:15 INFO - 'branch': 'Firefox', 09:04:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:15 INFO - 'config_files': ('talos/linux_config.py',), 09:04:15 INFO - 'default_actions': ('clobber', 09:04:15 INFO - 'read-buildbot-config', 09:04:15 INFO - 'download-and-extract', 09:04:15 INFO - 'populate-webroot', 09:04:15 INFO - 'create-virtualenv', 09:04:15 INFO - 'install', 09:04:15 INFO - 'run-tests'), 09:04:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:15 INFO - 'download_minidump_stackwalk': True, 09:04:15 INFO - 'download_symbols': 'ondemand', 09:04:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:15 INFO - 'installer_path': 'installer.exe', 09:04:15 INFO - 'log_level': 'info', 09:04:15 INFO - 'log_name': 'talos', 09:04:15 INFO - 'log_to_console': True, 09:04:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:15 INFO - 'opt_config_files': (), 09:04:15 INFO - 'pip_index': False, 09:04:15 INFO - 'sps_profile': False, 09:04:15 INFO - 'sps_profile_interval': 0, 09:04:15 INFO - 'suite': 'dromaeojs', 09:04:15 INFO - 'system_bits': '32', 09:04:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:15 INFO - 'title': 'talos-linux64-ix-057', 09:04:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:15 INFO - 'use_talos_json': True, 09:04:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:04:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:15 INFO - 'work_dir': 'build'} 09:04:15 INFO - ##### 09:04:15 INFO - ##### Running clobber step. 09:04:15 INFO - ##### 09:04:15 INFO - Running pre-action listener: _resource_record_pre_action 09:04:15 INFO - Running main action method: clobber 09:04:15 INFO - rmtree: /builds/slave/test-pgo/build 09:04:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:04:16 INFO - Running post-action listener: _resource_record_post_action 09:04:16 INFO - ##### 09:04:16 INFO - ##### Running read-buildbot-config step. 09:04:16 INFO - ##### 09:04:16 INFO - Running pre-action listener: _resource_record_pre_action 09:04:16 INFO - Running main action method: read_buildbot_config 09:04:16 INFO - Using buildbot properties: 09:04:16 INFO - { 09:04:16 INFO - "project": "", 09:04:16 INFO - "product": "firefox", 09:04:16 INFO - "script_repo_revision": "production", 09:04:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:04:16 INFO - "repository": "", 09:04:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:04:16 INFO - "buildid": "20160114060719", 09:04:16 INFO - "stage_platform": "linux64-pgo", 09:04:16 INFO - "basedir": "/builds/slave/test-pgo", 09:04:16 INFO - "nightly_build": "True", 09:04:16 INFO - "buildnumber": 644, 09:04:16 INFO - "slavename": "talos-linux64-ix-057", 09:04:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:04:16 INFO - "platform": "ubuntu64_hw", 09:04:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:04:16 INFO - "branch": "mozilla-central", 09:04:16 INFO - "repo_path": "mozilla-central", 09:04:16 INFO - "revision": "27eb5e90eeee", 09:04:16 INFO - "pgo_build": "True", 09:04:16 INFO - "builduid": "bcc34891ba2d4ed5a054dd5e69bc73b0", 09:04:16 INFO - "slavebuilddir": "test" 09:04:16 INFO - } 09:04:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:04:16 INFO - Running post-action listener: _resource_record_post_action 09:04:16 INFO - ##### 09:04:16 INFO - ##### Running download-and-extract step. 09:04:16 INFO - ##### 09:04:16 INFO - Running pre-action listener: _resource_record_pre_action 09:04:16 INFO - Running main action method: download_and_extract 09:04:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:04:16 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')]} 09:04:16 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json 09:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json 09:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:04:17 INFO - Downloaded 1448 bytes. 09:04:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:04:17 INFO - Using the following test package requirements: 09:04:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:04:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'jsshell-linux-x86_64.zip'], 09:04:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04: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')]} 09:04:17 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:19 INFO - Downloaded 24030841 bytes. 09:04:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:04:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:04:20 INFO - Return code: 0 09:04:20 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 09:04:20 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')]} 09:04:20 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:22 INFO - Downloaded 24030841 bytes. 09:04:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:04:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:04:24 INFO - Return code: 0 09:04:24 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')]} 09:04:24 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:26 INFO - Downloaded 11132144 bytes. 09:04:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:04:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:04:26 INFO - Return code: 0 09:04: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')]} 09:04:26 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 09:04:29 INFO - Downloaded 55848868 bytes. 09:04:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:29 INFO - mkdir: /builds/slave/test-pgo/properties 09:04:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:04:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:04:29 INFO - Contents: 09:04:29 INFO - build_url:https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:29 INFO - Running post-action listener: _resource_record_post_action 09:04:29 INFO - Running post-action listener: set_extra_try_arguments 09:04:29 INFO - ##### 09:04:29 INFO - ##### Running populate-webroot step. 09:04:29 INFO - ##### 09:04:29 INFO - Running pre-action listener: _resource_record_pre_action 09:04:29 INFO - Running main action method: populate_webroot 09:04:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:29 INFO - '--tppagecycles', 09:04:29 INFO - '7'], 09:04:29 INFO - 'tests': ['tsvgm']}}, 09:04:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:04:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'tests': ['damp', 'tps']}, 09:04:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['damp', 'tps']}, 09:04:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:04:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:29 INFO - 'other': {'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other_l64': {'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other_nol64': {'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'svgr': {'tests': ['tsvgx', 09:04:29 INFO - 'tsvgr_opacity', 09:04:29 INFO - 'tart', 09:04:29 INFO - 'tscrollx', 09:04:29 INFO - 'cart']}, 09:04:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tsvgx', 09:04:29 INFO - 'tsvgr_opacity', 09:04:29 INFO - 'tart', 09:04:29 INFO - 'tscrollx', 09:04:29 INFO - 'cart']}, 09:04:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'tests': ['tp5o']}, 09:04:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tp5o']}, 09:04:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--xperf_path', 09:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:29 INFO - 'tests': ['tp5n']}, 09:04:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s', 09:04:29 INFO - '--xperf_path', 09:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:29 INFO - 'tests': ['tp5n']}}, 09:04:29 INFO - 'talos.zip': {'path': '', 09:04:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:29 INFO - Running post-action listener: _resource_record_post_action 09:04:29 INFO - ##### 09:04:29 INFO - ##### Running create-virtualenv step. 09:04:29 INFO - ##### 09:04:29 INFO - Running pre-action listener: _resource_record_pre_action 09:04:29 INFO - Running main action method: create_virtualenv 09:04:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:04:29 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 09:04:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:04:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:29 INFO - Using real prefix '/usr' 09:04:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:04:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:31 INFO - Installing pip.................done. 09:04:31 INFO - Return code: 0 09:04:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:31 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:31 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 09:04:31 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 09:04:31 INFO - Using env: {'DISPLAY': ':0', 09:04:31 INFO - 'HOME': '/home/cltbld', 09:04:31 INFO - 'LANG': 'en_US.UTF-8', 09:04:31 INFO - 'LANGUAGE': 'en_US:en', 09:04:31 INFO - 'LOGNAME': 'cltbld', 09:04:31 INFO - 'MAIL': '/var/mail/cltbld', 09:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:31 INFO - 'MOZ_NO_REMOTE': '1', 09:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:31 INFO - 'NO_EM_RESTART': '1', 09:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:31 INFO - 'SHELL': '/bin/bash', 09:04:31 INFO - 'SHLVL': '1', 09:04:31 INFO - 'TERM': 'linux', 09:04:31 INFO - 'TMOUT': '86400', 09:04:31 INFO - 'USER': 'cltbld', 09:04:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:31 INFO - '_': '/tools/buildbot/bin/python'} 09:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:32 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 09:04:32 INFO - Cleaning up... 09:04:32 INFO - Return code: 0 09:04:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:32 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:32 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 09:04:32 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 09:04:32 INFO - Using env: {'DISPLAY': ':0', 09:04:32 INFO - 'HOME': '/home/cltbld', 09:04:32 INFO - 'LANG': 'en_US.UTF-8', 09:04:32 INFO - 'LANGUAGE': 'en_US:en', 09:04:32 INFO - 'LOGNAME': 'cltbld', 09:04:32 INFO - 'MAIL': '/var/mail/cltbld', 09:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:32 INFO - 'MOZ_NO_REMOTE': '1', 09:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:32 INFO - 'NO_EM_RESTART': '1', 09:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:32 INFO - 'SHELL': '/bin/bash', 09:04:32 INFO - 'SHLVL': '1', 09:04:32 INFO - 'TERM': 'linux', 09:04:32 INFO - 'TMOUT': '86400', 09:04:32 INFO - 'USER': 'cltbld', 09:04:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:32 INFO - '_': '/tools/buildbot/bin/python'} 09:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:32 INFO - Downloading/unpacking psutil>=0.7.1 09:04:32 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 09:04:32 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 09:04:32 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 09:04:32 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 09:04:32 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 09:04:32 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 09:04:34 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:04:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:34 INFO - Installing collected packages: psutil 09:04:34 INFO - Running setup.py install for psutil 09:04:34 INFO - building 'psutil._psutil_linux' extension 09:04:34 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 09:04:34 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 09:04:34 INFO - building 'psutil._psutil_posix' extension 09:04:34 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 09:04:34 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 09:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:34 INFO - Successfully installed psutil 09:04:34 INFO - Cleaning up... 09:04:34 INFO - Return code: 0 09:04:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:04:34 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')]} 09:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:34 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')]} 09:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:34 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:34 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 09:04:34 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 09:04:34 INFO - Using env: {'DISPLAY': ':0', 09:04:34 INFO - 'HOME': '/home/cltbld', 09:04:34 INFO - 'LANG': 'en_US.UTF-8', 09:04:34 INFO - 'LANGUAGE': 'en_US:en', 09:04:34 INFO - 'LOGNAME': 'cltbld', 09:04:34 INFO - 'MAIL': '/var/mail/cltbld', 09:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:34 INFO - 'MOZ_NO_REMOTE': '1', 09:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:34 INFO - 'NO_EM_RESTART': '1', 09:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:34 INFO - 'SHELL': '/bin/bash', 09:04:34 INFO - 'SHLVL': '1', 09:04:34 INFO - 'TERM': 'linux', 09:04:34 INFO - 'TMOUT': '86400', 09:04:34 INFO - 'USER': 'cltbld', 09:04:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:34 INFO - '_': '/tools/buildbot/bin/python'} 09:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:04:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:04:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:04:36 INFO - Installing collected packages: mozsystemmonitor 09:04:36 INFO - Running setup.py install for mozsystemmonitor 09:04:36 INFO - Successfully installed mozsystemmonitor 09:04:36 INFO - Cleaning up... 09:04:36 INFO - Return code: 0 09:04:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:04:36 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')]} 09:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:36 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')]} 09:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:36 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:36 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 09:04:36 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 09:04:36 INFO - Using env: {'DISPLAY': ':0', 09:04:36 INFO - 'HOME': '/home/cltbld', 09:04:36 INFO - 'LANG': 'en_US.UTF-8', 09:04:36 INFO - 'LANGUAGE': 'en_US:en', 09:04:36 INFO - 'LOGNAME': 'cltbld', 09:04:36 INFO - 'MAIL': '/var/mail/cltbld', 09:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:36 INFO - 'MOZ_NO_REMOTE': '1', 09:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:36 INFO - 'NO_EM_RESTART': '1', 09:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:36 INFO - 'SHELL': '/bin/bash', 09:04:36 INFO - 'SHLVL': '1', 09:04:36 INFO - 'TERM': 'linux', 09:04:36 INFO - 'TMOUT': '86400', 09:04:36 INFO - 'USER': 'cltbld', 09:04:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:36 INFO - '_': '/tools/buildbot/bin/python'} 09:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:36 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 09:04:36 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 09:04:36 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 09:04:36 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 09:04:36 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 09:04:36 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 09:04:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:04:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:38 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 09:04:38 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 09:04:38 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 09:04:38 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 09:04:38 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 09:04:38 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 09:04:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:04:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:39 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 09:04:39 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 09:04:39 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 09:04:39 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 09:04:39 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 09:04:39 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 09:04:39 INFO - Downloading docopt-0.6.1.tar.gz 09:04:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:39 INFO - Running setup.py install for blobuploader 09:04:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:04:39 INFO - Running setup.py install for requests 09:04:39 INFO - Running setup.py install for docopt 09:04:39 INFO - Successfully installed blobuploader requests docopt 09:04:39 INFO - Cleaning up... 09:04:40 INFO - Return code: 0 09:04:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:40 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')]} 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:40 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')]} 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:40 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:40 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 09:04:40 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 09:04:40 INFO - Using env: {'DISPLAY': ':0', 09:04:40 INFO - 'HOME': '/home/cltbld', 09:04:40 INFO - 'LANG': 'en_US.UTF-8', 09:04:40 INFO - 'LANGUAGE': 'en_US:en', 09:04:40 INFO - 'LOGNAME': 'cltbld', 09:04:40 INFO - 'MAIL': '/var/mail/cltbld', 09:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:40 INFO - 'MOZ_NO_REMOTE': '1', 09:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:40 INFO - 'NO_EM_RESTART': '1', 09:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:40 INFO - 'SHELL': '/bin/bash', 09:04:40 INFO - 'SHLVL': '1', 09:04:40 INFO - 'TERM': 'linux', 09:04:40 INFO - 'TMOUT': '86400', 09:04:40 INFO - 'USER': 'cltbld', 09:04:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:40 INFO - '_': '/tools/buildbot/bin/python'} 09:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:40 INFO - Running setup.py (path:/tmp/pip-E2_LcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:40 INFO - Running setup.py (path:/tmp/pip-7ueIUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:40 INFO - Running setup.py (path:/tmp/pip-9yg42Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:40 INFO - Running setup.py (path:/tmp/pip-TqZQzQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:40 INFO - Running setup.py (path:/tmp/pip-QEYg0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:40 INFO - Running setup.py (path:/tmp/pip-LQXoEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:40 INFO - Running setup.py (path:/tmp/pip-sQGEeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:40 INFO - Running setup.py (path:/tmp/pip-FaIzTG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:40 INFO - Running setup.py (path:/tmp/pip-UQIdqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:40 INFO - Running setup.py (path:/tmp/pip-BotytE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:40 INFO - Running setup.py (path:/tmp/pip-_pimje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:41 INFO - Running setup.py (path:/tmp/pip-YmOLxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:41 INFO - Running setup.py (path:/tmp/pip-oR1cgd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:41 INFO - Running setup.py (path:/tmp/pip-A5gClR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:41 INFO - Running setup.py (path:/tmp/pip-zcZrRb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:41 INFO - Running setup.py (path:/tmp/pip-Brvv5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:41 INFO - Running setup.py (path:/tmp/pip-T1njVT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:41 INFO - Running setup.py install for manifestparser 09:04:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:04:41 INFO - Running setup.py install for mozcrash 09:04:41 INFO - Running setup.py install for mozdebug 09:04:41 INFO - Running setup.py install for mozdevice 09:04:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:04:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:04:41 INFO - Running setup.py install for mozfile 09:04:41 INFO - Running setup.py install for mozhttpd 09:04:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozinfo 09:04:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozInstall 09:04:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozleak 09:04:42 INFO - Running setup.py install for mozlog 09:04:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for moznetwork 09:04:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozprocess 09:04:42 INFO - Running setup.py install for mozprofile 09:04:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozrunner 09:04:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozscreenshot 09:04:43 INFO - Running setup.py install for moztest 09:04:43 INFO - Running setup.py install for mozversion 09:04:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:43 INFO - Cleaning up... 09:04:43 INFO - Return code: 0 09:04:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04: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')]} 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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', '-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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:43 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 09:04:43 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 09:04:43 INFO - Using env: {'DISPLAY': ':0', 09:04:43 INFO - 'HOME': '/home/cltbld', 09:04:43 INFO - 'LANG': 'en_US.UTF-8', 09:04:43 INFO - 'LANGUAGE': 'en_US:en', 09:04:43 INFO - 'LOGNAME': 'cltbld', 09:04:43 INFO - 'MAIL': '/var/mail/cltbld', 09:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:43 INFO - 'MOZ_NO_REMOTE': '1', 09:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:43 INFO - 'NO_EM_RESTART': '1', 09:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:43 INFO - 'SHELL': '/bin/bash', 09:04:43 INFO - 'SHLVL': '1', 09:04:43 INFO - 'TERM': 'linux', 09:04:43 INFO - 'TMOUT': '86400', 09:04:43 INFO - 'USER': 'cltbld', 09:04:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:43 INFO - '_': '/tools/buildbot/bin/python'} 09:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:43 INFO - Running setup.py (path:/tmp/pip-evwn0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:43 INFO - Running setup.py (path:/tmp/pip-_qk8v7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:43 INFO - Running setup.py (path:/tmp/pip-91Egys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:43 INFO - Running setup.py (path:/tmp/pip-HiJf_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:43 INFO - Running setup.py (path:/tmp/pip-9X1T1Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:43 INFO - Running setup.py (path:/tmp/pip-yAASvb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:43 INFO - Running setup.py (path:/tmp/pip-CyQO6a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:43 INFO - Running setup.py (path:/tmp/pip-CxTCPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:44 INFO - Running setup.py (path:/tmp/pip-nD2Fhc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:44 INFO - Running setup.py (path:/tmp/pip-XskKhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:44 INFO - Running setup.py (path:/tmp/pip-leQVsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:44 INFO - Running setup.py (path:/tmp/pip-A4WiQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:44 INFO - Running setup.py (path:/tmp/pip-8hzx5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:44 INFO - Running setup.py (path:/tmp/pip-qC7jGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:44 INFO - Running setup.py (path:/tmp/pip-4qD68k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:44 INFO - Running setup.py (path:/tmp/pip-876_Dn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:44 INFO - Running setup.py (path:/tmp/pip-muNywS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:44 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)) 09:04:44 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)) 09:04:44 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)) 09:04:44 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)) 09:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:04:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:46 INFO - Downloading blessings-1.5.1.tar.gz 09:04:46 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 09:04:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:46 INFO - Installing collected packages: blessings 09:04:46 INFO - Running setup.py install for blessings 09:04:46 INFO - Successfully installed blessings 09:04:46 INFO - Cleaning up... 09:04:46 INFO - Return code: 0 09:04:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:04:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:46 INFO - Reading from file tmpfile_stdout 09:04:46 INFO - Current package versions: 09:04:46 INFO - argparse == 1.2.1 09:04:46 INFO - blessings == 1.5.1 09:04:46 INFO - blobuploader == 1.2.4 09:04:46 INFO - docopt == 0.6.1 09:04:46 INFO - manifestparser == 1.1 09:04:46 INFO - mozInstall == 1.12 09:04:46 INFO - mozcrash == 0.16 09:04:46 INFO - mozdebug == 0.1 09:04:46 INFO - mozdevice == 0.48 09:04:46 INFO - mozfile == 1.2 09:04:46 INFO - mozhttpd == 0.7 09:04:46 INFO - mozinfo == 0.9 09:04:46 INFO - mozleak == 0.1 09:04:46 INFO - mozlog == 3.1 09:04:46 INFO - moznetwork == 0.27 09:04:46 INFO - mozprocess == 0.22 09:04:46 INFO - mozprofile == 0.28 09:04:46 INFO - mozrunner == 6.11 09:04:46 INFO - mozscreenshot == 0.1 09:04:46 INFO - mozsystemmonitor == 0.0 09:04:46 INFO - moztest == 0.7 09:04:46 INFO - mozversion == 1.4 09:04:46 INFO - psutil == 3.1.1 09:04:46 INFO - requests == 1.2.3 09:04:46 INFO - wsgiref == 0.1.2 09:04:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:46 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')]} 09:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:46 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')]} 09:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:46 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:46 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 09:04:46 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 09:04:46 INFO - Using env: {'DISPLAY': ':0', 09:04:46 INFO - 'HOME': '/home/cltbld', 09:04:46 INFO - 'LANG': 'en_US.UTF-8', 09:04:46 INFO - 'LANGUAGE': 'en_US:en', 09:04:46 INFO - 'LOGNAME': 'cltbld', 09:04:46 INFO - 'MAIL': '/var/mail/cltbld', 09:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:46 INFO - 'MOZ_NO_REMOTE': '1', 09:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:46 INFO - 'NO_EM_RESTART': '1', 09:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:46 INFO - 'SHELL': '/bin/bash', 09:04:46 INFO - 'SHLVL': '1', 09:04:46 INFO - 'TERM': 'linux', 09:04:46 INFO - 'TMOUT': '86400', 09:04:46 INFO - 'USER': 'cltbld', 09:04:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:46 INFO - '_': '/tools/buildbot/bin/python'} 09:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 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)) 09:04:47 INFO - Cleaning up... 09:04:47 INFO - Return code: 0 09:04:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:04:47 INFO - Using env: {'DISPLAY': ':0', 09:04:47 INFO - 'HOME': '/home/cltbld', 09:04:47 INFO - 'LANG': 'en_US.UTF-8', 09:04:47 INFO - 'LANGUAGE': 'en_US:en', 09:04:47 INFO - 'LOGNAME': 'cltbld', 09:04:47 INFO - 'MAIL': '/var/mail/cltbld', 09:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:47 INFO - 'MOZ_NO_REMOTE': '1', 09:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:47 INFO - 'NO_EM_RESTART': '1', 09:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:47 INFO - 'SHELL': '/bin/bash', 09:04:47 INFO - 'SHLVL': '1', 09:04:47 INFO - 'TERM': 'linux', 09:04:47 INFO - 'TMOUT': '86400', 09:04:47 INFO - 'USER': 'cltbld', 09:04:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:47 INFO - '_': '/tools/buildbot/bin/python'} 09:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:47 INFO - Downloading/unpacking jsonschema 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:49 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 09:04:49 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:04:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:49 INFO - warning: no files found matching '*.txt' 09:04:49 INFO - no previously-included directories found matching 'build' 09:04:49 INFO - no previously-included directories found matching 'dist' 09:04:49 INFO - no previously-included directories found matching '.git*' 09:04:49 INFO - Installing collected packages: jsonschema, functools32 09:04:49 INFO - Running setup.py install for functools32 09:04:49 INFO - warning: no files found matching '*.txt' 09:04:49 INFO - no previously-included directories found matching 'build' 09:04:49 INFO - no previously-included directories found matching 'dist' 09:04:49 INFO - no previously-included directories found matching '.git*' 09:04:49 INFO - Successfully installed jsonschema functools32 09:04:49 INFO - Cleaning up... 09:04:49 INFO - Return code: 0 09:04:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:04: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')]} 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:49 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 0x7fe87c258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', '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 09:04:49 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 09:04:49 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 09:04:49 INFO - Using env: {'DISPLAY': ':0', 09:04:49 INFO - 'HOME': '/home/cltbld', 09:04:49 INFO - 'LANG': 'en_US.UTF-8', 09:04:49 INFO - 'LANGUAGE': 'en_US:en', 09:04:49 INFO - 'LOGNAME': 'cltbld', 09:04:49 INFO - 'MAIL': '/var/mail/cltbld', 09:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:49 INFO - 'MOZ_NO_REMOTE': '1', 09:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:49 INFO - 'NO_EM_RESTART': '1', 09:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:49 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:49 INFO - 'SHELL': '/bin/bash', 09:04:49 INFO - 'SHLVL': '1', 09:04:49 INFO - 'TERM': 'linux', 09:04:49 INFO - 'TMOUT': '86400', 09:04:49 INFO - 'USER': 'cltbld', 09:04:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:49 INFO - '_': '/tools/buildbot/bin/python'} 09:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:49 INFO - Downloading/unpacking flake8 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:51 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 09:04:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:51 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 09:04:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:04:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:52 INFO - no previously-included directories found matching 'docs/_build' 09:04:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:52 INFO - Running setup.py install for pep8 09:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:52 INFO - no previously-included directories found matching 'docs/_build' 09:04:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:04:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:52 INFO - Cleaning up... 09:04:52 INFO - Return code: 0 09:04:52 INFO - Running post-action listener: _resource_record_post_action 09:04:52 INFO - Running post-action listener: _start_resource_monitoring 09:04:52 INFO - Starting resource monitoring. 09:04:52 INFO - ##### 09:04:52 INFO - ##### Running install step. 09:04:52 INFO - ##### 09:04:52 INFO - Running pre-action listener: _resource_record_pre_action 09:04:52 INFO - Running main action method: install 09:04:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:52 INFO - Reading from file tmpfile_stdout 09:04:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:04:52 INFO - Reading from file tmpfile_stdout 09:04:52 INFO - Output received: 09:04:52 INFO - Usage: mozinstall [options] installer 09:04:52 INFO - Options: 09:04:52 INFO - -h, --help show this help message and exit 09:04:52 INFO - -d DEST, --destination=DEST 09:04:52 INFO - Directory to install application into. [default: 09:04:52 INFO - "/builds/slave/test-pgo"] 09:04:52 INFO - --app=APP Application being installed. [default: firefox] 09:04:52 INFO - mkdir: /builds/slave/test-pgo/build/application 09:04:52 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'] 09:04:52 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 09:05:08 INFO - Reading from file tmpfile_stdout 09:05:08 INFO - Output received: 09:05:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:05:08 INFO - Running post-action listener: _resource_record_post_action 09:05:08 INFO - ##### 09:05:08 INFO - ##### Running run-tests step. 09:05:08 INFO - ##### 09:05:08 INFO - Running pre-action listener: _resource_record_pre_action 09:05:08 INFO - Running main action method: run_tests 09:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:05:08 INFO - Python 2.7.3 09:05:08 INFO - Return code: 0 09:05:08 INFO - grabbing minidump binary from tooltool 09:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:08 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 0x1169840>, '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 0x10d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:05:08 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 09:05:08 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 09:05:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:08 INFO - Return code: 0 09:05:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:05:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:05:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:05:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:05:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:05:09 INFO - Return code: 0 09:05:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 09:05:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 09:05:09 INFO - Using env: {'DISPLAY': ':0', 09:05:09 INFO - 'HOME': '/home/cltbld', 09:05:09 INFO - 'LANG': 'en_US.UTF-8', 09:05:09 INFO - 'LANGUAGE': 'en_US:en', 09:05:09 INFO - 'LOGNAME': 'cltbld', 09:05:09 INFO - 'MAIL': '/var/mail/cltbld', 09:05:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:05:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:09 INFO - 'MOZ_NO_REMOTE': '1', 09:05:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:09 INFO - 'NO_EM_RESTART': '1', 09:05:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:05:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:05:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:05:09 INFO - 'SHELL': '/bin/bash', 09:05:09 INFO - 'SHLVL': '1', 09:05:09 INFO - 'TERM': 'linux', 09:05:09 INFO - 'TMOUT': '86400', 09:05:09 INFO - 'USER': 'cltbld', 09:05:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485', 09:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:09 INFO - '_': '/tools/buildbot/bin/python'} 09:05:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 09:05:09 INFO - mozversion application_buildid: 20160114060719 09:05:09 INFO - mozversion application_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 09:05:09 INFO - mozversion application_display_name: Nightly 09:05:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:09 INFO - mozversion application_name: Firefox 09:05:09 INFO - mozversion application_remotingname: firefox 09:05:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:05:09 INFO - mozversion application_vendor: Mozilla 09:05:09 INFO - mozversion application_version: 46.0a1 09:05:09 INFO - mozversion platform_buildid: 20160114060719 09:05:09 INFO - mozversion platform_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 09:05:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:05:09 INFO - mozversion platform_version: 46.0a1 09:05:09 INFO - using testdate: 1452791109 09:05:09 INFO - actual date: 1452791109 09:05:09 INFO - starting webserver on 'localhost:48267' 09:05:09 INFO - SUITE-START | Running 3 tests 09:05:09 INFO - TEST-START | dromaeo_css 09:05:09 INFO - operating with platform_type : linux_ 09:05:09 INFO - Initialising browser for dromaeo_css test... 09:05:09 INFO - TEST-INFO | started process 1409 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp34OHis/profile http://localhost:48267/getInfo.html) 09:05:14 INFO - PROCESS | 1409 | __metrics Screen width/height:1600/1200 09:05:14 INFO - PROCESS | 1409 | colorDepth:24 09:05:14 INFO - PROCESS | 1409 | Browser inner width/height: 1024/697 09:05:14 INFO - PROCESS | 1409 | __metrics 09:05:14 INFO - PROCESS | 1409 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:05:14 INFO - PROCESS | 1409 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:15 INFO - TEST-INFO | 1409: exit 0 09:05:15 INFO - Browser initialized. 09:05:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:15 INFO - TEST-INFO | started process 1504 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp34OHis/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:27 INFO - PROCESS | 1504 | RSS: Main: 150163456 09:05:27 INFO - PROCESS | 1504 | 09:06:18 INFO - PROCESS | 1504 | 1452791178576 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] 09:08:26 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48267/tests/dromaeo/cssquery-ext.html) 09:08:27 INFO - PROCESS | 1504 | RSS: Main: 232300544 09:08:27 INFO - PROCESS | 1504 | 09:11:30 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-ext.html (next: http://localhost:48267/tests/dromaeo/cssquery-jquery.html) 09:11:30 INFO - PROCESS | 1504 | RSS: Main: 231526400 09:11:30 INFO - PROCESS | 1504 | 09:14:32 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48267/tests/dromaeo/cssquery-mootools.html) 09:14:33 INFO - PROCESS | 1504 | RSS: Main: 243507200 09:14:33 INFO - PROCESS | 1504 | 09:17:35 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48267/tests/dromaeo/cssquery-prototype.html) 09:17:35 INFO - PROCESS | 1504 | RSS: Main: 213123072 09:17:35 INFO - PROCESS | 1504 | 09:20:38 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48267/tests/dromaeo/cssquery-yui.html) 09:20:39 INFO - PROCESS | 1504 | RSS: Main: 211705856 09:20:39 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-yui.html (next: http://localhost:48267/tests/dromaeo/cssquery-dojo.html) 09:23:41 INFO - PROCESS | 1504 | RSS: Main: 257581056 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | __start_tp_report 09:23:41 INFO - PROCESS | 1504 | _x_x_mozilla_page_load 09:23:41 INFO - PROCESS | 1504 | _x_x_mozilla_page_load_details 09:23:41 INFO - PROCESS | 1504 | |i|pagename|runs| 09:23:41 INFO - PROCESS | 1504 | |0;dojo.html;3059.2657762137087;3091.6599174090834;3138.4664607016803;3138.905832825015;3158.731507821835;4768.64235182361;4848.345473361095;5026.673266237696;5039.949600503994;5066.620003499738;4963.329950456688;4968.9503104968935;4979.626528010395;5055.418626857912;5131.615128865331;4362.781860906958;4493.550644935497;4566.611837993774;4624.699394539344;4685.108652844316;4506.346579745935;4638;4639.327297541854;4703.952960470386;4725.125851717443;4492.460904691442;4545.136424079431;4594.632429405639;4622.098690755304;4643.3963584733765;4593.724376537385;4597.977010114962;4607.308903664443;4611.515790841981;4642.489326174118;4507.639388848885;4587.747673877935;4590.42619672541;4594.494605593415;4616.907661846778;4866.513348665105;4872.561469467765;4884.169691152477;4884.902301953976;4888.364512613373;5310;5311.203319502067;5315.096433606258;5315.734213289359;5322.414534401213;5337;5338.973305133488;5358.785648574052;5398.2712333834825;5441.374241962146;5064.493550644943;5077.771500282459;5078.771455284521;5094.821681241176;5096.694198348111;5480.91778623321;5500.862478438071;5508.44915508446;5588.91616625751;5589.80435684749;5154.793808247703;5163.044836705221;5210.817621383233;5280.155175171954;5283.656562323436;5359.517643412111;5378.381486129067;5383.892322153535;5390.110631745718;5403.378611459732;5318.22885681574;5353.143497040455;5354.196870469383;5368;5416.458354164631;5181.326427564392;5264.210368444764;5333.57331413486;5361.1422172453;5408.296921400193;4149.8340066397;4168.687348448879;4171.541130475645;4179.623833854967;4222.218889505451;3746.8501259949844;3749.1751814600743;3759.3984962405884;3780.8109594520715;3786.924261514754;4894.461609222983;4958.578520825698;4971.204607262821;4990.72551009698;5086.440491545927;5362.544183744348;5371.167469042305;5375.838724838261;5378.19327100938;5385.219143224211;5006.549410552995;5013.724245166551;5025.924611130836;5027.522385373457;5061.1902095665255;4526.615237704832;4533.795979180944;4538.273876179861;4563.475200351935;4597.42532183477;5496.972515137479;5505.146702261076;5517.613767036269;5527.226188333637;5585.190147428519;5240.109181439241;5327.813526526553;5338.252644629677;5341.332333458317;5343.171808369709;5453.7818487260065;5470.91793623104;5505.752241149238;5531.502164805026;5579.218909352613;5283.709395983258;5285.418603953639;5295.973520132375;5297.2583838263445;5298.44366341544;5237.659552129099;5341.278927344914;5353.0096932066135;5370.812021579226;5411.864703382447;5134.820281290137;5137.691738495702;5154.329937108152;5171.870703232299;5173.14643083902;5195.6622819516615;5199.48005199477;5201.479852014768;5204.0892843751435;5257.737113144404;5069.518395752398;5122.590192784643;5135.15269980449;5135.845924622267;5167.095758242368;5271.604629652715;5317.229001794641;5322.520973112439;5340.813071542478;5373.731313434391;5157.742112894265;5161.174212126042;5161.664491808171;5163.690178589297;5166.715830629201 09:23:41 INFO - PROCESS | 1504 | |1;ext.html;518.6499113098658;524.7612336386944;526.3368156123283;540.2220802045052;541.9810306639267;28598.28504287394;29052.27369315768;29052.41895162098;29087.41825163498;36784.63215367845;39840.80079599598;40324;40326.59673403265;40350.19299614013;40418;8464.195901389357;8651.740447786577;8666.263367613761;8669.393142480028;8676.566171691422;7485.588292643903;7700.653470593837;8400.117987611304;10081.747956301115;10362.430066346347;10006.69979900604;10170.64402745904;10176.38941663499;10182.9490852546;10204.132648724868;10240.334378265426;10415.375077495337;10416.218783591261;10452.790944181112;10458.947705261426;10249.180065594808;10385;10388.37669739818;10391;10392.896071039344;40529;40876.79561602203;40925;40934.59065409367;41049.794751026355;3200.3759266942957;3204.4872820348633;3249.675032496755;3296.538484612156;3405.3019131078067;30322.188812999142;30431.087067388013;30615;30876.536851947014;31471.52792708111;3950.723449358546;4028.4158796974275;4029.8992525186814;4116.711830171889;4236.406903033578;267946;269640;270976.6451167751;271929;273023;54062.72968635132;55135.44864551303;62555.37444625587;63075.36924630695;63611.68194159092;56618.716906415204;57125;57162;57177.28106705542;57209.42790572124;13482.730345393038;13775.173489590456;13777.655558610915;13786.448542058206;13820.654483637789;10142.18862490999;10196.031377019171;10254.48727563619;10284.28010039305;10284.434356110336;20903;20946.581068378546;21126.47183820386;21191.364259072252;21403.966623170774;8029.478083924643;8069.193080691884;8170.346372290202;8262.256396924306;8316.750497485085;896.7937374403793;909.4088842252456;1004.8542961270575;1040.469360626071;1143.0741099709262;28362.858185709352;29275.268118296786;29453.55819662707;31237.37525249482;31746.142847143867;1020.321486211661;1034.715453250347;1041.6979076067855;1071.5338827610015;1095.8630171228597;14253.714925701428;14336;14371.856281437053;14389.42442302317;14543.854561454462;366467;371605;371623;372131;372959;55038;55794;55815.44184558184;55866.44133558694;55869.16196257059;1176.6940595445076;1238.6098379010582;1276.0875973678678;1297;1358.959231223065;26265.212043638723;27538.5869211966;29045.564316535692;29326.560101598065;29807.254818629706;41386.58613413827;41784.58215417807;41880.58119418889;42374.576254238294;43063.55491560605;184113;300232;303711;304412;306935;30922.381552368377;31421;31595;31621.683783161872;31630.311423528336;39473.60526394814;40120.59879401168;40695;40863.1827363457;40928;34516.30967380588;34565.85209774843;34904.82547587246;35068.64931350756;37642.623573763914;37154;37758.97548598494;37900;38213;38651.6134838648;36360.63639363572;36975.260494789414;37211.44182837205;37287.81356093311;37301.81349093237;31515.52726709147;32028;33861.492077618364;33867;34008.829955850066;32087.358252834347;32370.514442283857;32444.351112977136;32445.18887027749;32814.83592582117 09:23:41 INFO - PROCESS | 1504 | |2;jquery.html;369.6231537522728;372.47853005791893;373.79441307281024;374.2216190324126;375.20269427466644;14412.279386030683;15459.458918937826;15538.223088845541;16517.83482165178;17116.65766684667;11120.054795342385;11412.942935285333;11428.828567571492;11429.657110286706;16517.421890233843;4449.799759010836;5887.381824908376;6070.332263451039;6070.6661133637635;6073;4518.502964673883;6586.637734924578;6822;6824.0446337512785;6828.214755303129;6516.315786842384;6858.759943401982;6862.451003919675;6864.073350097723;6868.690908909086;6653.2681405045405;6792.524523283372;6832.419244364235;6904.067950826624;6918.723251069951;6360.109584658106;6586.868262634768;6620.6358650274215;6634.502412319095;6640.236372817091;21457.248996285056;21625.35123946284;22157.77842221573;22195.66706499404;22219.44451388712;1892.5647101166808;1966.547694030381;2090.5296308330658;2162.0703097667997;2239.6864438978555;13215.33923303831;13418.329083545881;13563.389647465889;13739.587812365646;14197.716045679132;1854.4807453912927;1899.1928430417017;1900.3918746001284;1900.809919008102;1937.4187743676982;57434.71282643602;59283;59508.40491595072;60523;60914.69542652259;14662.706745865236;15025.398984040516;15042.473513426978;15044.849551504563;15073;22685.319440416813;22799;22997.08011679514;23101.19145829888;23128.4217894554;8484.36367272457;8513.659453621909;8538.146185381413;8618.655253789779;8635.611397487128;7093.361597456151;7145.857082858313;7220.0613920190035;7231.385332246713;7237.276272372721;6819.727210911508;7157.0675917501985;7338.706451741978;7356.36771859798;7593.164751877289;2895.7104289570875;2917.5331946888396;2984.373281610886;3134.2947836736553;3144.8427578621436;726.6076318787901;908.7137551671202;965.0542468380886;973.1728031173587;1000.7748256642197;14248.786268205986;15580.143092129814;15698.17432862073;16480.023083773143;17402.65194696099;847.4915050969369;854.3805740837843;863.8790569320174;891.3938521805235;972.2319367699438;7748.883766743504;8210.220029097227;8523.57382130891;8729.432586881832;9182.127697868691;440070;444760;445693;491759;521441;64644.353556464775;66505;68071.65964170247;68819;70407.49498817594;1162.4943149729725;1163.825426186062;1167.0721776187781;1183.1717797541583;1184.1059999700171;14693.485727999896;14850.628734281729;15034.924825375803;15132.01532506338;15141.470048548248;31356.686433135375;31841.840790795897;32077;32266;33115.668843312225;41278.38082428826;41448.3782743253;42245.577544224165;43077.1384572313;43177.56822431736;7020.473464490286;7181.748638797617;7211.531250468703;7289.635518223961;7366.889496657447;8692.608832602422;10571.735706607396;10847;11049.502772375423;11113.888861111609;8177.754667359989;8680.348973827115;8728.912710873064;8830.381873268809;9562.426254424758;7451.515651482637;8958.417702849294;9199.356045077047;9416.10546998034;9592.568334424828;8639.179277968582;8650.78373040679;8680.565971701515;8798.252148567188;8816.426932249384;7076.858462830817;7249.746258880914;7313.341799238094;7378.188399275968;7402;8497.57512124379;9273.3045021625;9276;9299.395539289924;9423.952880235554 09:23:41 INFO - PROCESS | 1504 | |3;mootools.html;1233.4819375862137;1474.0492382413345;1491.6121808329835;1656.3126302584428;1803.323753592403;6670.933290667092;7399.7780066598025;7598.772036838896;7648.388128949685;7658.234176582339;7384.630768461582;7510.28652278034;7533.096028476577;7572.810679733009;7586.7344642937505;1910.4077735901844;1936.6029963857375;1956.65758492264;2268.2061278552496;2293.4954310051844;1951.6194342103295;2253.2451628704403;2307.826912981525;2311.7457079721216;2312.1329501436962;2210.5689390568846;2230.096810791632;2244.539869326792;2247.898844551991;2316.247219653611;2248.865068095903;2269.0470002598868;2271.6138256496433;2271.636538153904;2273.9880753064976;2217.5897458970144;2245.371296037112;2245.764194759543;2246.8988895499742;2248.022110381989;7687.615619219073;7717.459777815499;7734.458587898849;7738.110117336522;7793.688252469951;4743.146233677937;4897.681650692693;4898;4902.48523904992;4903.926441103386;3029.469842777505;3112.548680441346;3127.2650927032128;3146.480830662938;3168.1446009577285;974.9122578967927;984.3945973226414;998.201438848918;1027.6146445083093;1048.1509976918721;10671.199660025452;10680.198985076073;10689.30519516229;10691.518881650345;10698.62554810578;4287.09970906107;4287.63555097814;4325.15659446405;4338.783060846945;4364.978175109104;9206.76983075415;9224.49265290402;9234.215091717146;9236.630534778533;9244.306676999251;4798.73606951621;4802.855914322576;4803.447603525569;4804.543568361;4808.27875818623;4318.5681431856565;4369.12617476506;4369.934450983238;4370.38814565961;4377.146456441027;3334.2497937963763;3689.3912504437003;3737.028372623083;3763.9435408468894;3781.5273090863643;1089.5750657243523;1110.722319420145;1120.523777394604;1121.5401685308984;1178.3283528388736;1213.696575856036;1217.5495066825154;1231.85833629132;1242.7700875338091;1242.9067819913544;7112.822179445555;7134.357907788324;7187.9281207188305;7302.96348518254;7316;1106.6292791914639;1113.9610113645983;1118.9776204475866;1120.1878637987395;1145.6563031090639;5661.858453538612;5767.538596912237;5767.769289228468;5790.536757059425;5795.159701843293;8845.955770221237;8971.461712297283;9110;9161.175494205554;9210.217131543759;9066;9100.499472529074;9172.954135229415;9179.0820917909;9184.770380740534;6979.511434199659;7158.2125966143685;7219.241979592172;7289.16174639902;7289.599072051088;7296;7392.852142957218;7394.704211831681;7405;7405.9629701851145;8098.857052146893;8421.536815475207;8485.745427637181;8495.575221238789;8611.052784193858;8221.465604735673;8456.746297611082;8602.569871506274;8609.956950215208;8640.481571105754;6745.460363171032;6933.5146539743755;6965.895511567432;6993.0908981832035;6994.300569942965;7423.1834498206235;7477.850442991001;7483.476156668981;7489.737859174903;7491.213422590768;6182.505399568114;6597.934020659924;6939.479539034492;7180.210176880434;7192.856142877008;6861.416779573792;6935.237123916264;6955.617441040791;7082.327178917994;7120.323569260912;6930.965345173242;6976.337247961435;6987;6995.650217489207;6996.790096297119;6315.305316415099;6448.838779030561;6458.61248325102;6502.544821862424;6503.154589903283;6475.125858009297;6578.0790689304495;6582.275949645631;6586.40722334973;6594.868102638016 09:23:41 INFO - PROCESS | 1504 | |4;prototype.html;334.4364745403996;337.6033161035782;340.5691799873159;345.04078661321535;349.8670505208019;5872.5889187756875;5946.791862284821;5949.732262048213;6017.157597936292;6040.879182416349;5770.480656740892;5915.5859089863725;5945.613535120214;5963.34403215647;5964.88070238595;4621.12198682251;4627.722336659811;4628.675992680513;4631.976840115794;4635.675502714811;4392.428984232045;4470.374147619336;4526.298423744309;4577;4616.676832621718;4558.293464512989;4573.199690054244;4583.175028494869;4584.426946631671;4605.861824145281;4567.65742569307;4575.17646823575;4585.174668559658;4588.17412865684;4595.172868883599;4051.736637118578;4052.4731784868072;4056.59434056592;4058.3100872851687;4058.452108965311;5563.332400111972;5598.608097433182;5622.184783206453;5627.240322556443;5647.774089036434;5331.786728530854;5336.30628018359;5341.545968592674;5342.198670199462;5351.25082488452;6029.21620189377;6285.748570057192;6286.748530058792;6287.811365659038;6295.2445706515055;4411.955880441186;4413.962718761089;4509.481409637868;4511.052678937427;4517.2094883395275;6557.836054098638;6581.374769396947;6603.306652801482;6611.867762644768;6628.834279143011;4601.585857272795;4605.746683932416;4607.124646317189;4607.401037865123;4608.377868987711;4361.5856493633055;4491.932621010687;4496.662750293741;4649.976750116228;4659.603933665609;5216.608754343363;5219.947800522022;5221.686698798084;5223.843284701465;5225.6603320784025;6338.080978258219;6343.809685709436;6348.174737284216;6359.491240700733;6400.551961362753;1570.387548855947;1618.3607475047527;1618.9352425903066;1619.3198856480305;1620.3923528676746;1051.7160366700948;1071.410724101741;1078.2560033576806;1086.8858769829212;1088.357868857362;6018.307894592091;6024;6035.818925432244;6038.094285857156;6058.242719660043;6547.377999090078;6562.146920900348;6563.606183628997;6569.80290591283;6620.040094186316;5964.910526342108;6028.0355143176885;6036.517078633787;6040.244969378828;6044.788432404845;3498.4927185557954;3524.559430071241;3546.4148415511154;3549.2723991581665;3555.253396786652;6802.761903333359;6807.0810440589885;6816.965915170393;6822.215445223863;6823.55646882951;6685.331466853276;6687.7993660189295;6693.665316734144;6694.062831203635;6701.597904125768;6597.538172327987;6791.966040169767;6794.048833163361;6813.080234168423;6816.318368163144;6305.936940630535;6428.19647544057;6497.122888410193;6544.214694236722;6545.574537655038;6471.579347342596;6495.837604059936;6499.837504062247;6516.446102081376;6528.67356632176;6685.465162786868;6725.663716814238;6726;6741.797746067626;6858.554193977376;4555.0413322270415;4597.609203217764;4651.883702907319;4652.185867473247;4668.743219122981;6536.379043990813;6540.182477190351;6544.8363790905605;6555.836104097436;6567.573107747981;6374;6374.713137908712;6395.264544577247;6449.4840412765925;6451.774187903401;6199.721012554356;6362.872742545031;6377.617342959437;6379.106925030406;6384.904226436514;6219.253689557282;6220.626762394271;6232.750689972531;6234.251889773256;6235.158253635883;6370.076338930921;6398.4561312287115;6404.9039264412;6409.775657851953;6419.133416988647;6099.451049405575;6247.812565623039;6254.3745625437095;6336.303006669171;6336.619802811846 09:23:41 INFO - PROCESS | 1504 | |5;yui.html;704.4153352717244;793.7063286583962;801.9799505012373;802.7872613757359;836.0218544303162;12788.936055319722;12902.354882255873;12906.483740650387;12929.418176182071;12931.935340323309;11741.941290293558;11746.295222286668;11779.941100294487;11810.940945295282;12079.516819327217;672.5325898500544;680.8365992161895;799.4683535448919;813.3168138763438;813.975580732576;806.6410447350902;809.7773112394109;816.090059583566;823.3454403749034;825.8265764189528;851.812601227732;853.799357151069;855.1234984141242;855.486707975213;862.5299211929513;702.0732632924542;714.4498735973324;843.9324854011664;854.1543871567104;859.7979474823411;618.2951435363644;622.9034499652561;623.1151764494383;627.491731697322;631.4632562322035;12553.246805191626;12632;12639;12646.74706505874;12653.240805551697;12264.754704905941;12594;12595.622131336075;12756.170848894884;13065.150765200231;9908.35595686278;9978.07508165919;10070.79858402835;10227.130693891027;10534.78930421395;3572.589152247499;3600.9099772505633;3651.1602331463646;3720.5907350191455;3736.8318425670636;45976.77011614954;46531.30203046957;46537.301940470585;46637.30044049342;47267.52732472666;10095.24285678577;10116.696499105039;10221.591136354462;10307.639232626821;10319.94840025795;18604.81395186031;18673.719894201597;18675.90662046708;18708.158132883782;18710;7374.041374621373;7424.888626670604;7473.364763995012;7475.962620186864;7674.808129796688;4005.7396269242404;4011.6590089842107;4031.2139132869397;4074.2258970795456;4156.43888075112;3000.2499375156212;3022.818630882154;3040.9847950760104;3049.84750762461;3060.5409188621884;527.1091854765434;542.2652306125144;543.3154225675677;555.5527800120941;556.585343918775;579.6408616929142;622.5704264057786;628.4187126907592;651.4397618048474;655.9901601475982;8390.664373425117;8642.524661143572;8708.259797917248;8989.595468203946;9245.260379169651;617.0531971629516;636.8789929913302;645.4986925663055;652.1261509577095;655.9180102487189;3769.9057523561582;3921.941170882382;3976.2643910876004;4028.2749105160765;4030.7783071931326;54776.45223547793;55795;55831.16253256204;55922;55936.440635593935;49147.262791058165;51254.487455125716;51454.48545514572;51472.22791658128;51798.48201517937;42655.36016959748;43096.784516077845;43300.78349608232;44178.33732494015;45803.31295030644;7835.294823465915;7864.5281283123195;7889.763307100796;7928.246816552649;7974.561399122872;33105;33187.83406083051;33989.49015764716;34181.829090854386;34213.486797698555;40594;43790;44438;44543.10913781771;44951.775241124895;9209.907900920905;9259;9456.19622332082;9555.140037396668;9664.081912218327;10351.585936562453;10603.257771956198;10716.410597417216;10805.729856753644;11160.720981975192;9455;9717.611295548382;9728.805423891341;9955.253355998184;10281.53733082028;10427;10557.894421055691;10570.78858422812;10890.976232372486;10965.013148816644;8131.471454355448;10277.331973422002;10556.894431055898;10777.784444311226;10961.50673219723;8561;8600.22597966186;8626.870596941177;8973.192412682889;9113.3165012623;9342.579583918876;9387.953060234655;9470.57382417779;9720.951395242979;9749.562609347664 09:23:41 INFO - PROCESS | 1504 | __end_tp_report 09:23:41 INFO - PROCESS | 1504 | __start_cc_report 09:23:41 INFO - PROCESS | 1504 | _x_x_mozilla_cycle_collect,731 09:23:41 INFO - PROCESS | 1504 | __end_cc_report 09:23:41 INFO - PROCESS | 1504 | __startTimestamp1452792221923__endTimestamp 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | ------- Summary: start ------- 09:23:41 INFO - PROCESS | 1504 | Number of tests: 6 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | [#0] dojo.html Cycles:165 Average:4980.26 Median:5154.79 stddev:524.22 (10.2%) stddev-sans-first:503.70 09:23:41 INFO - PROCESS | 1504 | Values: 3059.3 3091.7 3138.5 3138.9 3158.7 4768.6 4848.3 5026.7 5039.9 5066.6 4963.3 4969.0 4979.6 5055.4 5131.6 4362.8 4493.6 4566.6 4624.7 4685.1 4506.3 4638.0 4639.3 4704.0 4725.1 4492.5 4545.1 4594.6 4622.1 4643.4 4593.7 4598.0 4607.3 4611.5 4642.5 4507.6 4587.7 4590.4 4594.5 4616.9 4866.5 4872.6 4884.2 4884.9 4888.4 5310.0 5311.2 5315.1 5315.7 5322.4 5337.0 5339.0 5358.8 5398.3 5441.4 5064.5 5077.8 5078.8 5094.8 5096.7 5480.9 5500.9 5508.4 5588.9 5589.8 5154.8 5163.0 5210.8 5280.2 5283.7 5359.5 5378.4 5383.9 5390.1 5403.4 5318.2 5353.1 5354.2 5368.0 5416.5 5181.3 5264.2 5333.6 5361.1 5408.3 4149.8 4168.7 4171.5 4179.6 4222.2 3746.9 3749.2 3759.4 3780.8 3786.9 4894.5 4958.6 4971.2 4990.7 5086.4 5362.5 5371.2 5375.8 5378.2 5385.2 5006.5 5013.7 5025.9 5027.5 5061.2 4526.6 4533.8 4538.3 4563.5 4597.4 5497.0 5505.1 5517.6 5527.2 5585.2 5240.1 5327.8 5338.3 5341.3 5343.2 5453.8 5470.9 5505.8 5531.5 5579.2 5283.7 5285.4 5296.0 5297.3 5298.4 5237.7 5341.3 5353.0 5370.8 5411.9 5134.8 5137.7 5154.3 5171.9 5173.1 5195.7 5199.5 5201.5 5204.1 5257.7 5069.5 5122.6 5135.2 5135.8 5167.1 5271.6 5317.2 5322.5 5340.8 5373.7 5157.7 5161.2 5161.7 5163.7 5166.7 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | [#1] ext.html Cycles:180 Average:47545.80 Median:32444.77 stddev:81721.41 (251.9%) stddev-sans-first:81874.38 09:23:41 INFO - PROCESS | 1504 | Values: 518.6 524.8 526.3 540.2 542.0 28598.3 29052.3 29052.4 29087.4 36784.6 39840.8 40324.0 40326.6 40350.2 40418.0 8464.2 8651.7 8666.3 8669.4 8676.6 7485.6 7700.7 8400.1 10081.7 10362.4 10006.7 10170.6 10176.4 10182.9 10204.1 10240.3 10415.4 10416.2 10452.8 10458.9 10249.2 10385.0 10388.4 10391.0 10392.9 40529.0 40876.8 40925.0 40934.6 41049.8 3200.4 3204.5 3249.7 3296.5 3405.3 30322.2 30431.1 30615.0 30876.5 31471.5 3950.7 4028.4 4029.9 4116.7 4236.4 267946.0 269640.0 270976.6 271929.0 273023.0 54062.7 55135.4 62555.4 63075.4 63611.7 56618.7 57125.0 57162.0 57177.3 57209.4 13482.7 13775.2 13777.7 13786.4 13820.7 10142.2 10196.0 10254.5 10284.3 10284.4 20903.0 20946.6 21126.5 21191.4 21404.0 8029.5 8069.2 8170.3 8262.3 8316.8 896.8 909.4 1004.9 1040.5 1143.1 28362.9 29275.3 29453.6 31237.4 31746.1 1020.3 1034.7 1041.7 1071.5 1095.9 14253.7 14336.0 14371.9 14389.4 14543.9 366467.0 371605.0 371623.0 372131.0 372959.0 55038.0 55794.0 55815.4 55866.4 55869.2 1176.7 1238.6 1276.1 1297.0 1359.0 26265.2 27538.6 29045.6 29326.6 29807.3 41386.6 41784.6 41880.6 42374.6 43063.6 184113.0 300232.0 303711.0 304412.0 306935.0 30922.4 31421.0 31595.0 31621.7 31630.3 39473.6 40120.6 40695.0 40863.2 40928.0 34516.3 34565.9 34904.8 35068.6 37642.6 37154.0 37759.0 37900.0 38213.0 38651.6 36360.6 36975.3 37211.4 37287.8 37301.8 31515.5 32028.0 33861.5 33867.0 34008.8 32087.4 32370.5 32444.4 32445.2 32814.8 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | [#2] jquery.html Cycles:180 Average:26039.30 Median:60015.70 stddev:76703.01 (127.8%) stddev-sans-first:76893.96 09:23:41 INFO - PROCESS | 1504 | Values: 369.6 372.5 373.8 374.2 375.2 14412.3 15459.5 15538.2 16517.8 17116.7 11120.1 11412.9 11428.8 11429.7 16517.4 4449.8 5887.4 6070.3 6070.7 6073.0 4518.5 6586.6 6822.0 6824.0 6828.2 6516.3 6858.8 6862.5 6864.1 6868.7 6653.3 6792.5 6832.4 6904.1 6918.7 6360.1 6586.9 6620.6 6634.5 6640.2 21457.2 21625.4 22157.8 22195.7 22219.4 1892.6 1966.5 2090.5 2162.1 2239.7 13215.3 13418.3 13563.4 13739.6 14197.7 1854.5 1899.2 1900.4 1900.8 1937.4 57434.7 59283.0 59508.4 60523.0 60914.7 14662.7 15025.4 15042.5 15044.8 15073.0 22685.3 22799.0 22997.1 23101.2 23128.4 8484.4 8513.7 8538.1 8618.7 8635.6 7093.4 7145.9 7220.1 7231.4 7237.3 6819.7 7157.1 7338.7 7356.4 7593.2 2895.7 2917.5 2984.4 3134.3 3144.8 726.6 908.7 965.1 973.2 1000.8 14248.8 15580.1 15698.2 16480.0 17402.7 847.5 854.4 863.9 891.4 972.2 7748.9 8210.2 8523.6 8729.4 9182.1 440070.0 444760.0 445693.0 491759.0 521441.0 64644.4 66505.0 68071.7 68819.0 70407.5 1162.5 1163.8 1167.1 1183.2 1184.1 14693.5 14850.6 15034.9 15132.0 15141.5 31356.7 31841.8 32077.0 32266.0 33115.7 41278.4 41448.4 42245.6 43077.1 43177.6 7020.5 7181.7 7211.5 7289.6 7366.9 8692.6 10571.7 10847.0 11049.5 11113.9 8177.8 8680.3 8728.9 8830.4 9562.4 7451.5 8958.4 9199.4 9416.1 9592.6 8639.2 8650.8 8680.6 8798.3 8816.4 7076.9 7249.7 7313.3 7378.2 7402.0 8497.6 9273.3 9276.0 9299.4 9424.0 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | [#3] mootools.html Cycles:180 Average:5434.01 Median:6466.87 stddev:2796.82 (43.2%) stddev-sans-first:2786.84 09:23:41 INFO - PROCESS | 1504 | Values: 1233.5 1474.0 1491.6 1656.3 1803.3 6670.9 7399.8 7598.8 7648.4 7658.2 7384.6 7510.3 7533.1 7572.8 7586.7 1910.4 1936.6 1956.7 2268.2 2293.5 1951.6 2253.2 2307.8 2311.7 2312.1 2210.6 2230.1 2244.5 2247.9 2316.2 2248.9 2269.0 2271.6 2271.6 2274.0 2217.6 2245.4 2245.8 2246.9 2248.0 7687.6 7717.5 7734.5 7738.1 7793.7 4743.1 4897.7 4898.0 4902.5 4903.9 3029.5 3112.5 3127.3 3146.5 3168.1 974.9 984.4 998.2 1027.6 1048.2 10671.2 10680.2 10689.3 10691.5 10698.6 4287.1 4287.6 4325.2 4338.8 4365.0 9206.8 9224.5 9234.2 9236.6 9244.3 4798.7 4802.9 4803.4 4804.5 4808.3 4318.6 4369.1 4369.9 4370.4 4377.1 3334.2 3689.4 3737.0 3763.9 3781.5 1089.6 1110.7 1120.5 1121.5 1178.3 1213.7 1217.5 1231.9 1242.8 1242.9 7112.8 7134.4 7187.9 7303.0 7316.0 1106.6 1114.0 1119.0 1120.2 1145.7 5661.9 5767.5 5767.8 5790.5 5795.2 8846.0 8971.5 9110.0 9161.2 9210.2 9066.0 9100.5 9173.0 9179.1 9184.8 6979.5 7158.2 7219.2 7289.2 7289.6 7296.0 7392.9 7394.7 7405.0 7406.0 8098.9 8421.5 8485.7 8495.6 8611.1 8221.5 8456.7 8602.6 8610.0 8640.5 6745.5 6933.5 6965.9 6993.1 6994.3 7423.2 7477.9 7483.5 7489.7 7491.2 6182.5 6597.9 6939.5 7180.2 7192.9 6861.4 6935.2 6955.6 7082.3 7120.3 6931.0 6976.3 6987.0 6995.7 6996.8 6315.3 6448.8 6458.6 6502.5 6503.2 6475.1 6578.1 6582.3 6586.4 6594.9 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | [#4] prototype.html Cycles:180 Average:5311.14 Median:6021.15 stddev:1590.06 (26.4%) stddev-sans-first:1550.02 09:23:41 INFO - PROCESS | 1504 | Values: 334.4 337.6 340.6 345.0 349.9 5872.6 5946.8 5949.7 6017.2 6040.9 5770.5 5915.6 5945.6 5963.3 5964.9 4621.1 4627.7 4628.7 4632.0 4635.7 4392.4 4470.4 4526.3 4577.0 4616.7 4558.3 4573.2 4583.2 4584.4 4605.9 4567.7 4575.2 4585.2 4588.2 4595.2 4051.7 4052.5 4056.6 4058.3 4058.5 5563.3 5598.6 5622.2 5627.2 5647.8 5331.8 5336.3 5341.5 5342.2 5351.3 6029.2 6285.7 6286.7 6287.8 6295.2 4412.0 4414.0 4509.5 4511.1 4517.2 6557.8 6581.4 6603.3 6611.9 6628.8 4601.6 4605.7 4607.1 4607.4 4608.4 4361.6 4491.9 4496.7 4650.0 4659.6 5216.6 5219.9 5221.7 5223.8 5225.7 6338.1 6343.8 6348.2 6359.5 6400.6 1570.4 1618.4 1618.9 1619.3 1620.4 1051.7 1071.4 1078.3 1086.9 1088.4 6018.3 6024.0 6035.8 6038.1 6058.2 6547.4 6562.1 6563.6 6569.8 6620.0 5964.9 6028.0 6036.5 6040.2 6044.8 3498.5 3524.6 3546.4 3549.3 3555.3 6802.8 6807.1 6817.0 6822.2 6823.6 6685.3 6687.8 6693.7 6694.1 6701.6 6597.5 6792.0 6794.0 6813.1 6816.3 6305.9 6428.2 6497.1 6544.2 6545.6 6471.6 6495.8 6499.8 6516.4 6528.7 6685.5 6725.7 6726.0 6741.8 6858.6 4555.0 4597.6 4651.9 4652.2 4668.7 6536.4 6540.2 6544.8 6555.8 6567.6 6374.0 6374.7 6395.3 6449.5 6451.8 6199.7 6362.9 6377.6 6379.1 6384.9 6219.3 6220.6 6232.8 6234.3 6235.2 6370.1 6398.5 6404.9 6409.8 6419.1 6099.5 6247.8 6254.4 6336.3 6336.6 09:23:41 INFO - PROCESS | 1504 | 09:23:41 INFO - PROCESS | 1504 | [#5] yui.html Cycles:180 Average:13276.24 Median:51463.36 stddev:15516.02 (30.1%) stddev-sans-first:15530.83 09:23:41 INFO - PROCESS | 1504 | Values: 704.4 793.7 802.0 802.8 836.0 12788.9 12902.4 12906.5 12929.4 12931.9 11741.9 11746.3 11779.9 11810.9 12079.5 672.5 680.8 799.5 813.3 814.0 806.6 809.8 816.1 823.3 825.8 851.8 853.8 855.1 855.5 862.5 702.1 714.4 843.9 854.2 859.8 618.3 622.9 623.1 627.5 631.5 12553.2 12632.0 12639.0 12646.7 12653.2 12264.8 12594.0 12595.6 12756.2 13065.2 9908.4 9978.1 10070.8 10227.1 10534.8 3572.6 3600.9 3651.2 3720.6 3736.8 45976.8 46531.3 46537.3 46637.3 47267.5 10095.2 10116.7 10221.6 10307.6 10319.9 18604.8 18673.7 18675.9 18708.2 18710.0 7374.0 7424.9 7473.4 7476.0 7674.8 4005.7 4011.7 4031.2 4074.2 4156.4 3000.2 3022.8 3041.0 3049.8 3060.5 527.1 542.3 543.3 555.6 556.6 579.6 622.6 628.4 651.4 656.0 8390.7 8642.5 8708.3 8989.6 9245.3 617.1 636.9 645.5 652.1 655.9 3769.9 3921.9 3976.3 4028.3 4030.8 54776.5 55795.0 55831.2 55922.0 55936.4 49147.3 51254.5 51454.5 51472.2 51798.5 42655.4 43096.8 43300.8 44178.3 45803.3 7835.3 7864.5 7889.8 7928.2 7974.6 33105.0 33187.8 33989.5 34181.8 34213.5 40594.0 43790.0 44438.0 44543.1 44951.8 9209.9 9259.0 9456.2 9555.1 9664.1 10351.6 10603.3 10716.4 10805.7 11160.7 9455.0 9717.6 9728.8 9955.3 10281.5 10427.0 10557.9 10570.8 10891.0 10965.0 8131.5 10277.3 10556.9 10777.8 10961.5 8561.0 8600.2 8626.9 8973.2 9113.3 9342.6 9388.0 9470.6 9721.0 9749.6 09:23:41 INFO - PROCESS | 1504 | -------- Summary: end -------- 09:23:41 INFO - PROCESS | 1504 | 09:23:42 INFO - TEST-INFO | 1504: exit 0 09:23:42 INFO - TEST-OK | dromaeo_css | took 1112740ms 09:23:42 INFO - TEST-START | kraken 09:23:42 INFO - operating with platform_type : linux_ 09:23:42 INFO - Initialising browser for kraken test... 09:23:42 INFO - TEST-INFO | started process 1700 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLqNpbW/profile http://localhost:48267/getInfo.html) 09:23:46 INFO - PROCESS | 1700 | __metrics Screen width/height:1600/1200 09:23:46 INFO - PROCESS | 1700 | colorDepth:24 09:23:46 INFO - PROCESS | 1700 | Browser inner width/height: 1024/697 09:23:46 INFO - PROCESS | 1700 | __metrics 09:23:46 INFO - PROCESS | 1700 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:23:47 INFO - PROCESS | 1700 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:23:47 INFO - TEST-INFO | 1700: exit 0 09:23:47 INFO - Browser initialized. 09:23:47 INFO - Running cycle 1/1 for kraken test... 09:23:47 INFO - TEST-INFO | started process 1784 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLqNpbW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:59 INFO - PROCESS | 1784 | RSS: Main: 150458368 09:23:59 INFO - PROCESS | 1784 | 09:24:02 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:02 INFO - PROCESS | 1784 | RSS: Main: 186638336 09:24:02 INFO - PROCESS | 1784 | 09:24:05 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-dft) 09:24:05 INFO - PROCESS | 1784 | RSS: Main: 176644096 09:24:05 INFO - PROCESS | 1784 | 09:24:08 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-fft) 09:24:09 INFO - PROCESS | 1784 | RSS: Main: 161542144 09:24:09 INFO - PROCESS | 1784 | 09:24:11 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-oscillator) 09:24:12 INFO - PROCESS | 1784 | RSS: Main: 164814848 09:24:12 INFO - PROCESS | 1784 | 09:24:14 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:14 INFO - PROCESS | 1784 | RSS: Main: 166367232 09:24:14 INFO - PROCESS | 1784 | 09:24:17 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48267/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:18 INFO - PROCESS | 1784 | RSS: Main: 166080512 09:24:18 INFO - PROCESS | 1784 | 09:24:21 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48267/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:22 INFO - PROCESS | 1784 | RSS: Main: 165691392 09:24:22 INFO - PROCESS | 1784 | 09:24:24 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48267/tests/kraken/driver.html?testName=json-parse-financial) 09:24:25 INFO - PROCESS | 1784 | RSS: Main: 166981632 09:24:25 INFO - PROCESS | 1784 | 09:24:27 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:27 INFO - PROCESS | 1784 | RSS: Main: 176746496 09:24:27 INFO - PROCESS | 1784 | 09:24:29 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:30 INFO - PROCESS | 1784 | RSS: Main: 173944832 09:24:30 INFO - PROCESS | 1784 | 09:24:32 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:32 INFO - PROCESS | 1784 | RSS: Main: 183103488 09:24:32 INFO - PROCESS | 1784 | 09:24:35 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:35 INFO - PROCESS | 1784 | RSS: Main: 191021056 09:24:35 INFO - PROCESS | 1784 | 09:24:38 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:38 INFO - PROCESS | 1784 | RSS: Main: 190013440 09:24:38 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48267/tests/kraken/driver.html?testName=ai-astar) 09:24:40 INFO - PROCESS | 1784 | RSS: Main: 248942592 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | __start_tp_report 09:24:40 INFO - PROCESS | 1784 | _x_x_mozilla_page_load 09:24:40 INFO - PROCESS | 1784 | _x_x_mozilla_page_load_details 09:24:40 INFO - PROCESS | 1784 | |i|pagename|runs| 09:24:40 INFO - PROCESS | 1784 | |0;ai-astar;108;111;105;112;111;111;102;112;110;110 09:24:40 INFO - PROCESS | 1784 | |1;audio-beat-detection;150;127;152;164;124;155;166;125;167;127 09:24:40 INFO - PROCESS | 1784 | |2;audio-dft;162;162;160;161;160;161;161;163;163;163 09:24:40 INFO - PROCESS | 1784 | |3;audio-fft;71;74;98;92;73;71;71;119;96;72 09:24:40 INFO - PROCESS | 1784 | |4;audio-oscillator;95;96;143;96;97;97;143;97;96;139 09:24:40 INFO - PROCESS | 1784 | |5;imaging-gaussian-blur;109;109;108;109;109;110;109;109;109;109 09:24:40 INFO - PROCESS | 1784 | |6;imaging-darkroom;146;145;145;146;146;147;146;147;145;146 09:24:40 INFO - PROCESS | 1784 | |7;imaging-desaturate;95;96;95;96;96;95;96;96;96;96 09:24:40 INFO - PROCESS | 1784 | |8;json-parse-financial;58;56;55;54;55;54;54;64;53;52 09:24:40 INFO - PROCESS | 1784 | |9;json-stringify-tinderbox;67;67;67;68;67;68;68;67;68;68 09:24:40 INFO - PROCESS | 1784 | |10;stanford-crypto-aes;81;90;83;83;83;82;83;84;82;81 09:24:40 INFO - PROCESS | 1784 | |11;stanford-crypto-ccm;116;127;123;116;115;117;123;124;123;123 09:24:40 INFO - PROCESS | 1784 | |12;stanford-crypto-pbkdf2;151;141;161;149;153;137;149;149;147;157 09:24:40 INFO - PROCESS | 1784 | |13;stanford-crypto-sha256-iterative;67;67;68;69;67;67;66;67;67;66 09:24:40 INFO - PROCESS | 1784 | __end_tp_report 09:24:40 INFO - PROCESS | 1784 | __start_cc_report 09:24:40 INFO - PROCESS | 1784 | _x_x_mozilla_cycle_collect,934 09:24:40 INFO - PROCESS | 1784 | __end_cc_report 09:24:40 INFO - PROCESS | 1784 | __startTimestamp1452792280744__endTimestamp 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | ------- Summary: start ------- 09:24:40 INFO - PROCESS | 1784 | Number of tests: 14 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.29 (3.0%) stddev-sans-first:3.46 09:24:40 INFO - PROCESS | 1784 | Values: 108.0 111.0 105.0 112.0 111.0 111.0 102.0 112.0 110.0 110.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:153.50 stddev:18.09 (11.8%) stddev-sans-first:19.12 09:24:40 INFO - PROCESS | 1784 | Values: 150.0 127.0 152.0 164.0 124.0 155.0 166.0 125.0 167.0 127.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 09:24:40 INFO - PROCESS | 1784 | Values: 162.0 162.0 160.0 161.0 160.0 161.0 161.0 163.0 163.0 163.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#3] audio-fft Cycles:10 Average:83.70 Median:73.50 stddev:16.67 (22.7%) stddev-sans-first:17.03 09:24:40 INFO - PROCESS | 1784 | Values: 71.0 74.0 98.0 92.0 73.0 71.0 71.0 119.0 96.0 72.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:21.96 (22.9%) stddev-sans-first:22.62 09:24:40 INFO - PROCESS | 1784 | Values: 95.0 96.0 143.0 96.0 97.0 97.0 143.0 97.0 96.0 139.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:24:40 INFO - PROCESS | 1784 | Values: 109.0 109.0 108.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:24:40 INFO - PROCESS | 1784 | Values: 146.0 145.0 145.0 146.0 146.0 147.0 146.0 147.0 145.0 146.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:24:40 INFO - PROCESS | 1784 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.41 (6.2%) stddev-sans-first:3.49 09:24:40 INFO - PROCESS | 1784 | Values: 58.0 56.0 55.0 54.0 55.0 54.0 54.0 64.0 53.0 52.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:24:40 INFO - PROCESS | 1784 | Values: 67.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 68.0 68.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.57 (3.1%) stddev-sans-first:2.60 09:24:40 INFO - PROCESS | 1784 | Values: 81.0 90.0 83.0 83.0 83.0 82.0 83.0 84.0 82.0 81.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:123.00 stddev:4.24 (3.5%) stddev-sans-first:4.15 09:24:40 INFO - PROCESS | 1784 | Values: 116.0 127.0 123.0 116.0 115.0 117.0 123.0 124.0 123.0 123.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:150.00 stddev:6.98 (4.7%) stddev-sans-first:7.38 09:24:40 INFO - PROCESS | 1784 | Values: 151.0 141.0 161.0 149.0 153.0 137.0 149.0 149.0 147.0 157.0 09:24:40 INFO - PROCESS | 1784 | 09:24:40 INFO - PROCESS | 1784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 09:24:40 INFO - PROCESS | 1784 | Values: 67.0 67.0 68.0 69.0 67.0 67.0 66.0 67.0 67.0 66.0 09:24:40 INFO - PROCESS | 1784 | -------- Summary: end -------- 09:24:40 INFO - PROCESS | 1784 | 09:24:41 INFO - TEST-INFO | 1784: exit 0 09:24:41 INFO - TEST-OK | kraken | took 58990ms 09:24:41 INFO - TEST-START | v8_7 09:24:41 INFO - operating with platform_type : linux_ 09:24:41 INFO - Initialising browser for v8_7 test... 09:24:41 INFO - TEST-INFO | started process 2031 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2WEzed/profile http://localhost:48267/getInfo.html) 09:24:45 INFO - PROCESS | 2031 | __metrics Screen width/height:1600/1200 09:24:45 INFO - PROCESS | 2031 | colorDepth:24 09:24:45 INFO - PROCESS | 2031 | Browser inner width/height: 1024/697 09:24:45 INFO - PROCESS | 2031 | __metrics 09:24:45 INFO - PROCESS | 2031 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:24:45 INFO - PROCESS | 2031 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:46 INFO - TEST-INFO | 2031: exit 0 09:24:46 INFO - Browser initialized. 09:24:46 INFO - Running cycle 1/1 for v8_7 test... 09:24:46 INFO - TEST-INFO | started process 2113 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2WEzed/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:58 INFO - PROCESS | 2113 | RSS: Main: 150224896 09:24:58 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:48267/tests/v8_7/run.html (next: http://localhost:48267/tests/v8_7/run.html) 09:25:21 INFO - PROCESS | 2113 | RSS: Main: 560758784 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | __start_tp_report 09:25:21 INFO - PROCESS | 2113 | _x_x_mozilla_page_load 09:25:21 INFO - PROCESS | 2113 | _x_x_mozilla_page_load_details 09:25:21 INFO - PROCESS | 2113 | |i|pagename|runs| 09:25:21 INFO - PROCESS | 2113 | |0;Richards;167.7570877369569 09:25:21 INFO - PROCESS | 2113 | |1;DeltaBlue;190.00570017100512 09:25:21 INFO - PROCESS | 2113 | |2;Encrypt;279.79854504756577 09:25:21 INFO - PROCESS | 2113 | |3;Decrypt;5263.1578947368425 09:25:21 INFO - PROCESS | 2113 | |4;RayTrace;1123.5955056179776 09:25:21 INFO - PROCESS | 2113 | |5;Earley;784.3137254901961 09:25:21 INFO - PROCESS | 2113 | |6;Boyer;12382.716049382716 09:25:21 INFO - PROCESS | 2113 | |7;RegExp;43000 09:25:21 INFO - PROCESS | 2113 | |8;Splay;586.0655737704918 09:25:21 INFO - PROCESS | 2113 | |9;NavierStokes;4840.579710144928 09:25:21 INFO - PROCESS | 2113 | __end_tp_report 09:25:21 INFO - PROCESS | 2113 | __startTimestamp1452792321246__endTimestamp 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | ------- Summary: start ------- 09:25:21 INFO - PROCESS | 2113 | Number of tests: 10 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 167.8 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#1] DeltaBlue Cycles:1 Average:190.01 Median:190.01 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 190.0 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 279.8 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 5263.2 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#4] RayTrace Cycles:1 Average:1123.60 Median:1123.60 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 1123.6 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 784.3 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 12382.7 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#7] RegExp Cycles:1 Average:43000.00 Median:43000.00 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 43000.0 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#8] Splay Cycles:1 Average:586.07 Median:586.07 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 586.1 09:25:21 INFO - PROCESS | 2113 | 09:25:21 INFO - PROCESS | 2113 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:25:21 INFO - PROCESS | 2113 | Values: 4840.6 09:25:21 INFO - PROCESS | 2113 | -------- Summary: end -------- 09:25:21 INFO - PROCESS | 2113 | 09:25:22 INFO - TEST-INFO | 2113: exit 0 09:25:22 INFO - TEST-OK | v8_7 | took 40471ms 09:25:22 INFO - SUITE-END | took 1212s 09:25:22 INFO - Completed test suite (00:20:12) 09:25:22 INFO - Working with test: dromaeo_css 09:25:22 INFO - Generating results file: dromaeo_css 09:25:22 INFO - Working with test: kraken 09:25:22 INFO - Generating results file: kraken 09:25:22 INFO - javascript benchmark 09:25:22 INFO - Working with test: v8_7 09:25:22 INFO - Generating results file: v8_7 09:25:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 09:25:22 INFO - process_Request line: dromaeo_css 6864.85 graph.html#tests=[[72,1,35]] 09:25:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:22 INFO - process_Request line: kraken 1504.10 graph.html#tests=[[232,1,35]] 09:25:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:22 INFO - process_Request line: v8_7 19979.48 graph.html#tests=[[230,1,35]] 09:25:22 INFO - RETURN: dromaeo_css: 6864.85 09:25:22 INFO - RETURN: kraken: 1504.10 09:25:22 INFO - RETURN: v8_7: 19979.48 09:25:22 INFO - javascript benchmark 09:25:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3059.2657762137087, 3091.6599174090834, 3138.4664607016803, 3138.905832825015, 3158.731507821835, 4768.64235182361, 4848.345473361095, 5026.673266237696, 5039.949600503994, 5066.620003499738, 4963.329950456688, 4968.9503104968935, 4979.626528010395, 5055.418626857912, 5131.615128865331, 4362.781860906958, 4493.550644935497, 4566.611837993774, 4624.699394539344, 4685.108652844316, 4506.346579745935, 4638.0, 4639.327297541854, 4703.952960470386, 4725.125851717443, 4492.460904691442, 4545.136424079431, 4594.632429405639, 4622.098690755304, 4643.3963584733765, 4593.724376537385, 4597.977010114962, 4607.308903664443, 4611.515790841981, 4642.489326174118, 4507.639388848885, 4587.747673877935, 4590.42619672541, 4594.494605593415, 4616.907661846778, 4866.513348665105, 4872.561469467765, 4884.169691152477, 4884.902301953976, 4888.364512613373, 5310.0, 5311.203319502067, 5315.096433606258, 5315.734213289359, 5322.414534401213, 5337.0, 5338.973305133488, 5358.785648574052, 5398.2712333834825, 5441.374241962146, 5064.493550644943, 5077.771500282459, 5078.771455284521, 5094.821681241176, 5096.694198348111, 5480.91778623321, 5500.862478438071, 5508.44915508446, 5588.91616625751, 5589.80435684749, 5154.793808247703, 5163.044836705221, 5210.817621383233, 5280.155175171954, 5283.656562323436, 5359.517643412111, 5378.381486129067, 5383.892322153535, 5390.110631745718, 5403.378611459732, 5318.22885681574, 5353.143497040455, 5354.196870469383, 5368.0, 5416.458354164631, 5181.326427564392, 5264.210368444764, 5333.57331413486, 5361.1422172453, 5408.296921400193, 4149.8340066397, 4168.687348448879, 4171.541130475645, 4179.623833854967, 4222.218889505451, 3746.8501259949844, 3749.1751814600743, 3759.3984962405884, 3780.8109594520715, 3786.924261514754, 4894.461609222983, 4958.578520825698, 4971.204607262821, 4990.72551009698, 5086.440491545927, 5362.544183744348, 5371.167469042305, 5375.838724838261, 5378.19327100938, 5385.219143224211, 5006.549410552995, 5013.724245166551, 5025.924611130836, 5027.522385373457, 5061.1902095665255, 4526.615237704832, 4533.795979180944, 4538.273876179861, 4563.475200351935, 4597.42532183477, 5496.972515137479, 5505.146702261076, 5517.613767036269, 5527.226188333637, 5585.190147428519, 5240.109181439241, 5327.813526526553, 5338.252644629677, 5341.332333458317, 5343.171808369709, 5453.7818487260065, 5470.91793623104, 5505.752241149238, 5531.502164805026, 5579.218909352613, 5283.709395983258, 5285.418603953639, 5295.973520132375, 5297.2583838263445, 5298.44366341544, 5237.659552129099, 5341.278927344914, 5353.0096932066135, 5370.812021579226, 5411.864703382447, 5134.820281290137, 5137.691738495702, 5154.329937108152, 5171.870703232299, 5173.14643083902, 5195.6622819516615, 5199.48005199477, 5201.479852014768, 5204.0892843751435, 5257.737113144404, 5069.518395752398, 5122.590192784643, 5135.15269980449, 5135.845924622267, 5167.095758242368, 5271.604629652715, 5317.229001794641, 5322.520973112439, 5340.813071542478, 5373.731313434391, 5157.742112894265, 5161.174212126042, 5161.664491808171, 5163.690178589297, 5166.715830629201], "unit": "score", "name": "dojo.html", "value": 4948.559703258304}, {"lowerIsBetter": false, "replicates": [518.6499113098658, 524.7612336386944, 526.3368156123283, 540.2220802045052, 541.9810306639267, 28598.28504287394, 29052.27369315768, 29052.41895162098, 29087.41825163498, 36784.63215367845, 39840.80079599598, 40324.0, 40326.59673403265, 40350.19299614013, 40418.0, 8464.195901389357, 8651.740447786577, 8666.263367613761, 8669.393142480028, 8676.566171691422, 7485.588292643903, 7700.653470593837, 8400.117987611304, 10081.747956301115, 10362.430066346347, 10006.69979900604, 10170.64402745904, 10176.38941663499, 10182.9490852546, 10204.132648724868, 10240.334378265426, 10415.375077495337, 10416.218783591261, 10452.790944181112, 10458.947705261426, 10249.180065594808, 10385.0, 10388.37669739818, 10391.0, 10392.896071039344, 40529.0, 40876.79561602203, 40925.0, 40934.59065409367, 41049.794751026355, 3200.3759266942957, 3204.4872820348633, 3249.675032496755, 3296.538484612156, 3405.3019131078067, 30322.188812999142, 30431.087067388013, 30615.0, 30876.536851947014, 31471.52792708111, 3950.723449358546, 4028.4158796974275, 4029.8992525186814, 4116.711830171889, 4236.406903033578, 267946.0, 269640.0, 270976.6451167751, 271929.0, 273023.0, 54062.72968635132, 55135.44864551303, 62555.37444625587, 63075.36924630695, 63611.68194159092, 56618.716906415204, 57125.0, 57162.0, 57177.28106705542, 57209.42790572124, 13482.730345393038, 13775.173489590456, 13777.655558610915, 13786.448542058206, 13820.654483637789, 10142.18862490999, 10196.031377019171, 10254.48727563619, 10284.28010039305, 10284.434356110336, 20903.0, 20946.581068378546, 21126.47183820386, 21191.364259072252, 21403.966623170774, 8029.478083924643, 8069.193080691884, 8170.346372290202, 8262.256396924306, 8316.750497485085, 896.7937374403793, 909.4088842252456, 1004.8542961270575, 1040.469360626071, 1143.0741099709262, 28362.858185709352, 29275.268118296786, 29453.55819662707, 31237.37525249482, 31746.142847143867, 1020.321486211661, 1034.715453250347, 1041.6979076067855, 1071.5338827610015, 1095.8630171228597, 14253.714925701428, 14336.0, 14371.856281437053, 14389.42442302317, 14543.854561454462, 366467.0, 371605.0, 371623.0, 372131.0, 372959.0, 55038.0, 55794.0, 55815.44184558184, 55866.44133558694, 55869.16196257059, 1176.6940595445076, 1238.6098379010582, 1276.0875973678678, 1297.0, 1358.959231223065, 26265.212043638723, 27538.5869211966, 29045.564316535692, 29326.560101598065, 29807.254818629706, 41386.58613413827, 41784.58215417807, 41880.58119418889, 42374.576254238294, 43063.55491560605, 184113.0, 300232.0, 303711.0, 304412.0, 306935.0, 30922.381552368377, 31421.0, 31595.0, 31621.683783161872, 31630.311423528336, 39473.60526394814, 40120.59879401168, 40695.0, 40863.1827363457, 40928.0, 34516.30967380588, 34565.85209774843, 34904.82547587246, 35068.64931350756, 37642.623573763914, 37154.0, 37758.97548598494, 37900.0, 38213.0, 38651.6134838648, 36360.63639363572, 36975.260494789414, 37211.44182837205, 37287.81356093311, 37301.81349093237, 31515.52726709147, 32028.0, 33861.492077618364, 33867.0, 34008.829955850066, 32087.358252834347, 32370.514442283857, 32444.351112977136, 32445.18887027749, 32814.83592582117], "unit": "score", "name": "ext.html", "value": 18642.391229249373}, {"lowerIsBetter": false, "replicates": [369.6231537522728, 372.47853005791893, 373.79441307281024, 374.2216190324126, 375.20269427466644, 14412.279386030683, 15459.458918937826, 15538.223088845541, 16517.83482165178, 17116.65766684667, 11120.054795342385, 11412.942935285333, 11428.828567571492, 11429.657110286706, 16517.421890233843, 4449.799759010836, 5887.381824908376, 6070.332263451039, 6070.6661133637635, 6073.0, 4518.502964673883, 6586.637734924578, 6822.0, 6824.0446337512785, 6828.214755303129, 6516.315786842384, 6858.759943401982, 6862.451003919675, 6864.073350097723, 6868.690908909086, 6653.2681405045405, 6792.524523283372, 6832.419244364235, 6904.067950826624, 6918.723251069951, 6360.109584658106, 6586.868262634768, 6620.6358650274215, 6634.502412319095, 6640.236372817091, 21457.248996285056, 21625.35123946284, 22157.77842221573, 22195.66706499404, 22219.44451388712, 1892.5647101166808, 1966.547694030381, 2090.5296308330658, 2162.0703097667997, 2239.6864438978555, 13215.33923303831, 13418.329083545881, 13563.389647465889, 13739.587812365646, 14197.716045679132, 1854.4807453912927, 1899.1928430417017, 1900.3918746001284, 1900.809919008102, 1937.4187743676982, 57434.71282643602, 59283.0, 59508.40491595072, 60523.0, 60914.69542652259, 14662.706745865236, 15025.398984040516, 15042.473513426978, 15044.849551504563, 15073.0, 22685.319440416813, 22799.0, 22997.08011679514, 23101.19145829888, 23128.4217894554, 8484.36367272457, 8513.659453621909, 8538.146185381413, 8618.655253789779, 8635.611397487128, 7093.361597456151, 7145.857082858313, 7220.0613920190035, 7231.385332246713, 7237.276272372721, 6819.727210911508, 7157.0675917501985, 7338.706451741978, 7356.36771859798, 7593.164751877289, 2895.7104289570875, 2917.5331946888396, 2984.373281610886, 3134.2947836736553, 3144.8427578621436, 726.6076318787901, 908.7137551671202, 965.0542468380886, 973.1728031173587, 1000.7748256642197, 14248.786268205986, 15580.143092129814, 15698.17432862073, 16480.023083773143, 17402.65194696099, 847.4915050969369, 854.3805740837843, 863.8790569320174, 891.3938521805235, 972.2319367699438, 7748.883766743504, 8210.220029097227, 8523.57382130891, 8729.432586881832, 9182.127697868691, 440070.0, 444760.0, 445693.0, 491759.0, 521441.0, 64644.353556464775, 66505.0, 68071.65964170247, 68819.0, 70407.49498817594, 1162.4943149729725, 1163.825426186062, 1167.0721776187781, 1183.1717797541583, 1184.1059999700171, 14693.485727999896, 14850.628734281729, 15034.924825375803, 15132.01532506338, 15141.470048548248, 31356.686433135375, 31841.840790795897, 32077.0, 32266.0, 33115.668843312225, 41278.38082428826, 41448.3782743253, 42245.577544224165, 43077.1384572313, 43177.56822431736, 7020.473464490286, 7181.748638797617, 7211.531250468703, 7289.635518223961, 7366.889496657447, 8692.608832602422, 10571.735706607396, 10847.0, 11049.502772375423, 11113.888861111609, 8177.754667359989, 8680.348973827115, 8728.912710873064, 8830.381873268809, 9562.426254424758, 7451.515651482637, 8958.417702849294, 9199.356045077047, 9416.10546998034, 9592.568334424828, 8639.179277968582, 8650.78373040679, 8680.565971701515, 8798.252148567188, 8816.426932249384, 7076.858462830817, 7249.746258880914, 7313.341799238094, 7378.188399275968, 7402.0, 8497.57512124379, 9273.3045021625, 9276.0, 9299.395539289924, 9423.952880235554], "unit": "score", "name": "jquery.html", "value": 8725.596288393508}, {"lowerIsBetter": false, "replicates": [1233.4819375862137, 1474.0492382413345, 1491.6121808329835, 1656.3126302584428, 1803.323753592403, 6670.933290667092, 7399.7780066598025, 7598.772036838896, 7648.388128949685, 7658.234176582339, 7384.630768461582, 7510.28652278034, 7533.096028476577, 7572.810679733009, 7586.7344642937505, 1910.4077735901844, 1936.6029963857375, 1956.65758492264, 2268.2061278552496, 2293.4954310051844, 1951.6194342103295, 2253.2451628704403, 2307.826912981525, 2311.7457079721216, 2312.1329501436962, 2210.5689390568846, 2230.096810791632, 2244.539869326792, 2247.898844551991, 2316.247219653611, 2248.865068095903, 2269.0470002598868, 2271.6138256496433, 2271.636538153904, 2273.9880753064976, 2217.5897458970144, 2245.371296037112, 2245.764194759543, 2246.8988895499742, 2248.022110381989, 7687.615619219073, 7717.459777815499, 7734.458587898849, 7738.110117336522, 7793.688252469951, 4743.146233677937, 4897.681650692693, 4898.0, 4902.48523904992, 4903.926441103386, 3029.469842777505, 3112.548680441346, 3127.2650927032128, 3146.480830662938, 3168.1446009577285, 974.9122578967927, 984.3945973226414, 998.201438848918, 1027.6146445083093, 1048.1509976918721, 10671.199660025452, 10680.198985076073, 10689.30519516229, 10691.518881650345, 10698.62554810578, 4287.09970906107, 4287.63555097814, 4325.15659446405, 4338.783060846945, 4364.978175109104, 9206.76983075415, 9224.49265290402, 9234.215091717146, 9236.630534778533, 9244.306676999251, 4798.73606951621, 4802.855914322576, 4803.447603525569, 4804.543568361, 4808.27875818623, 4318.5681431856565, 4369.12617476506, 4369.934450983238, 4370.38814565961, 4377.146456441027, 3334.2497937963763, 3689.3912504437003, 3737.028372623083, 3763.9435408468894, 3781.5273090863643, 1089.5750657243523, 1110.722319420145, 1120.523777394604, 1121.5401685308984, 1178.3283528388736, 1213.696575856036, 1217.5495066825154, 1231.85833629132, 1242.7700875338091, 1242.9067819913544, 7112.822179445555, 7134.357907788324, 7187.9281207188305, 7302.96348518254, 7316.0, 1106.6292791914639, 1113.9610113645983, 1118.9776204475866, 1120.1878637987395, 1145.6563031090639, 5661.858453538612, 5767.538596912237, 5767.769289228468, 5790.536757059425, 5795.159701843293, 8845.955770221237, 8971.461712297283, 9110.0, 9161.175494205554, 9210.217131543759, 9066.0, 9100.499472529074, 9172.954135229415, 9179.0820917909, 9184.770380740534, 6979.511434199659, 7158.2125966143685, 7219.241979592172, 7289.16174639902, 7289.599072051088, 7296.0, 7392.852142957218, 7394.704211831681, 7405.0, 7405.9629701851145, 8098.857052146893, 8421.536815475207, 8485.745427637181, 8495.575221238789, 8611.052784193858, 8221.465604735673, 8456.746297611082, 8602.569871506274, 8609.956950215208, 8640.481571105754, 6745.460363171032, 6933.5146539743755, 6965.895511567432, 6993.0908981832035, 6994.300569942965, 7423.1834498206235, 7477.850442991001, 7483.476156668981, 7489.737859174903, 7491.213422590768, 6182.505399568114, 6597.934020659924, 6939.479539034492, 7180.210176880434, 7192.856142877008, 6861.416779573792, 6935.237123916264, 6955.617441040791, 7082.327178917994, 7120.323569260912, 6930.965345173242, 6976.337247961435, 6987.0, 6995.650217489207, 6996.790096297119, 6315.305316415099, 6448.838779030561, 6458.61248325102, 6502.544821862424, 6503.154589903283, 6475.125858009297, 6578.0790689304495, 6582.275949645631, 6586.40722334973, 6594.868102638016], "unit": "score", "name": "mootools.html", "value": 4469.4340707961455}, {"lowerIsBetter": false, "replicates": [334.4364745403996, 337.6033161035782, 340.5691799873159, 345.04078661321535, 349.8670505208019, 5872.5889187756875, 5946.791862284821, 5949.732262048213, 6017.157597936292, 6040.879182416349, 5770.480656740892, 5915.5859089863725, 5945.613535120214, 5963.34403215647, 5964.88070238595, 4621.12198682251, 4627.722336659811, 4628.675992680513, 4631.976840115794, 4635.675502714811, 4392.428984232045, 4470.374147619336, 4526.298423744309, 4577.0, 4616.676832621718, 4558.293464512989, 4573.199690054244, 4583.175028494869, 4584.426946631671, 4605.861824145281, 4567.65742569307, 4575.17646823575, 4585.174668559658, 4588.17412865684, 4595.172868883599, 4051.736637118578, 4052.4731784868072, 4056.59434056592, 4058.3100872851687, 4058.452108965311, 5563.332400111972, 5598.608097433182, 5622.184783206453, 5627.240322556443, 5647.774089036434, 5331.786728530854, 5336.30628018359, 5341.545968592674, 5342.198670199462, 5351.25082488452, 6029.21620189377, 6285.748570057192, 6286.748530058792, 6287.811365659038, 6295.2445706515055, 4411.955880441186, 4413.962718761089, 4509.481409637868, 4511.052678937427, 4517.2094883395275, 6557.836054098638, 6581.374769396947, 6603.306652801482, 6611.867762644768, 6628.834279143011, 4601.585857272795, 4605.746683932416, 4607.124646317189, 4607.401037865123, 4608.377868987711, 4361.5856493633055, 4491.932621010687, 4496.662750293741, 4649.976750116228, 4659.603933665609, 5216.608754343363, 5219.947800522022, 5221.686698798084, 5223.843284701465, 5225.6603320784025, 6338.080978258219, 6343.809685709436, 6348.174737284216, 6359.491240700733, 6400.551961362753, 1570.387548855947, 1618.3607475047527, 1618.9352425903066, 1619.3198856480305, 1620.3923528676746, 1051.7160366700948, 1071.410724101741, 1078.2560033576806, 1086.8858769829212, 1088.357868857362, 6018.307894592091, 6024.0, 6035.818925432244, 6038.094285857156, 6058.242719660043, 6547.377999090078, 6562.146920900348, 6563.606183628997, 6569.80290591283, 6620.040094186316, 5964.910526342108, 6028.0355143176885, 6036.517078633787, 6040.244969378828, 6044.788432404845, 3498.4927185557954, 3524.559430071241, 3546.4148415511154, 3549.2723991581665, 3555.253396786652, 6802.761903333359, 6807.0810440589885, 6816.965915170393, 6822.215445223863, 6823.55646882951, 6685.331466853276, 6687.7993660189295, 6693.665316734144, 6694.062831203635, 6701.597904125768, 6597.538172327987, 6791.966040169767, 6794.048833163361, 6813.080234168423, 6816.318368163144, 6305.936940630535, 6428.19647544057, 6497.122888410193, 6544.214694236722, 6545.574537655038, 6471.579347342596, 6495.837604059936, 6499.837504062247, 6516.446102081376, 6528.67356632176, 6685.465162786868, 6725.663716814238, 6726.0, 6741.797746067626, 6858.554193977376, 4555.0413322270415, 4597.609203217764, 4651.883702907319, 4652.185867473247, 4668.743219122981, 6536.379043990813, 6540.182477190351, 6544.8363790905605, 6555.836104097436, 6567.573107747981, 6374.0, 6374.713137908712, 6395.264544577247, 6449.4840412765925, 6451.774187903401, 6199.721012554356, 6362.872742545031, 6377.617342959437, 6379.106925030406, 6384.904226436514, 6219.253689557282, 6220.626762394271, 6232.750689972531, 6234.251889773256, 6235.158253635883, 6370.076338930921, 6398.4561312287115, 6404.9039264412, 6409.775657851953, 6419.133416988647, 6099.451049405575, 6247.812565623039, 6254.3745625437095, 6336.303006669171, 6336.619802811846], "unit": "score", "name": "prototype.html", "value": 4795.017604654152}, {"lowerIsBetter": false, "replicates": [704.4153352717244, 793.7063286583962, 801.9799505012373, 802.7872613757359, 836.0218544303162, 12788.936055319722, 12902.354882255873, 12906.483740650387, 12929.418176182071, 12931.935340323309, 11741.941290293558, 11746.295222286668, 11779.941100294487, 11810.940945295282, 12079.516819327217, 672.5325898500544, 680.8365992161895, 799.4683535448919, 813.3168138763438, 813.975580732576, 806.6410447350902, 809.7773112394109, 816.090059583566, 823.3454403749034, 825.8265764189528, 851.812601227732, 853.799357151069, 855.1234984141242, 855.486707975213, 862.5299211929513, 702.0732632924542, 714.4498735973324, 843.9324854011664, 854.1543871567104, 859.7979474823411, 618.2951435363644, 622.9034499652561, 623.1151764494383, 627.491731697322, 631.4632562322035, 12553.246805191626, 12632.0, 12639.0, 12646.74706505874, 12653.240805551697, 12264.754704905941, 12594.0, 12595.622131336075, 12756.170848894884, 13065.150765200231, 9908.35595686278, 9978.07508165919, 10070.79858402835, 10227.130693891027, 10534.78930421395, 3572.589152247499, 3600.9099772505633, 3651.1602331463646, 3720.5907350191455, 3736.8318425670636, 45976.77011614954, 46531.30203046957, 46537.301940470585, 46637.30044049342, 47267.52732472666, 10095.24285678577, 10116.696499105039, 10221.591136354462, 10307.639232626821, 10319.94840025795, 18604.81395186031, 18673.719894201597, 18675.90662046708, 18708.158132883782, 18710.0, 7374.041374621373, 7424.888626670604, 7473.364763995012, 7475.962620186864, 7674.808129796688, 4005.7396269242404, 4011.6590089842107, 4031.2139132869397, 4074.2258970795456, 4156.43888075112, 3000.2499375156212, 3022.818630882154, 3040.9847950760104, 3049.84750762461, 3060.5409188621884, 527.1091854765434, 542.2652306125144, 543.3154225675677, 555.5527800120941, 556.585343918775, 579.6408616929142, 622.5704264057786, 628.4187126907592, 651.4397618048474, 655.9901601475982, 8390.664373425117, 8642.524661143572, 8708.259797917248, 8989.595468203946, 9245.260379169651, 617.0531971629516, 636.8789929913302, 645.4986925663055, 652.1261509577095, 655.9180102487189, 3769.9057523561582, 3921.941170882382, 3976.2643910876004, 4028.2749105160765, 4030.7783071931326, 54776.45223547793, 55795.0, 55831.16253256204, 55922.0, 55936.440635593935, 49147.262791058165, 51254.487455125716, 51454.48545514572, 51472.22791658128, 51798.48201517937, 42655.36016959748, 43096.784516077845, 43300.78349608232, 44178.33732494015, 45803.31295030644, 7835.294823465915, 7864.5281283123195, 7889.763307100796, 7928.246816552649, 7974.561399122872, 33105.0, 33187.83406083051, 33989.49015764716, 34181.829090854386, 34213.486797698555, 40594.0, 43790.0, 44438.0, 44543.10913781771, 44951.775241124895, 9209.907900920905, 9259.0, 9456.19622332082, 9555.140037396668, 9664.081912218327, 10351.585936562453, 10603.257771956198, 10716.410597417216, 10805.729856753644, 11160.720981975192, 9455.0, 9717.611295548382, 9728.805423891341, 9955.253355998184, 10281.53733082028, 10427.0, 10557.894421055691, 10570.78858422812, 10890.976232372486, 10965.013148816644, 8131.471454355448, 10277.331973422002, 10556.894431055898, 10777.784444311226, 10961.50673219723, 8561.0, 8600.22597966186, 8626.870596941177, 8973.192412682889, 9113.3165012623, 9342.579583918876, 9387.953060234655, 9470.57382417779, 9720.951395242979, 9749.562609347664], "unit": "score", "name": "yui.html", "value": 6066.3409266589115}], "name": "dromaeo_css", "value": 6864.848316343091}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 112.0, 111.0, 111.0, 102.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 152.0, 164.0, 124.0, 155.0, 166.0, 125.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0, 163.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 98.0, 92.0, 73.0, 71.0, 71.0, 119.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 143.0, 96.0, 97.0, 97.0, 143.0, 97.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 83.0, 83.0, 83.0, 82.0, 83.0, 84.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [116.0, 127.0, 123.0, 116.0, 115.0, 117.0, 123.0, 124.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [151.0, 141.0, 161.0, 149.0, 153.0, 137.0, 149.0, 149.0, 147.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1504.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [190.00570017100512], "unit": "score", "name": "DeltaBlue", "value": 347.979034}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1123.5955056179776], "unit": "score", "name": "RayTrace", "value": 658.5902099999998}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [43000.0], "unit": "score", "name": "RegExp", "value": 21.185697674418595}, {"lowerIsBetter": false, "replicates": [586.0655737704918], "unit": "score", "name": "Splay", "value": 139.0475804195804}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19979.47971367121}]} 09:25:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19979.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1504.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6864.85"}}} 09:25:22 INFO - Return code: 0 09:25:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:25:22 INFO - # TBPL SUCCESS # 09:25:22 INFO - Running post-action listener: _resource_record_post_action 09:25:22 INFO - Running post-run listener: _resource_record_post_run 09:25:23 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542334976; Read time: 136; Write time: 409688 09:25:23 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 239316992; Read time: 136; Write time: 203852 09:25:23 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 303017984; Read time: 0; Write time: 205836 09:25:23 INFO - Running post-run listener: _upload_blobber_files 09:25:23 INFO - Blob upload gear active. 09:25:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:25:23 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 09:25:23 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:25:23 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:25:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:24 INFO - (blobuploader) - INFO - Done attempting. 09:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:25 INFO - (blobuploader) - INFO - Done attempting. 09:25:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:25 INFO - Return code: 0 09:25:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:25:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05f60bc57b04e6232e0b15029ca9ca13c9eeaf625b14bfb019815dbf491a7c46e2a75389877626dcd1f34f485a1b7f603e4631f6b898a446f23568e6c1ce5ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2423750cb822bf30f9bb57ed1b7adba196c96d443114e832a18b75b53cadb3f8bc61aa219361ae4f4fa2181e1feedffae6ad420f91ed1b8e1f7f45a8fc1a8732"} 09:25:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:25:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:25:25 INFO - Contents: 09:25:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05f60bc57b04e6232e0b15029ca9ca13c9eeaf625b14bfb019815dbf491a7c46e2a75389877626dcd1f34f485a1b7f603e4631f6b898a446f23568e6c1ce5ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2423750cb822bf30f9bb57ed1b7adba196c96d443114e832a18b75b53cadb3f8bc61aa219361ae4f4fa2181e1feedffae6ad420f91ed1b8e1f7f45a8fc1a8732"} 09:25:25 INFO - Copying logs to upload dir... 09:25:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.258736 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-14 09:25:25.394820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 09:25:25.398472) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05f60bc57b04e6232e0b15029ca9ca13c9eeaf625b14bfb019815dbf491a7c46e2a75389877626dcd1f34f485a1b7f603e4631f6b898a446f23568e6c1ce5ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2423750cb822bf30f9bb57ed1b7adba196c96d443114e832a18b75b53cadb3f8bc61aa219361ae4f4fa2181e1feedffae6ad420f91ed1b8e1f7f45a8fc1a8732"} build_url:https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/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/Firefox/sha512/05f60bc57b04e6232e0b15029ca9ca13c9eeaf625b14bfb019815dbf491a7c46e2a75389877626dcd1f34f485a1b7f603e4631f6b898a446f23568e6c1ce5ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2423750cb822bf30f9bb57ed1b7adba196c96d443114e832a18b75b53cadb3f8bc61aa219361ae4f4fa2181e1feedffae6ad420f91ed1b8e1f7f45a8fc1a8732"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 09:25:25.423120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:25:25.423469) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452791007.304512-290051485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:25:25.508868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 09:25:25.509199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 09:25:25.509505) ========= ========= Total master_lag: 0.22 =========