builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1452222411.18 results: success (0) buildid: 20160107163004 builduid: 7ca013e06e03453fb834321594ac0929 revision: b4d9c2dd5f7aa41a59138482956400da38b8b9f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.182777) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.183181) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.183480) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006390 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.207420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.207749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.239662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.240039) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.289431) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.289726) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.290145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.290425) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 19:06:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-07 19:06:51 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.451794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.452124) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.188681 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.652448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:51.652775) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4d9c2dd5f7aa41a59138482956400da38b8b9f1 --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 b4d9c2dd5f7aa41a59138482956400da38b8b9f1 --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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 19:06:51,939 truncating revision to first 12 chars 2016-01-07 19:06:51,939 Setting DEBUG logging. 2016-01-07 19:06:51,939 attempt 1/10 2016-01-07 19:06:51,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4d9c2dd5f7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 19:06:52,186 unpacking tar archive at: mozilla-central-b4d9c2dd5f7a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.224970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.225246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.234505) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.234795) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:06:52.235385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-07 19:06:52.235687) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:06:52 INFO - MultiFileLogger online at 20160107 19:06:52 in /builds/slave/test-pgo 19:06:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:06:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:06:52 INFO - {'append_to_log': False, 19:06:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:06:52 INFO - 'blob_upload_branch': 'Firefox', 19:06:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:06:52 INFO - 'branch': 'Firefox', 19:06:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:52 INFO - 'config_files': ('talos/linux_config.py',), 19:06:52 INFO - 'default_actions': ('clobber', 19:06:52 INFO - 'read-buildbot-config', 19:06:52 INFO - 'download-and-extract', 19:06:52 INFO - 'populate-webroot', 19:06:52 INFO - 'create-virtualenv', 19:06:52 INFO - 'install', 19:06:52 INFO - 'run-tests'), 19:06:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:52 INFO - 'download_minidump_stackwalk': True, 19:06:52 INFO - 'download_symbols': 'ondemand', 19:06:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:52 INFO - 'installer_path': 'installer.exe', 19:06:52 INFO - 'log_level': 'info', 19:06:52 INFO - 'log_name': 'talos', 19:06:52 INFO - 'log_to_console': True, 19:06:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:06:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:06:52 INFO - 'opt_config_files': (), 19:06:52 INFO - 'pip_index': False, 19:06:52 INFO - 'sps_profile': False, 19:06:52 INFO - 'sps_profile_interval': 0, 19:06:52 INFO - 'suite': 'dromaeojs-e10s', 19:06:52 INFO - 'system_bits': '32', 19:06:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:52 INFO - 'title': 'talos-linux64-ix-051', 19:06:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:52 INFO - 'use_talos_json': True, 19:06:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:06:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:52 INFO - 'work_dir': 'build'} 19:06:52 INFO - ##### 19:06:52 INFO - ##### Running clobber step. 19:06:52 INFO - ##### 19:06:52 INFO - Running pre-action listener: _resource_record_pre_action 19:06:52 INFO - Running main action method: clobber 19:06:52 INFO - rmtree: /builds/slave/test-pgo/build 19:06:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:06:56 INFO - Running post-action listener: _resource_record_post_action 19:06:56 INFO - ##### 19:06:56 INFO - ##### Running read-buildbot-config step. 19:06:56 INFO - ##### 19:06:56 INFO - Running pre-action listener: _resource_record_pre_action 19:06:56 INFO - Running main action method: read_buildbot_config 19:06:56 INFO - Using buildbot properties: 19:06:56 INFO - { 19:06:56 INFO - "project": "", 19:06:56 INFO - "product": "firefox", 19:06:56 INFO - "script_repo_revision": "production", 19:06:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:06:56 INFO - "repository": "", 19:06:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:06:56 INFO - "buildid": "20160107163004", 19:06:56 INFO - "pgo_build": "True", 19:06:56 INFO - "basedir": "/builds/slave/test-pgo", 19:06:56 INFO - "buildnumber": 68, 19:06:56 INFO - "slavename": "talos-linux64-ix-051", 19:06:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:06:56 INFO - "platform": "ubuntu64_hw", 19:06:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:06:56 INFO - "branch": "mozilla-central", 19:06:56 INFO - "repo_path": "mozilla-central", 19:06:56 INFO - "revision": "b4d9c2dd5f7aa41a59138482956400da38b8b9f1", 19:06:56 INFO - "stage_platform": "linux64-pgo", 19:06:56 INFO - "builduid": "7ca013e06e03453fb834321594ac0929", 19:06:56 INFO - "slavebuilddir": "test" 19:06:56 INFO - } 19:06:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:06:56 INFO - Running post-action listener: _resource_record_post_action 19:06:56 INFO - ##### 19:06:56 INFO - ##### Running download-and-extract step. 19:06:56 INFO - ##### 19:06:56 INFO - Running pre-action listener: _resource_record_pre_action 19:06:56 INFO - Running main action method: download_and_extract 19:06:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:56 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:06:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json 19:06:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json 19:06:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:06:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:06:58 INFO - Downloaded 1302 bytes. 19:06:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:06:58 INFO - Using the following test package requirements: 19:06:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:06:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'jsshell-linux-x86_64.zip'], 19:06:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:06:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:06:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:06:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:06:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:06:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:58 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:06:59 INFO - Downloaded 24056302 bytes. 19:06:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:06:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:06:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:07:00 INFO - Return code: 0 19:07:00 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 19:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:00 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:01 INFO - Downloaded 24056302 bytes. 19:07:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:07:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:07:02 INFO - Return code: 0 19:07:02 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')]} 19:07:02 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:03 INFO - Downloaded 11132285 bytes. 19:07:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:07:04 INFO - Return code: 0 19:07:04 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')]} 19:07:04 INFO - https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dE4pi44FQ96LnaXyAlrOjg/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 19:07:05 INFO - Downloaded 55915867 bytes. 19:07:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:05 INFO - mkdir: /builds/slave/test-pgo/properties 19:07:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:07:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:07:05 INFO - Contents: 19:07:05 INFO - build_url:https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:05 INFO - Running post-action listener: _resource_record_post_action 19:07:05 INFO - Running post-action listener: set_extra_try_arguments 19:07:05 INFO - ##### 19:07:05 INFO - ##### Running populate-webroot step. 19:07:05 INFO - ##### 19:07:05 INFO - Running pre-action listener: _resource_record_pre_action 19:07:05 INFO - Running main action method: populate_webroot 19:07:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:05 INFO - '--tppagecycles', 19:07:05 INFO - '7'], 19:07:05 INFO - 'tests': ['tsvgm']}}, 19:07:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:07:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:07:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:07:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'tests': ['damp', 'tps']}, 19:07:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['damp', 'tps']}, 19:07:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:07:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:05 INFO - 'other': {'tests': ['a11yr', 19:07:05 INFO - 'ts_paint', 19:07:05 INFO - 'tpaint', 19:07:05 INFO - 'sessionrestore', 19:07:05 INFO - 'sessionrestore_no_auto_restore']}, 19:07:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['a11yr', 19:07:05 INFO - 'ts_paint', 19:07:05 INFO - 'tpaint', 19:07:05 INFO - 'sessionrestore', 19:07:05 INFO - 'sessionrestore_no_auto_restore']}, 19:07:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['a11yr', 19:07:05 INFO - 'ts_paint', 19:07:05 INFO - 'tpaint', 19:07:05 INFO - 'sessionrestore', 19:07:05 INFO - 'sessionrestore_no_auto_restore']}, 19:07:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['a11yr', 19:07:05 INFO - 'ts_paint', 19:07:05 INFO - 'tpaint', 19:07:05 INFO - 'sessionrestore', 19:07:05 INFO - 'sessionrestore_no_auto_restore']}, 19:07:05 INFO - 'other_l64': {'tests': ['a11yr', 19:07:05 INFO - 'ts_paint', 19:07:05 INFO - 'tpaint', 19:07:05 INFO - 'sessionrestore', 19:07:05 INFO - 'sessionrestore_no_auto_restore']}, 19:07:05 INFO - 'other_nol64': {'tests': ['a11yr', 19:07:05 INFO - 'ts_paint', 19:07:05 INFO - 'tpaint', 19:07:05 INFO - 'sessionrestore', 19:07:05 INFO - 'sessionrestore_no_auto_restore']}, 19:07:05 INFO - 'svgr': {'tests': ['tsvgx', 19:07:05 INFO - 'tsvgr_opacity', 19:07:05 INFO - 'tart', 19:07:05 INFO - 'tscrollx', 19:07:05 INFO - 'cart']}, 19:07:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['tsvgx', 19:07:05 INFO - 'tsvgr_opacity', 19:07:05 INFO - 'tart', 19:07:05 INFO - 'tscrollx', 19:07:05 INFO - 'cart']}, 19:07:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'tests': ['tp5o']}, 19:07:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'talos_options': ['--e10s'], 19:07:05 INFO - 'tests': ['tp5o']}, 19:07:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'talos_options': ['--xperf_path', 19:07:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:05 INFO - 'tests': ['tp5n']}, 19:07:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:05 INFO - 'talos_options': ['--e10s', 19:07:05 INFO - '--xperf_path', 19:07:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:05 INFO - 'tests': ['tp5n']}}, 19:07:05 INFO - 'talos.zip': {'path': '', 19:07:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:05 INFO - Running post-action listener: _resource_record_post_action 19:07:05 INFO - ##### 19:07:05 INFO - ##### Running create-virtualenv step. 19:07:05 INFO - ##### 19:07:05 INFO - Running pre-action listener: _resource_record_pre_action 19:07:05 INFO - Running main action method: create_virtualenv 19:07:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:07:05 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 19:07:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:07:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:05 INFO - Using real prefix '/usr' 19:07:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:07:06 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:08 INFO - Installing pip.................done. 19:07:08 INFO - Return code: 0 19:07:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:07: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')]} 19:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:08 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:08 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 19:07:08 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 19:07:08 INFO - Using env: {'DISPLAY': ':0', 19:07:08 INFO - 'HOME': '/home/cltbld', 19:07:08 INFO - 'LANG': 'en_US.UTF-8', 19:07:08 INFO - 'LANGUAGE': 'en_US:en', 19:07:08 INFO - 'LOGNAME': 'cltbld', 19:07:08 INFO - 'MAIL': '/var/mail/cltbld', 19:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:08 INFO - 'MOZ_NO_REMOTE': '1', 19:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:08 INFO - 'NO_EM_RESTART': '1', 19:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:08 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:08 INFO - 'SHELL': '/bin/bash', 19:07:08 INFO - 'SHLVL': '1', 19:07:08 INFO - 'TERM': 'linux', 19:07:08 INFO - 'TMOUT': '86400', 19:07:08 INFO - 'USER': 'cltbld', 19:07:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:08 INFO - '_': '/tools/buildbot/bin/python'} 19:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:08 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 19:07:08 INFO - Cleaning up... 19:07:08 INFO - Return code: 0 19:07:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:07: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')]} 19:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:08 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:08 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 19:07:08 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 19:07:08 INFO - Using env: {'DISPLAY': ':0', 19:07:08 INFO - 'HOME': '/home/cltbld', 19:07:08 INFO - 'LANG': 'en_US.UTF-8', 19:07:08 INFO - 'LANGUAGE': 'en_US:en', 19:07:08 INFO - 'LOGNAME': 'cltbld', 19:07:08 INFO - 'MAIL': '/var/mail/cltbld', 19:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:08 INFO - 'MOZ_NO_REMOTE': '1', 19:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:08 INFO - 'NO_EM_RESTART': '1', 19:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:08 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:08 INFO - 'SHELL': '/bin/bash', 19:07:08 INFO - 'SHLVL': '1', 19:07:08 INFO - 'TERM': 'linux', 19:07:08 INFO - 'TMOUT': '86400', 19:07:08 INFO - 'USER': 'cltbld', 19:07:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:08 INFO - '_': '/tools/buildbot/bin/python'} 19:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:08 INFO - Downloading/unpacking psutil>=0.7.1 19:07:08 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 19:07:08 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 19:07:08 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 19:07:08 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 19:07:08 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 19:07:08 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 19:07:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:07:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:07:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:10 INFO - Installing collected packages: psutil 19:07:10 INFO - Running setup.py install for psutil 19:07:10 INFO - building 'psutil._psutil_linux' extension 19:07:10 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 19:07:10 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 19:07:10 INFO - building 'psutil._psutil_posix' extension 19:07:10 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 19:07:10 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 19:07:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:10 INFO - Successfully installed psutil 19:07:10 INFO - Cleaning up... 19:07:11 INFO - Return code: 0 19:07:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:07:11 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')]} 19:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 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')]} 19:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:11 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 19:07:11 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 19:07:11 INFO - Using env: {'DISPLAY': ':0', 19:07:11 INFO - 'HOME': '/home/cltbld', 19:07:11 INFO - 'LANG': 'en_US.UTF-8', 19:07:11 INFO - 'LANGUAGE': 'en_US:en', 19:07:11 INFO - 'LOGNAME': 'cltbld', 19:07:11 INFO - 'MAIL': '/var/mail/cltbld', 19:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:11 INFO - 'MOZ_NO_REMOTE': '1', 19:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:11 INFO - 'NO_EM_RESTART': '1', 19:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:11 INFO - 'SHELL': '/bin/bash', 19:07:11 INFO - 'SHLVL': '1', 19:07:11 INFO - 'TERM': 'linux', 19:07:11 INFO - 'TMOUT': '86400', 19:07:11 INFO - 'USER': 'cltbld', 19:07:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:11 INFO - '_': '/tools/buildbot/bin/python'} 19:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:07:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:07:13 INFO - Installing collected packages: mozsystemmonitor 19:07:13 INFO - Running setup.py install for mozsystemmonitor 19:07:13 INFO - Successfully installed mozsystemmonitor 19:07:13 INFO - Cleaning up... 19:07:13 INFO - Return code: 0 19:07:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:07:13 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')]} 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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')]} 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:13 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 19:07:13 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 19:07:13 INFO - Using env: {'DISPLAY': ':0', 19:07:13 INFO - 'HOME': '/home/cltbld', 19:07:13 INFO - 'LANG': 'en_US.UTF-8', 19:07:13 INFO - 'LANGUAGE': 'en_US:en', 19:07:13 INFO - 'LOGNAME': 'cltbld', 19:07:13 INFO - 'MAIL': '/var/mail/cltbld', 19:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:13 INFO - 'MOZ_NO_REMOTE': '1', 19:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:13 INFO - 'NO_EM_RESTART': '1', 19:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:13 INFO - 'SHELL': '/bin/bash', 19:07:13 INFO - 'SHLVL': '1', 19:07:13 INFO - 'TERM': 'linux', 19:07:13 INFO - 'TMOUT': '86400', 19:07:13 INFO - 'USER': 'cltbld', 19:07:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:13 INFO - '_': '/tools/buildbot/bin/python'} 19:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:07:13 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 19:07:13 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 19:07:13 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 19:07:13 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 19:07:13 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 19:07:13 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 19:07:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:07:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:16 INFO - Downloading docopt-0.6.1.tar.gz 19:07:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:07:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:16 INFO - Running setup.py install for blobuploader 19:07:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:07:16 INFO - Running setup.py install for requests 19:07:16 INFO - Running setup.py install for docopt 19:07:16 INFO - Successfully installed blobuploader requests docopt 19:07:16 INFO - Cleaning up... 19:07:16 INFO - Return code: 0 19:07:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:07: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')]} 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:16 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:16 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 19:07:16 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 19:07:16 INFO - Using env: {'DISPLAY': ':0', 19:07:16 INFO - 'HOME': '/home/cltbld', 19:07:16 INFO - 'LANG': 'en_US.UTF-8', 19:07:16 INFO - 'LANGUAGE': 'en_US:en', 19:07:16 INFO - 'LOGNAME': 'cltbld', 19:07:16 INFO - 'MAIL': '/var/mail/cltbld', 19:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:16 INFO - 'MOZ_NO_REMOTE': '1', 19:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:16 INFO - 'NO_EM_RESTART': '1', 19:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:16 INFO - 'SHELL': '/bin/bash', 19:07:16 INFO - 'SHLVL': '1', 19:07:16 INFO - 'TERM': 'linux', 19:07:16 INFO - 'TMOUT': '86400', 19:07:16 INFO - 'USER': 'cltbld', 19:07:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:16 INFO - '_': '/tools/buildbot/bin/python'} 19:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:17 INFO - Running setup.py (path:/tmp/pip-4vPKCJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:17 INFO - Running setup.py (path:/tmp/pip-vyBKoK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:17 INFO - Running setup.py (path:/tmp/pip-6SFqA5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:17 INFO - Running setup.py (path:/tmp/pip-8lMTDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:17 INFO - Running setup.py (path:/tmp/pip-G_7i2_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:17 INFO - Running setup.py (path:/tmp/pip-wZz9tq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:17 INFO - Running setup.py (path:/tmp/pip-sO1Uae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:17 INFO - Running setup.py (path:/tmp/pip-1IYkGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:17 INFO - Running setup.py (path:/tmp/pip-0G09mj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:17 INFO - Running setup.py (path:/tmp/pip-mPIZG5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:17 INFO - Running setup.py (path:/tmp/pip-9X3B6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:17 INFO - Running setup.py (path:/tmp/pip-C3J_KE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:17 INFO - Running setup.py (path:/tmp/pip-0EzR69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:18 INFO - Running setup.py (path:/tmp/pip-mhqSB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:18 INFO - Running setup.py (path:/tmp/pip-zZlFd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:18 INFO - Running setup.py (path:/tmp/pip-E1HfKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:18 INFO - Running setup.py (path:/tmp/pip-DVcVyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:18 INFO - Running setup.py install for manifestparser 19:07:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:07:18 INFO - Running setup.py install for mozcrash 19:07:18 INFO - Running setup.py install for mozdebug 19:07:18 INFO - Running setup.py install for mozdevice 19:07:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:07:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:07:18 INFO - Running setup.py install for mozfile 19:07:18 INFO - Running setup.py install for mozhttpd 19:07:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:07:18 INFO - Running setup.py install for mozinfo 19:07:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Running setup.py install for mozInstall 19:07:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Running setup.py install for mozleak 19:07:19 INFO - Running setup.py install for mozlog 19:07:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Running setup.py install for moznetwork 19:07:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Running setup.py install for mozprocess 19:07:19 INFO - Running setup.py install for mozprofile 19:07:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Running setup.py install for mozrunner 19:07:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:07:19 INFO - Running setup.py install for mozscreenshot 19:07:19 INFO - Running setup.py install for moztest 19:07:19 INFO - Running setup.py install for mozversion 19:07:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:07:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:20 INFO - Cleaning up... 19:07:20 INFO - Return code: 0 19:07:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:07: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')]} 19:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:20 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:20 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 19:07:20 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 19:07:20 INFO - Using env: {'DISPLAY': ':0', 19:07:20 INFO - 'HOME': '/home/cltbld', 19:07:20 INFO - 'LANG': 'en_US.UTF-8', 19:07:20 INFO - 'LANGUAGE': 'en_US:en', 19:07:20 INFO - 'LOGNAME': 'cltbld', 19:07:20 INFO - 'MAIL': '/var/mail/cltbld', 19:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:20 INFO - 'MOZ_NO_REMOTE': '1', 19:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:20 INFO - 'NO_EM_RESTART': '1', 19:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:20 INFO - 'SHELL': '/bin/bash', 19:07:20 INFO - 'SHLVL': '1', 19:07:20 INFO - 'TERM': 'linux', 19:07:20 INFO - 'TMOUT': '86400', 19:07:20 INFO - 'USER': 'cltbld', 19:07:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:20 INFO - '_': '/tools/buildbot/bin/python'} 19:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:20 INFO - Running setup.py (path:/tmp/pip-skdEZm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:20 INFO - Running setup.py (path:/tmp/pip-tN8mPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:20 INFO - Running setup.py (path:/tmp/pip-mBDGP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:20 INFO - Running setup.py (path:/tmp/pip-Q9a6XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:20 INFO - Running setup.py (path:/tmp/pip-W267Su-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:20 INFO - Running setup.py (path:/tmp/pip-92iF0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:20 INFO - Running setup.py (path:/tmp/pip-cCRaPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:20 INFO - Running setup.py (path:/tmp/pip-PAbKqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:20 INFO - Running setup.py (path:/tmp/pip-y9762O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:07:20 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)) 19:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:20 INFO - Running setup.py (path:/tmp/pip-uK330y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:21 INFO - Running setup.py (path:/tmp/pip-Q2HjT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:21 INFO - Running setup.py (path:/tmp/pip-NiTzje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:21 INFO - Running setup.py (path:/tmp/pip-hHLHdQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:21 INFO - Running setup.py (path:/tmp/pip-TpFAlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:21 INFO - Running setup.py (path:/tmp/pip-ry6nKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:21 INFO - Running setup.py (path:/tmp/pip-cq_UO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:07:21 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)) 19:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:21 INFO - Running setup.py (path:/tmp/pip-EYlWPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:07:21 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)) 19:07:21 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)) 19:07:21 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)) 19:07:21 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)) 19:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:07:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:23 INFO - Downloading blessings-1.5.1.tar.gz 19:07:23 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 19:07:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:23 INFO - Installing collected packages: blessings 19:07:23 INFO - Running setup.py install for blessings 19:07:23 INFO - Successfully installed blessings 19:07:23 INFO - Cleaning up... 19:07:23 INFO - Return code: 0 19:07:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:07:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:07:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:07:23 INFO - Reading from file tmpfile_stdout 19:07:23 INFO - Current package versions: 19:07:23 INFO - argparse == 1.2.1 19:07:23 INFO - blessings == 1.5.1 19:07:23 INFO - blobuploader == 1.2.4 19:07:23 INFO - docopt == 0.6.1 19:07:23 INFO - manifestparser == 1.1 19:07:23 INFO - mozInstall == 1.12 19:07:23 INFO - mozcrash == 0.16 19:07:23 INFO - mozdebug == 0.1 19:07:23 INFO - mozdevice == 0.47 19:07:23 INFO - mozfile == 1.2 19:07:23 INFO - mozhttpd == 0.7 19:07:23 INFO - mozinfo == 0.9 19:07:23 INFO - mozleak == 0.1 19:07:23 INFO - mozlog == 3.1 19:07:23 INFO - moznetwork == 0.27 19:07:23 INFO - mozprocess == 0.22 19:07:23 INFO - mozprofile == 0.28 19:07:23 INFO - mozrunner == 6.11 19:07:23 INFO - mozscreenshot == 0.1 19:07:23 INFO - mozsystemmonitor == 0.0 19:07:23 INFO - moztest == 0.7 19:07:23 INFO - mozversion == 1.4 19:07:23 INFO - psutil == 3.1.1 19:07:23 INFO - requests == 1.2.3 19:07:23 INFO - wsgiref == 0.1.2 19:07:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:07:23 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')]} 19:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:23 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')]} 19:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:23 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:23 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 19:07:23 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 19:07:23 INFO - Using env: {'DISPLAY': ':0', 19:07:23 INFO - 'HOME': '/home/cltbld', 19:07:23 INFO - 'LANG': 'en_US.UTF-8', 19:07:23 INFO - 'LANGUAGE': 'en_US:en', 19:07:23 INFO - 'LOGNAME': 'cltbld', 19:07:23 INFO - 'MAIL': '/var/mail/cltbld', 19:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:23 INFO - 'MOZ_NO_REMOTE': '1', 19:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:23 INFO - 'NO_EM_RESTART': '1', 19:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:23 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:23 INFO - 'SHELL': '/bin/bash', 19:07:23 INFO - 'SHLVL': '1', 19:07:23 INFO - 'TERM': 'linux', 19:07:23 INFO - 'TMOUT': '86400', 19:07:23 INFO - 'USER': 'cltbld', 19:07:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:23 INFO - '_': '/tools/buildbot/bin/python'} 19:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 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)) 19:07:23 INFO - Cleaning up... 19:07:23 INFO - Return code: 0 19:07:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:07:23 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')]} 19:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:23 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')]} 19:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:23 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:23 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 19:07:23 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 19:07:23 INFO - Using env: {'DISPLAY': ':0', 19:07:23 INFO - 'HOME': '/home/cltbld', 19:07:23 INFO - 'LANG': 'en_US.UTF-8', 19:07:23 INFO - 'LANGUAGE': 'en_US:en', 19:07:23 INFO - 'LOGNAME': 'cltbld', 19:07:23 INFO - 'MAIL': '/var/mail/cltbld', 19:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:23 INFO - 'MOZ_NO_REMOTE': '1', 19:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:23 INFO - 'NO_EM_RESTART': '1', 19:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:23 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:23 INFO - 'SHELL': '/bin/bash', 19:07:23 INFO - 'SHLVL': '1', 19:07:23 INFO - 'TERM': 'linux', 19:07:23 INFO - 'TMOUT': '86400', 19:07:23 INFO - 'USER': 'cltbld', 19:07:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:23 INFO - '_': '/tools/buildbot/bin/python'} 19:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:24 INFO - Downloading/unpacking jsonschema 19:07:24 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 19:07:24 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 19:07:24 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 19:07:24 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 19:07:24 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 19:07:24 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 19:07:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:25 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 19:07:25 INFO - Downloading/unpacking functools32 (from jsonschema) 19:07:25 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 19:07:25 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 19:07:25 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 19:07:25 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 19:07:25 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 19:07:25 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 19:07:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:07:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:26 INFO - warning: no files found matching '*.txt' 19:07:26 INFO - no previously-included directories found matching 'build' 19:07:26 INFO - no previously-included directories found matching 'dist' 19:07:26 INFO - no previously-included directories found matching '.git*' 19:07:26 INFO - Installing collected packages: jsonschema, functools32 19:07:26 INFO - Running setup.py install for functools32 19:07:26 INFO - warning: no files found matching '*.txt' 19:07:26 INFO - no previously-included directories found matching 'build' 19:07:26 INFO - no previously-included directories found matching 'dist' 19:07:26 INFO - no previously-included directories found matching '.git*' 19:07:26 INFO - Successfully installed jsonschema functools32 19:07:26 INFO - Cleaning up... 19:07:26 INFO - Return code: 0 19:07:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:07: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')]} 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:26 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 0x7fd4cd59df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', '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 19:07:26 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 19:07:26 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 19:07:26 INFO - Using env: {'DISPLAY': ':0', 19:07:26 INFO - 'HOME': '/home/cltbld', 19:07:26 INFO - 'LANG': 'en_US.UTF-8', 19:07:26 INFO - 'LANGUAGE': 'en_US:en', 19:07:26 INFO - 'LOGNAME': 'cltbld', 19:07:26 INFO - 'MAIL': '/var/mail/cltbld', 19:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:26 INFO - 'MOZ_NO_REMOTE': '1', 19:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:26 INFO - 'NO_EM_RESTART': '1', 19:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:26 INFO - 'SHELL': '/bin/bash', 19:07:26 INFO - 'SHLVL': '1', 19:07:26 INFO - 'TERM': 'linux', 19:07:26 INFO - 'TMOUT': '86400', 19:07:26 INFO - 'USER': 'cltbld', 19:07:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:26 INFO - '_': '/tools/buildbot/bin/python'} 19:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:26 INFO - Downloading/unpacking flake8 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:07:28 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 19:07:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:07:28 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 19:07:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 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 19:07:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:07:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:28 INFO - no previously-included directories found matching 'docs/_build' 19:07:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:07:29 INFO - Running setup.py install for pep8 19:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:29 INFO - no previously-included directories found matching 'docs/_build' 19:07:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:07:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:07:29 INFO - Cleaning up... 19:07:29 INFO - Return code: 0 19:07:29 INFO - Running post-action listener: _resource_record_post_action 19:07:29 INFO - Running post-action listener: _start_resource_monitoring 19:07:29 INFO - Starting resource monitoring. 19:07:29 INFO - ##### 19:07:29 INFO - ##### Running install step. 19:07:29 INFO - ##### 19:07:29 INFO - Running pre-action listener: _resource_record_pre_action 19:07:29 INFO - Running main action method: install 19:07:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:07:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:07:29 INFO - Reading from file tmpfile_stdout 19:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:07:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:07:29 INFO - Reading from file tmpfile_stdout 19:07:29 INFO - Output received: 19:07:29 INFO - Usage: mozinstall [options] installer 19:07:29 INFO - Options: 19:07:29 INFO - -h, --help show this help message and exit 19:07:29 INFO - -d DEST, --destination=DEST 19:07:29 INFO - Directory to install application into. [default: 19:07:29 INFO - "/builds/slave/test-pgo"] 19:07:29 INFO - --app=APP Application being installed. [default: firefox] 19:07:29 INFO - mkdir: /builds/slave/test-pgo/build/application 19:07:29 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'] 19:07:29 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 19:07:45 INFO - Reading from file tmpfile_stdout 19:07:45 INFO - Output received: 19:07:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:07:45 INFO - Running post-action listener: _resource_record_post_action 19:07:45 INFO - ##### 19:07:45 INFO - ##### Running run-tests step. 19:07:45 INFO - ##### 19:07:45 INFO - Running pre-action listener: _resource_record_pre_action 19:07:45 INFO - Running main action method: run_tests 19:07:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:07:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:07:45 INFO - Python 2.7.3 19:07:45 INFO - Return code: 0 19:07:45 INFO - grabbing minidump binary from tooltool 19:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:45 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 0x21e8660>, '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 0x21e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:07:45 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 19:07:45 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 19:07:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:07:45 INFO - Return code: 0 19:07:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:07:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:07:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:07:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:07:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:07:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:07:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:07:46 INFO - Return code: 0 19:07:46 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:07:46 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:07:46 INFO - Using env: {'DISPLAY': ':0', 19:07:46 INFO - 'HOME': '/home/cltbld', 19:07:46 INFO - 'LANG': 'en_US.UTF-8', 19:07:46 INFO - 'LANGUAGE': 'en_US:en', 19:07:46 INFO - 'LOGNAME': 'cltbld', 19:07:46 INFO - 'MAIL': '/var/mail/cltbld', 19:07:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:07:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:46 INFO - 'MOZ_NO_REMOTE': '1', 19:07:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:46 INFO - 'NO_EM_RESTART': '1', 19:07:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:07:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:07:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:07:46 INFO - 'SHELL': '/bin/bash', 19:07:46 INFO - 'SHLVL': '1', 19:07:46 INFO - 'TERM': 'linux', 19:07:46 INFO - 'TMOUT': '86400', 19:07:46 INFO - 'USER': 'cltbld', 19:07:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821', 19:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:46 INFO - '_': '/tools/buildbot/bin/python'} 19:07:46 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:07:46 INFO - mozversion application_buildid: 20160107163004 19:07:46 INFO - mozversion application_changeset: b4d9c2dd5f7aa41a59138482956400da38b8b9f1 19:07:46 INFO - mozversion application_display_name: Nightly 19:07:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:07:46 INFO - mozversion application_name: Firefox 19:07:46 INFO - mozversion application_remotingname: firefox 19:07:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:07:46 INFO - mozversion application_vendor: Mozilla 19:07:46 INFO - mozversion application_version: 46.0a1 19:07:46 INFO - mozversion platform_buildid: 20160107163004 19:07:46 INFO - mozversion platform_changeset: b4d9c2dd5f7aa41a59138482956400da38b8b9f1 19:07:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:07:46 INFO - mozversion platform_version: 46.0a1 19:07:46 INFO - using testdate: 1452222466 19:07:46 INFO - actual date: 1452222466 19:07:46 INFO - starting webserver on 'localhost:39903' 19:07:46 INFO - SUITE-START | Running 3 tests 19:07:46 INFO - TEST-START | dromaeo_css 19:07:46 INFO - operating with platform_type : linux_ 19:07:46 INFO - Initialising browser for dromaeo_css test... 19:07:46 INFO - TEST-INFO | started process 7538 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOLQ0N5/profile http://localhost:39903/getInfo.html) 19:07:50 INFO - PROCESS | 7538 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 19:07:51 INFO - PROCESS | 7538 | __metrics Screen width/height:1600/1200 19:07:51 INFO - PROCESS | 7538 | colorDepth:24 19:07:51 INFO - PROCESS | 7538 | Browser inner width/height: 1024/697 19:07:51 INFO - PROCESS | 7538 | __metrics 19:07:51 INFO - PROCESS | 7538 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:52 INFO - TEST-INFO | 7538: exit 0 19:07:52 INFO - Browser initialized. 19:07:52 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:52 INFO - TEST-INFO | started process 7672 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOLQ0N5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:04 INFO - PROCESS | 7672 | RSS: Main: 150540288 19:08:04 INFO - PROCESS | 7672 | 19:08:53 INFO - PROCESS | 7672 | 1452222533975 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] 19:11:03 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:39903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39903/tests/dromaeo/cssquery-ext.html) 19:11:04 INFO - PROCESS | 7672 | RSS: Main: 155889664 19:11:04 INFO - PROCESS | 7672 | 19:14:06 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:39903/tests/dromaeo/cssquery-ext.html (next: http://localhost:39903/tests/dromaeo/cssquery-jquery.html) 19:14:07 INFO - PROCESS | 7672 | RSS: Main: 155885568 19:14:07 INFO - PROCESS | 7672 | 19:17:08 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:39903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39903/tests/dromaeo/cssquery-mootools.html) 19:17:09 INFO - PROCESS | 7672 | RSS: Main: 153538560 19:17:09 INFO - PROCESS | 7672 | 19:20:11 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:39903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39903/tests/dromaeo/cssquery-prototype.html) 19:20:11 INFO - PROCESS | 7672 | RSS: Main: 151343104 19:20:11 INFO - PROCESS | 7672 | 19:23:14 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:39903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39903/tests/dromaeo/cssquery-yui.html) 19:23:14 INFO - PROCESS | 7672 | RSS: Main: 153292800 19:23:14 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:39903/tests/dromaeo/cssquery-yui.html (next: http://localhost:39903/tests/dromaeo/cssquery-dojo.html) 19:26:17 INFO - PROCESS | 7672 | RSS: Main: 155660288 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | __start_tp_report 19:26:17 INFO - PROCESS | 7672 | _x_x_mozilla_page_load 19:26:17 INFO - PROCESS | 7672 | _x_x_mozilla_page_load_details 19:26:17 INFO - PROCESS | 7672 | |i|pagename|runs| 19:26:17 INFO - PROCESS | 7672 | |0;dojo.html;3207.118042538302;3248.626407963082;3274.4269752793257;3288.013595921223;3299.6865297796703;5289;5350.5184533391985;5367.731613419333;5377.354717433908;5382.38102618199;5264.710440925747;5268.631195816294;5350.8127215547465;5351.224072509483;5427.864303392417;4815.133276010317;4878.268259761029;4930.309756634074;4956.2070068789;4966.777160975451;4870.831000559876;4916.434610019858;4931.284963680264;4970.130227210242;4978.352814134176;4757;4838.975805120987;4843.878903027435;4870.07468580972;4873.43955445123;4842.225243960949;4921.8523444296725;4930.112579735646;4953.950460495421;4958.9752051239875;4827.444843842968;4887.755612219375;4887.804487820483;4917.60659147271;4918.729469879156;5133.30700355451;5185.403678576937;5190.455002224788;5216.374035115772;5237.921431178535;5757.68332741699;5763.164341170549;5768.826935191951;5787.565932555033;5799.2750906136735;5753.856153596152;5761.078227483583;5765.711714414262;5767.884642307173;5774.913376299359;5217.739113044333;5322.121849894724;5331.360236771573;5364.034473794676;5404.648697834628;5963.4931030862;5966.492848107872;5980.132880732356;6003.369646187175;6003.8198854034445;5721.5136713379825;5726.4273572642405;5733.569982251348;5734.569907256972;5739.110437882135;5673.886522269531;5719.256496655491;5751.626144300607;5818.679972601548;5855.238818953509;5679.602427830012;5701.486866181981;5713.714314284269;5713.971430142906;5720.599558030981;5688.914666280009;5703.771849126071;5704.743286552115;5713.857153571111;5721.8569535761935;4372.650187984954;4430.113977204572;4473.530279320625;4478.081993191388;4484.439445069366;4007.338789099824;4012.598740125964;4013.6387725104883;4021.859234926822;4055.858044968412;5409.675419474844;5421.430749771296;5436.184572314184;5454.10007348783;5500.037493438632;5678.829635110871;5733.971330143406;5784.132380143013;5803.274590676166;5873.911891321633;5364.088105022156;5366.651167674088;5367.9800837840685;5382.327209098863;5384.703841288767;4875.658703890694;4919.385076865392;4933.186024305949;4949.307097006422;4975.975120124376;5834;5864.70676466175;5941.316748573883;6017.187679663364;6029.60807547508;5688.516476099578;5692.544596432358;5696.857578560569;5697.743601537858;5703.058995265735;5893.764249429974;5899.498542623754;5909;5913.852153696192;5918.73365698536;5554.222408862682;5628.634138780966;5644.689542075225;5708.457696518824;5740.626859254302;5808;5839.532837372915;5856.502197313276;5857.1799948008165;5865.501432378295;5496.31296087989;5672.064109421899;5680.71596420169;5692.203091567101;5719.656820590778;5478.91781623268;5548.55611551083;5610.7755689773585;5630.4369563043365;5653.689047102449;5452.154915988028;5492.286002819608;5503.889922201453;5521.116621340566;5526.281583394133;5569.164625306236;5609.467100625434;5616.747246374005;5621.409751975983;5713.085906254979;5474.972625136849;5476.288082549243;5533.170024496197;5567.192757050124;5597.048501754793 19:26:17 INFO - PROCESS | 7672 | |1;ext.html;476.264171854485;510.74462768615695;520.7240162713762;524.0723918663967;542.4439949052221;35146.12134696634;36338.27323453529;36360.45459318112;36393.454098188515;36436.45345319819;39224.60775392245;39516.407253891215;39730.205395892066;39838.20323593527;39884.80057599708;8433.072362040155;8611.48331100136;8629;8652.22130008299;8653.48079115252;8261.173882611722;8349.081601023883;8393.328533717287;8410.453320534176;8472.19514146155;8662.913370866274;8722.563871806384;8771.56142192891;8788;8789.604467798932;8541.231289183972;8600.8709869352;8602.053774084878;8621.094785047542;8646.43798153118;8545.743627691118;8616.138386161396;8665.653373865038;8671.523066231355;8719.302455803521;38023.23953520942;38654.226915461535;38674.41988370177;38677.419838702444;38677.80661096705;3048.7103725146076;3049.481588130001;3123.3597112591865;3148.8740450381956;3553.5913369962527;28211;28574.85712571424;28791.280217994507;29051;29136.41727165445;3681.2821499807283;3730.8880733578035;3787.772733635991;3871.728978971473;3998.980005099985;183158;183962;184121;184371.99999999866;185452;49287.260691089665;51122.48877511251;55128.72435637796;55400.445995540336;55402.44597554053;61992.380076198664;62670;62992;63012;63076.36923630705;14350.856491434952;14599.124052556881;14694.853051469563;14696;14739.705205895822;11081.944590277159;11134.27627204229;11143.275687080313;11151.386673733023;11168.888311116947;18616;18689.158987845578;18893.90553047226;18982.905085474486;19686.507837304183;7497.700091996259;7732.536047837148;7740.690372385042;7815.413843961612;7882.921170788219;959.4195511715312;984.7291994701515;985.6254623243121;1041.2919214933918;1075.499892549968;27659.86170069177;27808.86095569509;27814.443711125663;28066.438671226868;28094.43811123766;1016;1022.805666923297;1124.971875703114;1126.4761885723178;1174.9588764393204;14244.743784475162;14469.602745268525;14595.635109122144;14630.561083167522;14649.34077966494;314248;321196;322578;323266;326178;49410;49576.256356154685;49813.750931245115;49881.25178122331;49924.50075499271;1307.627326212044;1307.8888294494884;1323.543377534749;1324.3576865220361;1326.2970625568464;26389.340266492723;27460.58809117905;27794.722052779212;27813;28037.299067523476;43473.78263108791;43695.781521093464;43841.78079109712;43952.12095758003;44106.33840492331;289024;292957;293930;294195;294417;30480.085597432113;30926.690733092382;30943.845280773454;31179.532307015867;31192.37615247637;35725;35838.283234335686;36666.63333366632;36891;36908.077298067765;33316.83341583276;34728.479072813425;35751.82124089363;35853.462198066525;35968.28063438769;33389.49915751217;34452;36675.26649467049;38139.61860381361;38936.2212755749;31757.20606984844;31895.521567176977;31962.52056219112;32014;34812.82593587117;27584.724152758215;27783.166505004883;29364;29452.558211626416;29713.851430742707;23886;24276.1503347382;24860;25058.248252552454;25508.872455637604 19:26:17 INFO - PROCESS | 7672 | |2;jquery.html;357.9946300805487;360.3693536311455;360.4521127885614;361.39827187732425;364.37509670914375;16262.837371626296;16756.916215418936;17240.31038758451;17758.112094395277;18108.456746297597;12573.748525029494;13070.346482675852;13142.934285328583;13635.522756703518;16032.198390080479;4979.626528010395;5122.487751224885;5131.307273518083;5132.332796736419;5162.457941916101;5111.233315002761;5143.022825663131;5177.948220517803;5181.145111056671;5191.662541934781;4535.569120933506;5180.948190518085;5379.838604841861;5577.470140336662;5640.689762063085;5275;5280.9207861882105;5282.286891269668;5318.521333080022;5329.493698098674;4868.537488938545;5003.124453220708;5007.12375334315;5036.420811606676;5045;12944.611661650166;12965;13070.085094043421;13130.277834719087;13167.14413563125;1885.4155211884222;1972.7139564763172;2017.5863947890648;2022.0799536211136;2169.5227050048966;9691.418514889128;9697.951510242403;9884.851727224097;9967.302288839785;9994.900050999542;1750.772399588058;1759.683257013737;1787.061792558904;1834.1471215884678;1854.46220596027;57986.71006644982;59090.40909590892;60012.699936500474;62452.68773656148;63388.99999999954;10062.044105809937;10216.131628811485;10293.588256469657;10336.431496267627;10420.947895260475;13430.664233394047;13439;13469.663258418617;13480.325983700972;13487.504811609884;7440.925590744131;7472.215417381097;7486.13909400415;7514.586697731568;7538.736144234926;7155.177154627285;7174.067371241706;7185.281471852877;7193.172785129673;7218.819529511804;4410.580994805488;4449.2658711312915;4479.3057076153245;4481.5070342262325;4486.416765820488;1758.9384371546935;1795.4613615915173;1823.1795691938416;1827.1960337451478;1836.5959488912417;807.6117907352927;909.663424532927;936.9344145909857;957.4781743949425;987.3631507677508;14077.296135193199;16015.712181404127;16481.91759041221;16960.660786784196;17132.571685707957;886.7251152142857;887.8978917424579;898.0525545549377;899.8425275576748;925.9953700231456;9366.391184572982;9651.758706032266;9671.419714816993;9695.466749328714;9737.318387712792;555784;558956;567080;569404;580844;69746.302536975;71797.64101179565;71928;81533.59233203914;81732;1131.0216662586638;1131.3664347965166;1183.0299154693068;1191.4936152135308;1210.7881120803825;15908.602284942968;16010.119443430724;16200.756988645415;16260.51218463448;16526.421575244807;20154.798452015293;23957.76042239625;29118.27204319909;35019.29961400809;36097.63902361048;47329.76335118302;48715.269270961675;48988.755056224494;49239.50760492349;50326.74836625793;9397.718068457958;9487.762805929908;9600.951995239979;9633.470159141314;9636.42181469114;11282.7743445129;17006.829931700526;17211.91394043022;17506.824931750518;17692.11539422998;13671.521496747566;13826.101303415246;14268.215248161036;14509.85490145085;14723.852761472677;13627;14556.27218639085;14701.852981470049;14888.478903238334;14990;14300.570982870115;14409.63975900569;15007.924960375129;15050.774238386652;15728.13495257726;9724.222062235145;9794.608215671293;9956.651517197153;9981.951895051205;10005.599776008878;13696.65758356049;14136.434542618592;14628.268586570415;14692.779608306098;15019.699606008036 19:26:17 INFO - PROCESS | 7672 | |3;mootools.html;1461.9853801461986;1465.1428914085263;1624.5370069530186;1760.568660678134;1790.1317860837491;7538.133114691812;7603.429742769294;7656.54060756355;7752.069751629805;7759.456838021334;7634.961825190866;7684.308412242897;7716.151223365426;7722.227777222275;7802.882956755653;2269.1490690990836;2301.6892719482908;2324.081987614891;2326.360250930991;2334.6264597664376;2329;2345.1909091363455;2378.4053986503372;2378.4767351182713;2382.404398900275;2256.277991042867;2304.51605162916;2311.826613004023;2328.8020518255967;2348.5537747827943;2256.909723611054;2280.2247235939776;2307.896144673494;2315.490592069742;2317.606006978809;2305.043406986099;2348.894299756515;2350.083467447697;2350.5886469867705;2351.400392899817;7528.736494222676;7613.124490683587;7669.309762121436;7675.424343174284;7696.538207707499;4715.41057367829;4753.144434001878;4778.354922085508;4792.448868380146;4796.2326027835725;2889.277680579855;2902.6226590543306;2968.2876109733506;2974.672785993539;2979.016924414938;899.2626046641757;899.4063917814277;920.3235621817959;923.6028507741669;929.0848514213494;10528.263021588491;10540.894591054068;10554.47227638615;10604.310719803188;10652.840207396895;4207.158568286355;4250.574942505787;4290.249206388869;4302.397664326997;4304.096139810612;8646.827063458695;8679.826403472021;8685.478871267744;8688.956555217184;8694.26098781598;4702.788374523155;4709.764511774398;4714.222153344728;4716.716996980193;4725.36207611968;4297.205017071852;4313.439252897166;4315.697901146952;4329.15581461612;4342.196693611692;3323.2356557991316;3338.9983005098375;3346.598408191033;3347.297067615828;3348.8325583720716;1018.4296793795498;1029.351508549624;1032.318669678009;1034.0745033195249;1060.6977011551826;1013.9391636501833;1027.9640212592524;1080.3409919948824;1154.49202350967;1291.90310726694;6601.70292336846;6612.603243805387;6631.403173714389;6642.202935647753;6701.1623547056615;1190.1847234644297;1198.526582000105;1199.4422593494066;1221.7867009764263;1222.1689251309194;5593.405879324373;5609.1305847593685;5628.296462942132;5668.461496157858;5675;8968.417052891542;9090.454572725657;9113.043130471206;9182.494962777111;9281.21109705669;8941;8996.200759848056;9013.459192448474;9060.592273347715;9151.313651476034;6874.175098988154;7337.266273372727;7340.045794046847;7378.631068446556;7381.963090184622;6905.551139175937;6976.930230697628;6991.161060672548;6996.755113571001;7011.544249623758;8062.879056814035;8128.227818357246;8207.261346478606;8275.131111233475;8391.622376992927;8358.707445239388;8439.8734018991;8442.197991190827;8482.915170848459;8585.141485851615;6601.240857301472;6611.438027767694;6625.436837868642;6648.468122550281;6676.132102826601;7449.776506704808;7471.103467583925;7477.66350514239;7493.063367079115;7515.210902855121;6751.628660423724;6965.129358830146;7039.9296007039275;7180.461465390013;7228.855422891407;6545;6549.901751473827;6597.901031484435;6664.233613134357;6671.032700258533;6774.762883299061;6795.558288711218;6857.862842743217;6865.347791959756;6881.41507971828;6370.872582548416;6379.96810015947;6391.58454700443;6406.359364063556;6435.485161187;6187.690615469299;6232.968835155795;6254.6247225166635;6259.65571893532;6276.592021518587 19:26:17 INFO - PROCESS | 7672 | |4;prototype.html;334.0812764896535;343.68896148985164;345.402453755004;347.428480150153;353.55452130315797;6149.601655354415;6201.84495387615;6211.192544969148;6224.875502489947;6283.685815709207;6143.44708976192;6160.353162917885;6200.689965501718;6203.286622038467;6212.378762123785;4738;4745.264484004968;4748.311494833247;4748.97625511872;4753.524647535253;4726.645501587377;4729.456112547049;4741.762911854411;4743.573078422941;4746.52534746526;4487.102579484116;4525.185466616024;4622.907541849161;4633.212353899845;4703.388559487262;4590.977045114753;4612.4465064192345;4612.46956599992;4619.468761092484;4622.514635963243;3979.820908059144;4018.0758425561994;4020.9195816083807;4021.4571032910476;4035.3946907963746;5840.328362238354;5846.9707651461895;5851.268591426072;5871.853203669943;5883.587938894677;5215.50452706996;5405.351357837085;5422.1053526168525;5449.809256676037;5453.209284653703;6508.511861610351;6534.673266336664;6538.346165383424;6550.344965503459;6584.144061272052;4485.484169320537;4485.865424037284;4487.820487180509;4502.752348620825;4513.50351461339;6707.228668703064;6785.355391237825;6795.3204679531655;6853.074834897275;6856.451483881277;4580.7938642761155;4584.679072464895;4584.701994370355;4595.1728688835665;4596.264597664358;4642.303654451859;4648.372469716545;4654.557817007379;4657.441107067174;4661.394018777537;5389.75746091419;5390.299261096033;5405.8107966221;5406.729663516887;5412.431694672082;6462.159919210567;6578.144841170617;6581.769638062645;6592.1430214072825;6604.669766511655;1649.5876030992251;1661.9335226590802;1663.7670726098356;1663.9084850333347;1665.4587259140828;1097.2100087936674;1100.9119270458343;1110.6334909479851;1119.535392811974;1132.2300835431986;6195.690215489208;6265.279492858289;6267.843303917347;6269.65516896566;6295.685215739286;6732.3267673232285;6742.561733487308;6758.797236082925;6764.526483146133;6767.323267673193;6165.229346331708;6200.937990620127;6243.625382477066;6251.12484252205;6253.405926436982;3665.17533554948;3671.3024525340634;3697.445383192489;3708.6847617952776;3710.165212827092;7165.211826699059;7167.462440316997;7201.711931522786;7216.206217316091;7220.205777364486;6922.134733158356;7042.7887163385185;7055.976883351886;7056.576605403692;7061.752838650623;7178.246284140195;7185.96407017972;7193.460490463236;7207.855842883113;7213.4589905757275;6835.008923706134;6837.658117094026;6853.657317134223;6854.725810967506;6897.896531552131;6641.26946035926;6789.558678685869;6791.592504449749;6792.796216113525;6811.148606424197;7145.606991615511;7199.604021778852;7201.603911784902;7203.6758345875605;7216.134063912364;4624.884377890579;4705.176594096088;4708.482066972561;4708.505606911362;4722.315264286728;6786.457083433214;6860.176778786577;6886.51794374389;6890.827729306808;6894.482913781386;6698.095757072733;6699.497537684596;6705.1283333166375;6708.631025293461;6715.832104197434;6535.085088087577;6600;6682.431993280431;6690.531662783753;6694.096296999843;6521.67391630426;6547.672616369067;6549.148610680581;6550.47596192313;6560.704768285344;6632.568883022588;6691.464682825265;6706.295838936841;6716.261211266855;6739.157605299338;6364.745410183541;6535.150430444012;6536.477081833346;6545.5090868184125;6581.407673309425 19:26:17 INFO - PROCESS | 7672 | |5;yui.html;741.9295166959139;752.3379426105026;797.1191833024511;816.4815342257666;840.3529282452512;12530.248185108889;12731.490740370396;12779.552715654954;12792.872071279307;12799.808002879965;12443.564475243369;12554.309512976783;12557.811632825493;12575.622731318075;12581.993440524759;796.2197046894062;808.1312588966855;826.450410477032;829.3613917283687;830.3564737328588;807.7899746066036;812.2162113560413;815.4129027100478;819.9016118065811;820.1798201798201;855.3713020929612;862.7282406042108;865.3164000439676;867.3104881619128;867.3278209387712;846.2848892685671;851.7104184577212;855.6491838346279;859.8237361340973;859.9914000860006;628.9088082228097;631.1479502671402;631.3465563142172;632.5034847644577;633.1990032608753;12705;12786.74426511474;12789.232646041268;12910.87089129106;12954.870451295461;11735.119866010084;11894.702632434171;12107.697307567294;12150.392480375946;12179.756404871941;9819.312648114636;10069.597216111346;10107.191424686007;10188.184945204366;10334.431606261653;3484.686378225972;3547.7516573839844;3558.0037589474987;3559.555055618048;3567.571891373052;46610.76694616505;46917.29624055642;46937.530624694;47518.76240618809;48050.27924581134;9394.765130871647;9404.24766018717;9431.434113953184;9483.33616646842;9545.331826772059;17421.47735567935;18629.254829806927;18873.150708218163;18937.33719319817;18983.620327593646;7437;7556.1310449299035;7798.53208807462;7872;7953;4015.658669013108;4042.8584999524874;4049.5950404959267;4236.343366778155;4245.936310955338;3031.227037105568;3064.3105301307473;3069;3071.1861356740483;3093.706097920739;548.9258950041773;572.2160639923331;578.4389142531821;585.9472647461664;586.0418216216517;477.49385651209826;546.1752753342481;661.4278648968608;663.0683889135772;673.5217995223446;7699.26856948589;7861.489003214772;8064.435489515678;8111.918880811117;8275.172482751797;508.3112382721433;544.8910217956425;579.1660009586183;606.931800031947;707.7133760826873;3828.1769419574925;4118.8352465901025;4120.814563344657;4123.814428350672;4234.534201237861;50534;52627.73686131545;53438.465615344125;54573.45426545763;55792.16311755327;49637.50362496329;49755.75122124366;49961.25058124131;50386.74806625943;50644.746776265885;44011.77994110073;44410;45732;46046.5395346049;46839.29741053887;8039.15588863161;8209.71266005687;8216.548089855116;8247.257746802576;8275.54484503358;33938.248645190186;34051.65948340485;34200.82899585486;34436;34786.65213347834;40048.39927401033;42672;44406;46955;50645.49354506408;10737.141028717528;10756.51595678212;10921.453927303444;11005.339679619248;11549.133814963743;11610.535578576762;11805;11859.466324015268;11976.341301228167;12245.326507041842;10636.680899573024;10703.625373112216;11256.324620522795;11395.772084558428;11597.362145081765;11141.220114592224;11381.943090284496;11547.191696581494;11923.344216068199;11955.402229888297;10480.423576703355;10589.4705264738;10957.452127393439;10974.780504390028;11286;9643.951780241054;9675.661351852652;10077.143442807443;10118.645847395306;10143.239257055602;9391.530423478935;9564.856527152237;9590.232781377612;9708.85436718464;9894.15899648538 19:26:17 INFO - PROCESS | 7672 | __end_tp_report 19:26:17 INFO - PROCESS | 7672 | __start_cc_report 19:26:17 INFO - PROCESS | 7672 | _x_x_mozilla_cycle_collect,305 19:26:17 INFO - PROCESS | 7672 | __end_cc_report 19:26:17 INFO - PROCESS | 7672 | __startTimestamp1452223577504__endTimestamp 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | ------- Summary: start ------- 19:26:17 INFO - PROCESS | 7672 | Number of tests: 6 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | [#0] dojo.html Cycles:165 Average:5342.88 Median:5521.12 stddev:582.35 (10.5%) stddev-sans-first:559.52 19:26:17 INFO - PROCESS | 7672 | Values: 3207.1 3248.6 3274.4 3288.0 3299.7 5289.0 5350.5 5367.7 5377.4 5382.4 5264.7 5268.6 5350.8 5351.2 5427.9 4815.1 4878.3 4930.3 4956.2 4966.8 4870.8 4916.4 4931.3 4970.1 4978.4 4757.0 4839.0 4843.9 4870.1 4873.4 4842.2 4921.9 4930.1 4954.0 4959.0 4827.4 4887.8 4887.8 4917.6 4918.7 5133.3 5185.4 5190.5 5216.4 5237.9 5757.7 5763.2 5768.8 5787.6 5799.3 5753.9 5761.1 5765.7 5767.9 5774.9 5217.7 5322.1 5331.4 5364.0 5404.6 5963.5 5966.5 5980.1 6003.4 6003.8 5721.5 5726.4 5733.6 5734.6 5739.1 5673.9 5719.3 5751.6 5818.7 5855.2 5679.6 5701.5 5713.7 5714.0 5720.6 5688.9 5703.8 5704.7 5713.9 5721.9 4372.7 4430.1 4473.5 4478.1 4484.4 4007.3 4012.6 4013.6 4021.9 4055.9 5409.7 5421.4 5436.2 5454.1 5500.0 5678.8 5734.0 5784.1 5803.3 5873.9 5364.1 5366.7 5368.0 5382.3 5384.7 4875.7 4919.4 4933.2 4949.3 4976.0 5834.0 5864.7 5941.3 6017.2 6029.6 5688.5 5692.5 5696.9 5697.7 5703.1 5893.8 5899.5 5909.0 5913.9 5918.7 5554.2 5628.6 5644.7 5708.5 5740.6 5808.0 5839.5 5856.5 5857.2 5865.5 5496.3 5672.1 5680.7 5692.2 5719.7 5478.9 5548.6 5610.8 5630.4 5653.7 5452.2 5492.3 5503.9 5521.1 5526.3 5569.2 5609.5 5616.7 5621.4 5713.1 5475.0 5476.3 5533.2 5567.2 5597.0 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | [#1] ext.html Cycles:180 Average:43118.75 Median:19349.86 stddev:71452.72 (369.3%) stddev-sans-first:71581.43 19:26:17 INFO - PROCESS | 7672 | Values: 476.3 510.7 520.7 524.1 542.4 35146.1 36338.3 36360.5 36393.5 36436.5 39224.6 39516.4 39730.2 39838.2 39884.8 8433.1 8611.5 8629.0 8652.2 8653.5 8261.2 8349.1 8393.3 8410.5 8472.2 8662.9 8722.6 8771.6 8788.0 8789.6 8541.2 8600.9 8602.1 8621.1 8646.4 8545.7 8616.1 8665.7 8671.5 8719.3 38023.2 38654.2 38674.4 38677.4 38677.8 3048.7 3049.5 3123.4 3148.9 3553.6 28211.0 28574.9 28791.3 29051.0 29136.4 3681.3 3730.9 3787.8 3871.7 3999.0 183158.0 183962.0 184121.0 184372.0 185452.0 49287.3 51122.5 55128.7 55400.4 55402.4 61992.4 62670.0 62992.0 63012.0 63076.4 14350.9 14599.1 14694.9 14696.0 14739.7 11081.9 11134.3 11143.3 11151.4 11168.9 18616.0 18689.2 18893.9 18982.9 19686.5 7497.7 7732.5 7740.7 7815.4 7882.9 959.4 984.7 985.6 1041.3 1075.5 27659.9 27808.9 27814.4 28066.4 28094.4 1016.0 1022.8 1125.0 1126.5 1175.0 14244.7 14469.6 14595.6 14630.6 14649.3 314248.0 321196.0 322578.0 323266.0 326178.0 49410.0 49576.3 49813.8 49881.3 49924.5 1307.6 1307.9 1323.5 1324.4 1326.3 26389.3 27460.6 27794.7 27813.0 28037.3 43473.8 43695.8 43841.8 43952.1 44106.3 289024.0 292957.0 293930.0 294195.0 294417.0 30480.1 30926.7 30943.8 31179.5 31192.4 35725.0 35838.3 36666.6 36891.0 36908.1 33316.8 34728.5 35751.8 35853.5 35968.3 33389.5 34452.0 36675.3 38139.6 38936.2 31757.2 31895.5 31962.5 32014.0 34812.8 27584.7 27783.2 29364.0 29452.6 29713.9 23886.0 24276.2 24860.0 25058.2 25508.9 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | [#2] jquery.html Cycles:180 Average:29089.40 Median:2387.48 stddev:92500.12 (3874.4%) stddev-sans-first:92734.45 19:26:17 INFO - PROCESS | 7672 | Values: 358.0 360.4 360.5 361.4 364.4 16262.8 16756.9 17240.3 17758.1 18108.5 12573.7 13070.3 13142.9 13635.5 16032.2 4979.6 5122.5 5131.3 5132.3 5162.5 5111.2 5143.0 5177.9 5181.1 5191.7 4535.6 5180.9 5379.8 5577.5 5640.7 5275.0 5280.9 5282.3 5318.5 5329.5 4868.5 5003.1 5007.1 5036.4 5045.0 12944.6 12965.0 13070.1 13130.3 13167.1 1885.4 1972.7 2017.6 2022.1 2169.5 9691.4 9698.0 9884.9 9967.3 9994.9 1750.8 1759.7 1787.1 1834.1 1854.5 57986.7 59090.4 60012.7 62452.7 63389.0 10062.0 10216.1 10293.6 10336.4 10420.9 13430.7 13439.0 13469.7 13480.3 13487.5 7440.9 7472.2 7486.1 7514.6 7538.7 7155.2 7174.1 7185.3 7193.2 7218.8 4410.6 4449.3 4479.3 4481.5 4486.4 1758.9 1795.5 1823.2 1827.2 1836.6 807.6 909.7 936.9 957.5 987.4 14077.3 16015.7 16481.9 16960.7 17132.6 886.7 887.9 898.1 899.8 926.0 9366.4 9651.8 9671.4 9695.5 9737.3 555784.0 558956.0 567080.0 569404.0 580844.0 69746.3 71797.6 71928.0 81533.6 81732.0 1131.0 1131.4 1183.0 1191.5 1210.8 15908.6 16010.1 16200.8 16260.5 16526.4 20154.8 23957.8 29118.3 35019.3 36097.6 47329.8 48715.3 48988.8 49239.5 50326.7 9397.7 9487.8 9601.0 9633.5 9636.4 11282.8 17006.8 17211.9 17506.8 17692.1 13671.5 13826.1 14268.2 14509.9 14723.9 13627.0 14556.3 14701.9 14888.5 14990.0 14300.6 14409.6 15007.9 15050.8 15728.1 9724.2 9794.6 9956.7 9982.0 10005.6 13696.7 14136.4 14628.3 14692.8 15019.7 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | [#3] mootools.html Cycles:180 Average:5352.90 Median:6375.42 stddev:2741.47 (43.0%) stddev-sans-first:2733.57 19:26:17 INFO - PROCESS | 7672 | Values: 1462.0 1465.1 1624.5 1760.6 1790.1 7538.1 7603.4 7656.5 7752.1 7759.5 7635.0 7684.3 7716.2 7722.2 7802.9 2269.1 2301.7 2324.1 2326.4 2334.6 2329.0 2345.2 2378.4 2378.5 2382.4 2256.3 2304.5 2311.8 2328.8 2348.6 2256.9 2280.2 2307.9 2315.5 2317.6 2305.0 2348.9 2350.1 2350.6 2351.4 7528.7 7613.1 7669.3 7675.4 7696.5 4715.4 4753.1 4778.4 4792.4 4796.2 2889.3 2902.6 2968.3 2974.7 2979.0 899.3 899.4 920.3 923.6 929.1 10528.3 10540.9 10554.5 10604.3 10652.8 4207.2 4250.6 4290.2 4302.4 4304.1 8646.8 8679.8 8685.5 8689.0 8694.3 4702.8 4709.8 4714.2 4716.7 4725.4 4297.2 4313.4 4315.7 4329.2 4342.2 3323.2 3339.0 3346.6 3347.3 3348.8 1018.4 1029.4 1032.3 1034.1 1060.7 1013.9 1028.0 1080.3 1154.5 1291.9 6601.7 6612.6 6631.4 6642.2 6701.2 1190.2 1198.5 1199.4 1221.8 1222.2 5593.4 5609.1 5628.3 5668.5 5675.0 8968.4 9090.5 9113.0 9182.5 9281.2 8941.0 8996.2 9013.5 9060.6 9151.3 6874.2 7337.3 7340.0 7378.6 7382.0 6905.6 6976.9 6991.2 6996.8 7011.5 8062.9 8128.2 8207.3 8275.1 8391.6 8358.7 8439.9 8442.2 8482.9 8585.1 6601.2 6611.4 6625.4 6648.5 6676.1 7449.8 7471.1 7477.7 7493.1 7515.2 6751.6 6965.1 7039.9 7180.5 7228.9 6545.0 6549.9 6597.9 6664.2 6671.0 6774.8 6795.6 6857.9 6865.3 6881.4 6370.9 6380.0 6391.6 6406.4 6435.5 6187.7 6233.0 6254.6 6259.7 6276.6 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | [#4] prototype.html Cycles:180 Average:5509.17 Median:6218.63 stddev:1690.58 (27.2%) stddev-sans-first:1650.10 19:26:17 INFO - PROCESS | 7672 | Values: 334.1 343.7 345.4 347.4 353.6 6149.6 6201.8 6211.2 6224.9 6283.7 6143.4 6160.4 6200.7 6203.3 6212.4 4738.0 4745.3 4748.3 4749.0 4753.5 4726.6 4729.5 4741.8 4743.6 4746.5 4487.1 4525.2 4622.9 4633.2 4703.4 4591.0 4612.4 4612.5 4619.5 4622.5 3979.8 4018.1 4020.9 4021.5 4035.4 5840.3 5847.0 5851.3 5871.9 5883.6 5215.5 5405.4 5422.1 5449.8 5453.2 6508.5 6534.7 6538.3 6550.3 6584.1 4485.5 4485.9 4487.8 4502.8 4513.5 6707.2 6785.4 6795.3 6853.1 6856.5 4580.8 4584.7 4584.7 4595.2 4596.3 4642.3 4648.4 4654.6 4657.4 4661.4 5389.8 5390.3 5405.8 5406.7 5412.4 6462.2 6578.1 6581.8 6592.1 6604.7 1649.6 1661.9 1663.8 1663.9 1665.5 1097.2 1100.9 1110.6 1119.5 1132.2 6195.7 6265.3 6267.8 6269.7 6295.7 6732.3 6742.6 6758.8 6764.5 6767.3 6165.2 6200.9 6243.6 6251.1 6253.4 3665.2 3671.3 3697.4 3708.7 3710.2 7165.2 7167.5 7201.7 7216.2 7220.2 6922.1 7042.8 7056.0 7056.6 7061.8 7178.2 7186.0 7193.5 7207.9 7213.5 6835.0 6837.7 6853.7 6854.7 6897.9 6641.3 6789.6 6791.6 6792.8 6811.1 7145.6 7199.6 7201.6 7203.7 7216.1 4624.9 4705.2 4708.5 4708.5 4722.3 6786.5 6860.2 6886.5 6890.8 6894.5 6698.1 6699.5 6705.1 6708.6 6715.8 6535.1 6600.0 6682.4 6690.5 6694.1 6521.7 6547.7 6549.1 6550.5 6560.7 6632.6 6691.5 6706.3 6716.3 6739.2 6364.7 6535.2 6536.5 6545.5 6581.4 19:26:17 INFO - PROCESS | 7672 | 19:26:17 INFO - PROCESS | 7672 | [#5] yui.html Cycles:180 Average:13467.98 Median:46878.30 stddev:15480.15 (33.0%) stddev-sans-first:15494.08 19:26:17 INFO - PROCESS | 7672 | Values: 741.9 752.3 797.1 816.5 840.4 12530.2 12731.5 12779.6 12792.9 12799.8 12443.6 12554.3 12557.8 12575.6 12582.0 796.2 808.1 826.5 829.4 830.4 807.8 812.2 815.4 819.9 820.2 855.4 862.7 865.3 867.3 867.3 846.3 851.7 855.6 859.8 860.0 628.9 631.1 631.3 632.5 633.2 12705.0 12786.7 12789.2 12910.9 12954.9 11735.1 11894.7 12107.7 12150.4 12179.8 9819.3 10069.6 10107.2 10188.2 10334.4 3484.7 3547.8 3558.0 3559.6 3567.6 46610.8 46917.3 46937.5 47518.8 48050.3 9394.8 9404.2 9431.4 9483.3 9545.3 17421.5 18629.3 18873.2 18937.3 18983.6 7437.0 7556.1 7798.5 7872.0 7953.0 4015.7 4042.9 4049.6 4236.3 4245.9 3031.2 3064.3 3069.0 3071.2 3093.7 548.9 572.2 578.4 585.9 586.0 477.5 546.2 661.4 663.1 673.5 7699.3 7861.5 8064.4 8111.9 8275.2 508.3 544.9 579.2 606.9 707.7 3828.2 4118.8 4120.8 4123.8 4234.5 50534.0 52627.7 53438.5 54573.5 55792.2 49637.5 49755.8 49961.3 50386.7 50644.7 44011.8 44410.0 45732.0 46046.5 46839.3 8039.2 8209.7 8216.5 8247.3 8275.5 33938.2 34051.7 34200.8 34436.0 34786.7 40048.4 42672.0 44406.0 46955.0 50645.5 10737.1 10756.5 10921.5 11005.3 11549.1 11610.5 11805.0 11859.5 11976.3 12245.3 10636.7 10703.6 11256.3 11395.8 11597.4 11141.2 11381.9 11547.2 11923.3 11955.4 10480.4 10589.5 10957.5 10974.8 11286.0 9644.0 9675.7 10077.1 10118.6 10143.2 9391.5 9564.9 9590.2 9708.9 9894.2 19:26:17 INFO - PROCESS | 7672 | -------- Summary: end -------- 19:26:17 INFO - PROCESS | 7672 | 19:26:18 INFO - TEST-INFO | 7672: exit 0 19:26:18 INFO - TEST-OK | dromaeo_css | took 1111426ms 19:26:18 INFO - TEST-START | kraken 19:26:18 INFO - operating with platform_type : linux_ 19:26:18 INFO - Initialising browser for kraken test... 19:26:18 INFO - TEST-INFO | started process 7919 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNcXXvv/profile http://localhost:39903/getInfo.html) 19:26:21 INFO - PROCESS | 7919 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 19:26:22 INFO - PROCESS | 7919 | __metrics Screen width/height:1600/1200 19:26:22 INFO - PROCESS | 7919 | colorDepth:24 19:26:22 INFO - PROCESS | 7919 | Browser inner width/height: 1024/697 19:26:22 INFO - PROCESS | 7919 | __metrics 19:26:22 INFO - PROCESS | 7919 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:26:23 INFO - TEST-INFO | 7919: exit 0 19:26:23 INFO - Browser initialized. 19:26:23 INFO - Running cycle 1/1 for kraken test... 19:26:23 INFO - TEST-INFO | started process 8045 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNcXXvv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:35 INFO - PROCESS | 8045 | RSS: Main: 150392832 19:26:35 INFO - PROCESS | 8045 | 19:26:37 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39903/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:38 INFO - PROCESS | 8045 | RSS: Main: 151076864 19:26:38 INFO - PROCESS | 8045 | 19:26:41 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39903/tests/kraken/driver.html?testName=audio-dft) 19:26:41 INFO - PROCESS | 8045 | RSS: Main: 152350720 19:26:41 INFO - PROCESS | 8045 | 19:26:44 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39903/tests/kraken/driver.html?testName=audio-fft) 19:26:45 INFO - PROCESS | 8045 | RSS: Main: 146259968 19:26:45 INFO - PROCESS | 8045 | 19:26:47 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39903/tests/kraken/driver.html?testName=audio-oscillator) 19:26:47 INFO - PROCESS | 8045 | RSS: Main: 146391040 19:26:47 INFO - PROCESS | 8045 | 19:26:49 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:50 INFO - PROCESS | 8045 | RSS: Main: 147853312 19:26:50 INFO - PROCESS | 8045 | 19:26:53 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39903/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:54 INFO - PROCESS | 8045 | RSS: Main: 148111360 19:26:54 INFO - PROCESS | 8045 | 19:26:57 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39903/tests/kraken/driver.html?testName=imaging-desaturate) 19:26:58 INFO - PROCESS | 8045 | RSS: Main: 149475328 19:26:58 INFO - PROCESS | 8045 | 19:27:00 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39903/tests/kraken/driver.html?testName=json-parse-financial) 19:27:01 INFO - PROCESS | 8045 | RSS: Main: 148439040 19:27:01 INFO - PROCESS | 8045 | 19:27:03 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:03 INFO - PROCESS | 8045 | RSS: Main: 149442560 19:27:03 INFO - PROCESS | 8045 | 19:27:05 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:06 INFO - PROCESS | 8045 | RSS: Main: 148619264 19:27:06 INFO - PROCESS | 8045 | 19:27:08 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:08 INFO - PROCESS | 8045 | RSS: Main: 149336064 19:27:08 INFO - PROCESS | 8045 | 19:27:11 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:11 INFO - PROCESS | 8045 | RSS: Main: 149032960 19:27:11 INFO - PROCESS | 8045 | 19:27:14 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:14 INFO - PROCESS | 8045 | RSS: Main: 149151744 19:27:15 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | Cycle 1(1): loaded http://localhost:39903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39903/tests/kraken/driver.html?testName=ai-astar) 19:27:16 INFO - PROCESS | 8045 | RSS: Main: 149889024 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | __start_tp_report 19:27:16 INFO - PROCESS | 8045 | _x_x_mozilla_page_load 19:27:16 INFO - PROCESS | 8045 | _x_x_mozilla_page_load_details 19:27:16 INFO - PROCESS | 8045 | |i|pagename|runs| 19:27:16 INFO - PROCESS | 8045 | |0;ai-astar;112;108;110;110;112;123;112;112;112;111 19:27:16 INFO - PROCESS | 8045 | |1;audio-beat-detection;155;129;162;163;127;149;155;128;162;127 19:27:16 INFO - PROCESS | 8045 | |2;audio-dft;163;162;161;162;163;161;160;168;173;162 19:27:16 INFO - PROCESS | 8045 | |3;audio-fft;72;73;71;76;72;128;75;76;75;74 19:27:16 INFO - PROCESS | 8045 | |4;audio-oscillator;96;97;139;96;97;98;146;97;97;143 19:27:16 INFO - PROCESS | 8045 | |5;imaging-gaussian-blur;109;110;110;109;110;110;110;109;110;110 19:27:16 INFO - PROCESS | 8045 | |6;imaging-darkroom;146;147;146;146;147;147;148;147;146;146 19:27:16 INFO - PROCESS | 8045 | |7;imaging-desaturate;96;97;96;96;96;97;96;96;96;96 19:27:16 INFO - PROCESS | 8045 | |8;json-parse-financial;60;58;59;57;67;58;59;63;56;58 19:27:16 INFO - PROCESS | 8045 | |9;json-stringify-tinderbox;68;68;68;69;69;70;68;68;69;68 19:27:16 INFO - PROCESS | 8045 | |10;stanford-crypto-aes;86;87;87;86;95;87;87;87;94;89 19:27:16 INFO - PROCESS | 8045 | |11;stanford-crypto-ccm;129;117;125;127;120;117;119;120;124;128 19:27:16 INFO - PROCESS | 8045 | |12;stanford-crypto-pbkdf2;142;152;153;153;152;143;152;149;150;145 19:27:16 INFO - PROCESS | 8045 | |13;stanford-crypto-sha256-iterative;69;70;67;68;68;68;70;67;68;67 19:27:16 INFO - PROCESS | 8045 | __end_tp_report 19:27:16 INFO - PROCESS | 8045 | __start_cc_report 19:27:16 INFO - PROCESS | 8045 | _x_x_mozilla_cycle_collect,743 19:27:16 INFO - PROCESS | 8045 | __end_cc_report 19:27:16 INFO - PROCESS | 8045 | __startTimestamp1452223636967__endTimestamp 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | ------- Summary: start ------- 19:27:16 INFO - PROCESS | 8045 | Number of tests: 14 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.02 (3.6%) stddev-sans-first:4.27 19:27:16 INFO - PROCESS | 8045 | Values: 112.0 108.0 110.0 110.0 112.0 123.0 112.0 112.0 112.0 111.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:155.00 stddev:16.01 (10.3%) stddev-sans-first:16.62 19:27:16 INFO - PROCESS | 8045 | Values: 155.0 129.0 162.0 163.0 127.0 149.0 155.0 128.0 162.0 127.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.50 stddev:3.98 (2.4%) stddev-sans-first:4.22 19:27:16 INFO - PROCESS | 8045 | Values: 163.0 162.0 161.0 162.0 163.0 161.0 160.0 168.0 173.0 162.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#3] audio-fft Cycles:10 Average:79.20 Median:74.50 stddev:17.24 (23.1%) stddev-sans-first:18.08 19:27:16 INFO - PROCESS | 8045 | Values: 72.0 73.0 71.0 76.0 72.0 128.0 75.0 76.0 75.0 74.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:97.00 stddev:22.20 (22.9%) stddev-sans-first:22.91 19:27:16 INFO - PROCESS | 8045 | Values: 96.0 97.0 139.0 96.0 97.0 98.0 146.0 97.0 97.0 143.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:27:16 INFO - PROCESS | 8045 | Values: 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:27:16 INFO - PROCESS | 8045 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 146.0 146.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:27:16 INFO - PROCESS | 8045 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:3.24 (5.5%) stddev-sans-first:3.43 19:27:16 INFO - PROCESS | 8045 | Values: 60.0 58.0 59.0 57.0 67.0 58.0 59.0 63.0 56.0 58.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 19:27:16 INFO - PROCESS | 8045 | Values: 68.0 68.0 68.0 69.0 69.0 70.0 68.0 68.0 69.0 68.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.00 stddev:3.27 (3.8%) stddev-sans-first:3.35 19:27:16 INFO - PROCESS | 8045 | Values: 86.0 87.0 87.0 86.0 95.0 87.0 87.0 87.0 94.0 89.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:124.50 stddev:4.55 (3.7%) stddev-sans-first:4.20 19:27:16 INFO - PROCESS | 8045 | Values: 129.0 117.0 125.0 127.0 120.0 117.0 119.0 120.0 124.0 128.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:152.00 stddev:4.23 (2.8%) stddev-sans-first:3.62 19:27:16 INFO - PROCESS | 8045 | Values: 142.0 152.0 153.0 153.0 152.0 143.0 152.0 149.0 150.0 145.0 19:27:16 INFO - PROCESS | 8045 | 19:27:16 INFO - PROCESS | 8045 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 19:27:16 INFO - PROCESS | 8045 | Values: 69.0 70.0 67.0 68.0 68.0 68.0 70.0 67.0 68.0 67.0 19:27:16 INFO - PROCESS | 8045 | -------- Summary: end -------- 19:27:16 INFO - PROCESS | 8045 | 19:27:17 INFO - TEST-INFO | 8045: exit 0 19:27:17 INFO - TEST-OK | kraken | took 59803ms 19:27:17 INFO - TEST-START | v8_7 19:27:17 INFO - operating with platform_type : linux_ 19:27:17 INFO - Initialising browser for v8_7 test... 19:27:18 INFO - TEST-INFO | started process 8332 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgtpuUq/profile http://localhost:39903/getInfo.html) 19:27:21 INFO - PROCESS | 8332 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 19:27:22 INFO - PROCESS | 8332 | __metrics Screen width/height:1600/1200 19:27:22 INFO - PROCESS | 8332 | colorDepth:24 19:27:22 INFO - PROCESS | 8332 | Browser inner width/height: 1024/697 19:27:22 INFO - PROCESS | 8332 | __metrics 19:27:22 INFO - PROCESS | 8332 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:27:23 INFO - TEST-INFO | 8332: exit 0 19:27:23 INFO - Browser initialized. 19:27:23 INFO - Running cycle 1/1 for v8_7 test... 19:27:23 INFO - TEST-INFO | started process 8453 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgtpuUq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:35 INFO - PROCESS | 8453 | RSS: Main: 150577152 19:27:35 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:39903/tests/v8_7/run.html (next: http://localhost:39903/tests/v8_7/run.html) 19:27:56 INFO - PROCESS | 8453 | RSS: Main: 147382272 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | __start_tp_report 19:27:56 INFO - PROCESS | 8453 | _x_x_mozilla_page_load 19:27:56 INFO - PROCESS | 8453 | _x_x_mozilla_page_load_details 19:27:56 INFO - PROCESS | 8453 | |i|pagename|runs| 19:27:56 INFO - PROCESS | 8453 | |0;Richards;170.7067258449983 19:27:56 INFO - PROCESS | 8453 | |1;DeltaBlue;189.53752843062927 19:27:56 INFO - PROCESS | 8453 | |2;Encrypt;279.9552071668533 19:27:56 INFO - PROCESS | 8453 | |3;Decrypt;5202.072538860104 19:27:56 INFO - PROCESS | 8453 | |4;RayTrace;1060.4453870625662 19:27:56 INFO - PROCESS | 8453 | |5;Earley;713.9800285306704 19:27:56 INFO - PROCESS | 8453 | |6;Boyer;12419.753086419752 19:27:56 INFO - PROCESS | 8453 | |7;RegExp;25450 19:27:56 INFO - PROCESS | 8453 | |8;Splay;682.0966643975494 19:27:56 INFO - PROCESS | 8453 | |9;NavierStokes;4845.410628019324 19:27:56 INFO - PROCESS | 8453 | __end_tp_report 19:27:56 INFO - PROCESS | 8453 | __startTimestamp1452223676696__endTimestamp 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | ------- Summary: start ------- 19:27:56 INFO - PROCESS | 8453 | Number of tests: 10 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#0] Richards Cycles:1 Average:170.71 Median:170.71 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 170.7 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#1] DeltaBlue Cycles:1 Average:189.54 Median:189.54 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 189.5 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 280.0 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 5202.1 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 1060.4 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#5] Earley Cycles:1 Average:713.98 Median:713.98 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 714.0 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 12419.8 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 25450.0 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#8] Splay Cycles:1 Average:682.10 Median:682.10 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 682.1 19:27:56 INFO - PROCESS | 8453 | 19:27:56 INFO - PROCESS | 8453 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 19:27:56 INFO - PROCESS | 8453 | Values: 4845.4 19:27:56 INFO - PROCESS | 8453 | -------- Summary: end -------- 19:27:56 INFO - PROCESS | 8453 | 19:27:57 INFO - TEST-INFO | 8453: exit 0 19:27:57 INFO - TEST-OK | v8_7 | took 39594ms 19:27:57 INFO - SUITE-END | took 1210s 19:27:57 INFO - Completed test suite (00:20:10) 19:27:57 INFO - Working with test: dromaeo_css 19:27:57 INFO - Generating results file: dromaeo_css 19:27:57 INFO - Working with test: kraken 19:27:57 INFO - Generating results file: kraken 19:27:57 INFO - javascript benchmark 19:27:57 INFO - Working with test: v8_7 19:27:57 INFO - Generating results file: v8_7 19:27:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:27:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 19:27:57 INFO - process_Request line: dromaeo_css 6918.19 graph.html#tests=[[72,1,43]] 19:27:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:27:57 INFO - process_Request line: kraken 1520.10 graph.html#tests=[[232,1,43]] 19:27:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:27:57 INFO - process_Request line: v8_7 21006.93 graph.html#tests=[[230,1,43]] 19:27:57 INFO - RETURN: dromaeo_css: 6918.19 19:27:57 INFO - RETURN: kraken: 1520.10 19:27:57 INFO - RETURN: v8_7: 21006.93 19:27:57 INFO - javascript benchmark 19:27:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.118042538302, 3248.626407963082, 3274.4269752793257, 3288.013595921223, 3299.6865297796703, 5289.0, 5350.5184533391985, 5367.731613419333, 5377.354717433908, 5382.38102618199, 5264.710440925747, 5268.631195816294, 5350.8127215547465, 5351.224072509483, 5427.864303392417, 4815.133276010317, 4878.268259761029, 4930.309756634074, 4956.2070068789, 4966.777160975451, 4870.831000559876, 4916.434610019858, 4931.284963680264, 4970.130227210242, 4978.352814134176, 4757.0, 4838.975805120987, 4843.878903027435, 4870.07468580972, 4873.43955445123, 4842.225243960949, 4921.8523444296725, 4930.112579735646, 4953.950460495421, 4958.9752051239875, 4827.444843842968, 4887.755612219375, 4887.804487820483, 4917.60659147271, 4918.729469879156, 5133.30700355451, 5185.403678576937, 5190.455002224788, 5216.374035115772, 5237.921431178535, 5757.68332741699, 5763.164341170549, 5768.826935191951, 5787.565932555033, 5799.2750906136735, 5753.856153596152, 5761.078227483583, 5765.711714414262, 5767.884642307173, 5774.913376299359, 5217.739113044333, 5322.121849894724, 5331.360236771573, 5364.034473794676, 5404.648697834628, 5963.4931030862, 5966.492848107872, 5980.132880732356, 6003.369646187175, 6003.8198854034445, 5721.5136713379825, 5726.4273572642405, 5733.569982251348, 5734.569907256972, 5739.110437882135, 5673.886522269531, 5719.256496655491, 5751.626144300607, 5818.679972601548, 5855.238818953509, 5679.602427830012, 5701.486866181981, 5713.714314284269, 5713.971430142906, 5720.599558030981, 5688.914666280009, 5703.771849126071, 5704.743286552115, 5713.857153571111, 5721.8569535761935, 4372.650187984954, 4430.113977204572, 4473.530279320625, 4478.081993191388, 4484.439445069366, 4007.338789099824, 4012.598740125964, 4013.6387725104883, 4021.859234926822, 4055.858044968412, 5409.675419474844, 5421.430749771296, 5436.184572314184, 5454.10007348783, 5500.037493438632, 5678.829635110871, 5733.971330143406, 5784.132380143013, 5803.274590676166, 5873.911891321633, 5364.088105022156, 5366.651167674088, 5367.9800837840685, 5382.327209098863, 5384.703841288767, 4875.658703890694, 4919.385076865392, 4933.186024305949, 4949.307097006422, 4975.975120124376, 5834.0, 5864.70676466175, 5941.316748573883, 6017.187679663364, 6029.60807547508, 5688.516476099578, 5692.544596432358, 5696.857578560569, 5697.743601537858, 5703.058995265735, 5893.764249429974, 5899.498542623754, 5909.0, 5913.852153696192, 5918.73365698536, 5554.222408862682, 5628.634138780966, 5644.689542075225, 5708.457696518824, 5740.626859254302, 5808.0, 5839.532837372915, 5856.502197313276, 5857.1799948008165, 5865.501432378295, 5496.31296087989, 5672.064109421899, 5680.71596420169, 5692.203091567101, 5719.656820590778, 5478.91781623268, 5548.55611551083, 5610.7755689773585, 5630.4369563043365, 5653.689047102449, 5452.154915988028, 5492.286002819608, 5503.889922201453, 5521.116621340566, 5526.281583394133, 5569.164625306236, 5609.467100625434, 5616.747246374005, 5621.409751975983, 5713.085906254979, 5474.972625136849, 5476.288082549243, 5533.170024496197, 5567.192757050124, 5597.048501754793], "unit": "score", "name": "dojo.html", "value": 5306.072599110576}, {"lowerIsBetter": false, "replicates": [476.264171854485, 510.74462768615695, 520.7240162713762, 524.0723918663967, 542.4439949052221, 35146.12134696634, 36338.27323453529, 36360.45459318112, 36393.454098188515, 36436.45345319819, 39224.60775392245, 39516.407253891215, 39730.205395892066, 39838.20323593527, 39884.80057599708, 8433.072362040155, 8611.48331100136, 8629.0, 8652.22130008299, 8653.48079115252, 8261.173882611722, 8349.081601023883, 8393.328533717287, 8410.453320534176, 8472.19514146155, 8662.913370866274, 8722.563871806384, 8771.56142192891, 8788.0, 8789.604467798932, 8541.231289183972, 8600.8709869352, 8602.053774084878, 8621.094785047542, 8646.43798153118, 8545.743627691118, 8616.138386161396, 8665.653373865038, 8671.523066231355, 8719.302455803521, 38023.23953520942, 38654.226915461535, 38674.41988370177, 38677.419838702444, 38677.80661096705, 3048.7103725146076, 3049.481588130001, 3123.3597112591865, 3148.8740450381956, 3553.5913369962527, 28211.0, 28574.85712571424, 28791.280217994507, 29051.0, 29136.41727165445, 3681.2821499807283, 3730.8880733578035, 3787.772733635991, 3871.728978971473, 3998.980005099985, 183158.0, 183962.0, 184121.0, 184371.99999999866, 185452.0, 49287.260691089665, 51122.48877511251, 55128.72435637796, 55400.445995540336, 55402.44597554053, 61992.380076198664, 62670.0, 62992.0, 63012.0, 63076.36923630705, 14350.856491434952, 14599.124052556881, 14694.853051469563, 14696.0, 14739.705205895822, 11081.944590277159, 11134.27627204229, 11143.275687080313, 11151.386673733023, 11168.888311116947, 18616.0, 18689.158987845578, 18893.90553047226, 18982.905085474486, 19686.507837304183, 7497.700091996259, 7732.536047837148, 7740.690372385042, 7815.413843961612, 7882.921170788219, 959.4195511715312, 984.7291994701515, 985.6254623243121, 1041.2919214933918, 1075.499892549968, 27659.86170069177, 27808.86095569509, 27814.443711125663, 28066.438671226868, 28094.43811123766, 1016.0, 1022.805666923297, 1124.971875703114, 1126.4761885723178, 1174.9588764393204, 14244.743784475162, 14469.602745268525, 14595.635109122144, 14630.561083167522, 14649.34077966494, 314248.0, 321196.0, 322578.0, 323266.0, 326178.0, 49410.0, 49576.256356154685, 49813.750931245115, 49881.25178122331, 49924.50075499271, 1307.627326212044, 1307.8888294494884, 1323.543377534749, 1324.3576865220361, 1326.2970625568464, 26389.340266492723, 27460.58809117905, 27794.722052779212, 27813.0, 28037.299067523476, 43473.78263108791, 43695.781521093464, 43841.78079109712, 43952.12095758003, 44106.33840492331, 289024.0, 292957.0, 293930.0, 294195.0, 294417.0, 30480.085597432113, 30926.690733092382, 30943.845280773454, 31179.532307015867, 31192.37615247637, 35725.0, 35838.283234335686, 36666.63333366632, 36891.0, 36908.077298067765, 33316.83341583276, 34728.479072813425, 35751.82124089363, 35853.462198066525, 35968.28063438769, 33389.49915751217, 34452.0, 36675.26649467049, 38139.61860381361, 38936.2212755749, 31757.20606984844, 31895.521567176977, 31962.52056219112, 32014.0, 34812.82593587117, 27584.724152758215, 27783.166505004883, 29364.0, 29452.558211626416, 29713.851430742707, 23886.0, 24276.1503347382, 24860.0, 25058.248252552454, 25508.872455637604], "unit": "score", "name": "ext.html", "value": 17646.21824905301}, {"lowerIsBetter": false, "replicates": [357.9946300805487, 360.3693536311455, 360.4521127885614, 361.39827187732425, 364.37509670914375, 16262.837371626296, 16756.916215418936, 17240.31038758451, 17758.112094395277, 18108.456746297597, 12573.748525029494, 13070.346482675852, 13142.934285328583, 13635.522756703518, 16032.198390080479, 4979.626528010395, 5122.487751224885, 5131.307273518083, 5132.332796736419, 5162.457941916101, 5111.233315002761, 5143.022825663131, 5177.948220517803, 5181.145111056671, 5191.662541934781, 4535.569120933506, 5180.948190518085, 5379.838604841861, 5577.470140336662, 5640.689762063085, 5275.0, 5280.9207861882105, 5282.286891269668, 5318.521333080022, 5329.493698098674, 4868.537488938545, 5003.124453220708, 5007.12375334315, 5036.420811606676, 5045.0, 12944.611661650166, 12965.0, 13070.085094043421, 13130.277834719087, 13167.14413563125, 1885.4155211884222, 1972.7139564763172, 2017.5863947890648, 2022.0799536211136, 2169.5227050048966, 9691.418514889128, 9697.951510242403, 9884.851727224097, 9967.302288839785, 9994.900050999542, 1750.772399588058, 1759.683257013737, 1787.061792558904, 1834.1471215884678, 1854.46220596027, 57986.71006644982, 59090.40909590892, 60012.699936500474, 62452.68773656148, 63388.99999999954, 10062.044105809937, 10216.131628811485, 10293.588256469657, 10336.431496267627, 10420.947895260475, 13430.664233394047, 13439.0, 13469.663258418617, 13480.325983700972, 13487.504811609884, 7440.925590744131, 7472.215417381097, 7486.13909400415, 7514.586697731568, 7538.736144234926, 7155.177154627285, 7174.067371241706, 7185.281471852877, 7193.172785129673, 7218.819529511804, 4410.580994805488, 4449.2658711312915, 4479.3057076153245, 4481.5070342262325, 4486.416765820488, 1758.9384371546935, 1795.4613615915173, 1823.1795691938416, 1827.1960337451478, 1836.5959488912417, 807.6117907352927, 909.663424532927, 936.9344145909857, 957.4781743949425, 987.3631507677508, 14077.296135193199, 16015.712181404127, 16481.91759041221, 16960.660786784196, 17132.571685707957, 886.7251152142857, 887.8978917424579, 898.0525545549377, 899.8425275576748, 925.9953700231456, 9366.391184572982, 9651.758706032266, 9671.419714816993, 9695.466749328714, 9737.318387712792, 555784.0, 558956.0, 567080.0, 569404.0, 580844.0, 69746.302536975, 71797.64101179565, 71928.0, 81533.59233203914, 81732.0, 1131.0216662586638, 1131.3664347965166, 1183.0299154693068, 1191.4936152135308, 1210.7881120803825, 15908.602284942968, 16010.119443430724, 16200.756988645415, 16260.51218463448, 16526.421575244807, 20154.798452015293, 23957.76042239625, 29118.27204319909, 35019.29961400809, 36097.63902361048, 47329.76335118302, 48715.269270961675, 48988.755056224494, 49239.50760492349, 50326.74836625793, 9397.718068457958, 9487.762805929908, 9600.951995239979, 9633.470159141314, 9636.42181469114, 11282.7743445129, 17006.829931700526, 17211.91394043022, 17506.824931750518, 17692.11539422998, 13671.521496747566, 13826.101303415246, 14268.215248161036, 14509.85490145085, 14723.852761472677, 13627.0, 14556.27218639085, 14701.852981470049, 14888.478903238334, 14990.0, 14300.570982870115, 14409.63975900569, 15007.924960375129, 15050.774238386652, 15728.13495257726, 9724.222062235145, 9794.608215671293, 9956.651517197153, 9981.951895051205, 10005.599776008878, 13696.65758356049, 14136.434542618592, 14628.268586570415, 14692.779608306098, 15019.699606008036], "unit": "score", "name": "jquery.html", "value": 8644.33565551655}, {"lowerIsBetter": false, "replicates": [1461.9853801461986, 1465.1428914085263, 1624.5370069530186, 1760.568660678134, 1790.1317860837491, 7538.133114691812, 7603.429742769294, 7656.54060756355, 7752.069751629805, 7759.456838021334, 7634.961825190866, 7684.308412242897, 7716.151223365426, 7722.227777222275, 7802.882956755653, 2269.1490690990836, 2301.6892719482908, 2324.081987614891, 2326.360250930991, 2334.6264597664376, 2329.0, 2345.1909091363455, 2378.4053986503372, 2378.4767351182713, 2382.404398900275, 2256.277991042867, 2304.51605162916, 2311.826613004023, 2328.8020518255967, 2348.5537747827943, 2256.909723611054, 2280.2247235939776, 2307.896144673494, 2315.490592069742, 2317.606006978809, 2305.043406986099, 2348.894299756515, 2350.083467447697, 2350.5886469867705, 2351.400392899817, 7528.736494222676, 7613.124490683587, 7669.309762121436, 7675.424343174284, 7696.538207707499, 4715.41057367829, 4753.144434001878, 4778.354922085508, 4792.448868380146, 4796.2326027835725, 2889.277680579855, 2902.6226590543306, 2968.2876109733506, 2974.672785993539, 2979.016924414938, 899.2626046641757, 899.4063917814277, 920.3235621817959, 923.6028507741669, 929.0848514213494, 10528.263021588491, 10540.894591054068, 10554.47227638615, 10604.310719803188, 10652.840207396895, 4207.158568286355, 4250.574942505787, 4290.249206388869, 4302.397664326997, 4304.096139810612, 8646.827063458695, 8679.826403472021, 8685.478871267744, 8688.956555217184, 8694.26098781598, 4702.788374523155, 4709.764511774398, 4714.222153344728, 4716.716996980193, 4725.36207611968, 4297.205017071852, 4313.439252897166, 4315.697901146952, 4329.15581461612, 4342.196693611692, 3323.2356557991316, 3338.9983005098375, 3346.598408191033, 3347.297067615828, 3348.8325583720716, 1018.4296793795498, 1029.351508549624, 1032.318669678009, 1034.0745033195249, 1060.6977011551826, 1013.9391636501833, 1027.9640212592524, 1080.3409919948824, 1154.49202350967, 1291.90310726694, 6601.70292336846, 6612.603243805387, 6631.403173714389, 6642.202935647753, 6701.1623547056615, 1190.1847234644297, 1198.526582000105, 1199.4422593494066, 1221.7867009764263, 1222.1689251309194, 5593.405879324373, 5609.1305847593685, 5628.296462942132, 5668.461496157858, 5675.0, 8968.417052891542, 9090.454572725657, 9113.043130471206, 9182.494962777111, 9281.21109705669, 8941.0, 8996.200759848056, 9013.459192448474, 9060.592273347715, 9151.313651476034, 6874.175098988154, 7337.266273372727, 7340.045794046847, 7378.631068446556, 7381.963090184622, 6905.551139175937, 6976.930230697628, 6991.161060672548, 6996.755113571001, 7011.544249623758, 8062.879056814035, 8128.227818357246, 8207.261346478606, 8275.131111233475, 8391.622376992927, 8358.707445239388, 8439.8734018991, 8442.197991190827, 8482.915170848459, 8585.141485851615, 6601.240857301472, 6611.438027767694, 6625.436837868642, 6648.468122550281, 6676.132102826601, 7449.776506704808, 7471.103467583925, 7477.66350514239, 7493.063367079115, 7515.210902855121, 6751.628660423724, 6965.129358830146, 7039.9296007039275, 7180.461465390013, 7228.855422891407, 6545.0, 6549.901751473827, 6597.901031484435, 6664.233613134357, 6671.032700258533, 6774.762883299061, 6795.558288711218, 6857.862842743217, 6865.347791959756, 6881.41507971828, 6370.872582548416, 6379.96810015947, 6391.58454700443, 6406.359364063556, 6435.485161187, 6187.690615469299, 6232.968835155795, 6254.6247225166635, 6259.65571893532, 6276.592021518587], "unit": "score", "name": "mootools.html", "value": 4412.379140094024}, {"lowerIsBetter": false, "replicates": [334.0812764896535, 343.68896148985164, 345.402453755004, 347.428480150153, 353.55452130315797, 6149.601655354415, 6201.84495387615, 6211.192544969148, 6224.875502489947, 6283.685815709207, 6143.44708976192, 6160.353162917885, 6200.689965501718, 6203.286622038467, 6212.378762123785, 4738.0, 4745.264484004968, 4748.311494833247, 4748.97625511872, 4753.524647535253, 4726.645501587377, 4729.456112547049, 4741.762911854411, 4743.573078422941, 4746.52534746526, 4487.102579484116, 4525.185466616024, 4622.907541849161, 4633.212353899845, 4703.388559487262, 4590.977045114753, 4612.4465064192345, 4612.46956599992, 4619.468761092484, 4622.514635963243, 3979.820908059144, 4018.0758425561994, 4020.9195816083807, 4021.4571032910476, 4035.3946907963746, 5840.328362238354, 5846.9707651461895, 5851.268591426072, 5871.853203669943, 5883.587938894677, 5215.50452706996, 5405.351357837085, 5422.1053526168525, 5449.809256676037, 5453.209284653703, 6508.511861610351, 6534.673266336664, 6538.346165383424, 6550.344965503459, 6584.144061272052, 4485.484169320537, 4485.865424037284, 4487.820487180509, 4502.752348620825, 4513.50351461339, 6707.228668703064, 6785.355391237825, 6795.3204679531655, 6853.074834897275, 6856.451483881277, 4580.7938642761155, 4584.679072464895, 4584.701994370355, 4595.1728688835665, 4596.264597664358, 4642.303654451859, 4648.372469716545, 4654.557817007379, 4657.441107067174, 4661.394018777537, 5389.75746091419, 5390.299261096033, 5405.8107966221, 5406.729663516887, 5412.431694672082, 6462.159919210567, 6578.144841170617, 6581.769638062645, 6592.1430214072825, 6604.669766511655, 1649.5876030992251, 1661.9335226590802, 1663.7670726098356, 1663.9084850333347, 1665.4587259140828, 1097.2100087936674, 1100.9119270458343, 1110.6334909479851, 1119.535392811974, 1132.2300835431986, 6195.690215489208, 6265.279492858289, 6267.843303917347, 6269.65516896566, 6295.685215739286, 6732.3267673232285, 6742.561733487308, 6758.797236082925, 6764.526483146133, 6767.323267673193, 6165.229346331708, 6200.937990620127, 6243.625382477066, 6251.12484252205, 6253.405926436982, 3665.17533554948, 3671.3024525340634, 3697.445383192489, 3708.6847617952776, 3710.165212827092, 7165.211826699059, 7167.462440316997, 7201.711931522786, 7216.206217316091, 7220.205777364486, 6922.134733158356, 7042.7887163385185, 7055.976883351886, 7056.576605403692, 7061.752838650623, 7178.246284140195, 7185.96407017972, 7193.460490463236, 7207.855842883113, 7213.4589905757275, 6835.008923706134, 6837.658117094026, 6853.657317134223, 6854.725810967506, 6897.896531552131, 6641.26946035926, 6789.558678685869, 6791.592504449749, 6792.796216113525, 6811.148606424197, 7145.606991615511, 7199.604021778852, 7201.603911784902, 7203.6758345875605, 7216.134063912364, 4624.884377890579, 4705.176594096088, 4708.482066972561, 4708.505606911362, 4722.315264286728, 6786.457083433214, 6860.176778786577, 6886.51794374389, 6890.827729306808, 6894.482913781386, 6698.095757072733, 6699.497537684596, 6705.1283333166375, 6708.631025293461, 6715.832104197434, 6535.085088087577, 6600.0, 6682.431993280431, 6690.531662783753, 6694.096296999843, 6521.67391630426, 6547.672616369067, 6549.148610680581, 6550.47596192313, 6560.704768285344, 6632.568883022588, 6691.464682825265, 6706.295838936841, 6716.261211266855, 6739.157605299338, 6364.745410183541, 6535.150430444012, 6536.477081833346, 6545.5090868184125, 6581.407673309425], "unit": "score", "name": "prototype.html", "value": 4959.151738809283}, {"lowerIsBetter": false, "replicates": [741.9295166959139, 752.3379426105026, 797.1191833024511, 816.4815342257666, 840.3529282452512, 12530.248185108889, 12731.490740370396, 12779.552715654954, 12792.872071279307, 12799.808002879965, 12443.564475243369, 12554.309512976783, 12557.811632825493, 12575.622731318075, 12581.993440524759, 796.2197046894062, 808.1312588966855, 826.450410477032, 829.3613917283687, 830.3564737328588, 807.7899746066036, 812.2162113560413, 815.4129027100478, 819.9016118065811, 820.1798201798201, 855.3713020929612, 862.7282406042108, 865.3164000439676, 867.3104881619128, 867.3278209387712, 846.2848892685671, 851.7104184577212, 855.6491838346279, 859.8237361340973, 859.9914000860006, 628.9088082228097, 631.1479502671402, 631.3465563142172, 632.5034847644577, 633.1990032608753, 12705.0, 12786.74426511474, 12789.232646041268, 12910.87089129106, 12954.870451295461, 11735.119866010084, 11894.702632434171, 12107.697307567294, 12150.392480375946, 12179.756404871941, 9819.312648114636, 10069.597216111346, 10107.191424686007, 10188.184945204366, 10334.431606261653, 3484.686378225972, 3547.7516573839844, 3558.0037589474987, 3559.555055618048, 3567.571891373052, 46610.76694616505, 46917.29624055642, 46937.530624694, 47518.76240618809, 48050.27924581134, 9394.765130871647, 9404.24766018717, 9431.434113953184, 9483.33616646842, 9545.331826772059, 17421.47735567935, 18629.254829806927, 18873.150708218163, 18937.33719319817, 18983.620327593646, 7437.0, 7556.1310449299035, 7798.53208807462, 7872.0, 7953.0, 4015.658669013108, 4042.8584999524874, 4049.5950404959267, 4236.343366778155, 4245.936310955338, 3031.227037105568, 3064.3105301307473, 3069.0, 3071.1861356740483, 3093.706097920739, 548.9258950041773, 572.2160639923331, 578.4389142531821, 585.9472647461664, 586.0418216216517, 477.49385651209826, 546.1752753342481, 661.4278648968608, 663.0683889135772, 673.5217995223446, 7699.26856948589, 7861.489003214772, 8064.435489515678, 8111.918880811117, 8275.172482751797, 508.3112382721433, 544.8910217956425, 579.1660009586183, 606.931800031947, 707.7133760826873, 3828.1769419574925, 4118.8352465901025, 4120.814563344657, 4123.814428350672, 4234.534201237861, 50534.0, 52627.73686131545, 53438.465615344125, 54573.45426545763, 55792.16311755327, 49637.50362496329, 49755.75122124366, 49961.25058124131, 50386.74806625943, 50644.746776265885, 44011.77994110073, 44410.0, 45732.0, 46046.5395346049, 46839.29741053887, 8039.15588863161, 8209.71266005687, 8216.548089855116, 8247.257746802576, 8275.54484503358, 33938.248645190186, 34051.65948340485, 34200.82899585486, 34436.0, 34786.65213347834, 40048.39927401033, 42672.0, 44406.0, 46955.0, 50645.49354506408, 10737.141028717528, 10756.51595678212, 10921.453927303444, 11005.339679619248, 11549.133814963743, 11610.535578576762, 11805.0, 11859.466324015268, 11976.341301228167, 12245.326507041842, 10636.680899573024, 10703.625373112216, 11256.324620522795, 11395.772084558428, 11597.362145081765, 11141.220114592224, 11381.943090284496, 11547.191696581494, 11923.344216068199, 11955.402229888297, 10480.423576703355, 10589.4705264738, 10957.452127393439, 10974.780504390028, 11286.0, 9643.951780241054, 9675.661351852652, 10077.143442807443, 10118.645847395306, 10143.239257055602, 9391.530423478935, 9564.856527152237, 9590.232781377612, 9708.85436718464, 9894.15899648538], "unit": "score", "name": "yui.html", "value": 6189.869396272792}], "name": "dromaeo_css", "value": 6918.188536600747}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 110.0, 110.0, 112.0, 123.0, 112.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 162.0, 163.0, 127.0, 149.0, 155.0, 128.0, 162.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 162.0, 163.0, 161.0, 160.0, 168.0, 173.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 76.0, 72.0, 128.0, 75.0, 76.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 139.0, 96.0, 97.0, 98.0, 146.0, 97.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 59.0, 57.0, 67.0, 58.0, 59.0, 63.0, 56.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 87.0, 86.0, 95.0, 87.0, 87.0, 87.0, 94.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [129.0, 117.0, 125.0, 127.0, 120.0, 117.0, 119.0, 120.0, 124.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [142.0, 152.0, 153.0, 153.0, 152.0, 143.0, 152.0, 149.0, 150.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 67.0, 68.0, 68.0, 68.0, 70.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1520.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.7067258449983], "unit": "score", "name": "Richards", "value": 206.79911599999994}, {"lowerIsBetter": false, "replicates": [189.53752843062927], "unit": "score", "name": "DeltaBlue", "value": 348.8385680000001}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [713.9800285306704], "unit": "score", "name": "Earley", "value": 933.447678321678}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [682.0966643975494], "unit": "score", "name": "Splay", "value": 119.47133632734533}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21006.931681411224}]} 19:27:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21006.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6918.19"}}} 19:27:57 INFO - Return code: 0 19:27:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:27:57 INFO - # TBPL SUCCESS # 19:27:57 INFO - Running post-action listener: _resource_record_post_action 19:27:57 INFO - Running post-run listener: _resource_record_post_run 19:27:59 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 328921088; Read time: 152; Write time: 157540 19:27:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5447680; Read time: 0; Write time: 396 19:27:59 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 16384; Write bytes: 323473408; Read time: 152; Write time: 157144 19:27:59 INFO - Running post-run listener: _upload_blobber_files 19:27:59 INFO - Blob upload gear active. 19:27:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:27:59 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 19:27:59 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'] 19:27:59 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 19:27:59 INFO - (blobuploader) - INFO - Open directory for files ... 19:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:00 INFO - (blobuploader) - INFO - Done attempting. 19:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:00 INFO - (blobuploader) - INFO - Done attempting. 19:28:00 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:01 INFO - Return code: 0 19:28:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:28:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0f4a48c0eb7b7ff104677273421a26a84620abd5641cf38b6581a8fb5790ffb0a83836eaf0ab36d7987e8b34793747a7a0569d24cc32a1bf399203c3b30412a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f266ec9ba9c032828cd78f7a5213d3dee95ba9d5653e94dee0e1cbc17fa5582e796fd900d10eb3891381316198393f2069b909527c1c573dac22806d176e61"} 19:28:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:28:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:28:01 INFO - Contents: 19:28:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0f4a48c0eb7b7ff104677273421a26a84620abd5641cf38b6581a8fb5790ffb0a83836eaf0ab36d7987e8b34793747a7a0569d24cc32a1bf399203c3b30412a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f266ec9ba9c032828cd78f7a5213d3dee95ba9d5653e94dee0e1cbc17fa5582e796fd900d10eb3891381316198393f2069b909527c1c573dac22806d176e61"} 19:28:01 INFO - Copying logs to upload dir... 19:28:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.559349 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-07 19:28:00.802407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:00.805883) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0f4a48c0eb7b7ff104677273421a26a84620abd5641cf38b6581a8fb5790ffb0a83836eaf0ab36d7987e8b34793747a7a0569d24cc32a1bf399203c3b30412a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f266ec9ba9c032828cd78f7a5213d3dee95ba9d5653e94dee0e1cbc17fa5582e796fd900d10eb3891381316198393f2069b909527c1c573dac22806d176e61"} build_url:https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/dE4pi44FQ96LnaXyAlrOjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0f4a48c0eb7b7ff104677273421a26a84620abd5641cf38b6581a8fb5790ffb0a83836eaf0ab36d7987e8b34793747a7a0569d24cc32a1bf399203c3b30412a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f266ec9ba9c032828cd78f7a5213d3dee95ba9d5653e94dee0e1cbc17fa5582e796fd900d10eb3891381316198393f2069b909527c1c573dac22806d176e61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:00.829862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:00.830140) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1452221640.372444-545767821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:28:00.913976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 19:28:00.914262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 19:28:00.914537) ========= ========= Total master_lag: 0.18 =========