builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1451828609.07 results: success (0) buildid: 20160103030302 builduid: 18edf61e6bf446079e860acb6e19026e revision: d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.069094) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.069592) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.069889) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006434 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.104052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.104416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.177764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.178100) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.236018) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.236424) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.236921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.237246) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-03 05:43:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-01-03 05:43:29 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.355972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.356401) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.407507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.407878) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 --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 d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-03 05:43:29,590 truncating revision to first 12 chars 2016-01-03 05:43:29,591 Setting DEBUG logging. 2016-01-03 05:43:29,591 attempt 1/10 2016-01-03 05:43:29,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d7a0ad85d9fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-03 05:43:29,835 unpacking tar archive at: mozilla-central-d7a0ad85d9fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.933863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.934201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.945125) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.945409) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 05:43:29.945783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-03 05:43:29.946079) ========= /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=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:30 INFO - MultiFileLogger online at 20160103 05:43:30 in /builds/slave/test-pgo 05:43:30 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 05:43:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:43:30 INFO - {'append_to_log': False, 05:43:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:43:30 INFO - 'blob_upload_branch': 'Firefox', 05:43:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:43:30 INFO - 'branch': 'Firefox', 05:43:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:30 INFO - 'config_files': ('talos/linux_config.py',), 05:43:30 INFO - 'default_actions': ('clobber', 05:43:30 INFO - 'read-buildbot-config', 05:43:30 INFO - 'download-and-extract', 05:43:30 INFO - 'populate-webroot', 05:43:30 INFO - 'create-virtualenv', 05:43:30 INFO - 'install', 05:43:30 INFO - 'run-tests'), 05:43:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:30 INFO - 'download_minidump_stackwalk': True, 05:43:30 INFO - 'download_symbols': 'ondemand', 05:43:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:30 INFO - 'installer_path': 'installer.exe', 05:43:30 INFO - 'log_level': 'info', 05:43:30 INFO - 'log_name': 'talos', 05:43:30 INFO - 'log_to_console': True, 05:43:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:30 INFO - 'opt_config_files': (), 05:43:30 INFO - 'pip_index': False, 05:43:30 INFO - 'sps_profile': False, 05:43:30 INFO - 'sps_profile_interval': 0, 05:43:30 INFO - 'suite': 'dromaeojs-e10s', 05:43:30 INFO - 'system_bits': '32', 05:43:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:30 INFO - 'title': 'talos-linux64-ix-047', 05:43:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:30 INFO - 'use_talos_json': True, 05:43:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:43:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:30 INFO - 'work_dir': 'build'} 05:43:30 INFO - ##### 05:43:30 INFO - ##### Running clobber step. 05:43:30 INFO - ##### 05:43:30 INFO - Running pre-action listener: _resource_record_pre_action 05:43:30 INFO - Running main action method: clobber 05:43:30 INFO - rmtree: /builds/slave/test-pgo/build 05:43:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:43:31 INFO - Running post-action listener: _resource_record_post_action 05:43:31 INFO - ##### 05:43:31 INFO - ##### Running read-buildbot-config step. 05:43:31 INFO - ##### 05:43:31 INFO - Running pre-action listener: _resource_record_pre_action 05:43:31 INFO - Running main action method: read_buildbot_config 05:43:31 INFO - Using buildbot properties: 05:43:31 INFO - { 05:43:31 INFO - "project": "", 05:43:31 INFO - "product": "firefox", 05:43:31 INFO - "script_repo_revision": "production", 05:43:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:43:31 INFO - "repository": "", 05:43:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:43:31 INFO - "buildid": "20160103030302", 05:43:31 INFO - "stage_platform": "linux64-pgo", 05:43:31 INFO - "basedir": "/builds/slave/test-pgo", 05:43:31 INFO - "nightly_build": "True", 05:43:31 INFO - "buildnumber": 285, 05:43:31 INFO - "slavename": "talos-linux64-ix-047", 05:43:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:43:31 INFO - "platform": "ubuntu64_hw", 05:43:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:31 INFO - "branch": "mozilla-central", 05:43:31 INFO - "repo_path": "mozilla-central", 05:43:31 INFO - "revision": "d7a0ad85d9fb77916f9d77d62697b852f3dc63e6", 05:43:31 INFO - "pgo_build": "True", 05:43:31 INFO - "builduid": "18edf61e6bf446079e860acb6e19026e", 05:43:31 INFO - "slavebuilddir": "test" 05:43:31 INFO - } 05:43:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:43:31 INFO - Running post-action listener: _resource_record_post_action 05:43:31 INFO - ##### 05:43:31 INFO - ##### Running download-and-extract step. 05:43:31 INFO - ##### 05:43:31 INFO - Running pre-action listener: _resource_record_pre_action 05:43:31 INFO - Running main action method: download_and_extract 05:43:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:31 INFO - https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:43:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/test_packages.json 05:43:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/test_packages.json 05:43:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:43:35 INFO - Downloaded 1302 bytes. 05:43:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:43:35 INFO - Using the following test package requirements: 05:43:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'jsshell-linux-x86_64.zip'], 05:43:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:35 INFO - https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:45 INFO - Downloaded 23198118 bytes. 05:43:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:43:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:43:46 INFO - Return code: 0 05:43:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:46 INFO - https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:48 INFO - Downloaded 23198118 bytes. 05:43:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:43:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:43:50 INFO - Return code: 0 05:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:50 INFO - https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:51 INFO - Downloaded 11132285 bytes. 05:43:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:43:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:43:51 INFO - Return code: 0 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:52 INFO - Downloaded 54981630 bytes. 05:43:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:52 INFO - mkdir: /builds/slave/test-pgo/properties 05:43:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:43:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:43:52 INFO - Contents: 05:43:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:52 INFO - Running post-action listener: _resource_record_post_action 05:43:52 INFO - Running post-action listener: set_extra_try_arguments 05:43:52 INFO - ##### 05:43:52 INFO - ##### Running populate-webroot step. 05:43:52 INFO - ##### 05:43:52 INFO - Running pre-action listener: _resource_record_pre_action 05:43:52 INFO - Running main action method: populate_webroot 05:43:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:52 INFO - '--tppagecycles', 05:43:52 INFO - '7'], 05:43:52 INFO - 'tests': ['tsvgm']}}, 05:43:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:43:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'tests': ['damp', 'tps']}, 05:43:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['damp', 'tps']}, 05:43:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:43:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:52 INFO - 'other': {'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore']}, 05:43:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore']}, 05:43:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore']}, 05:43:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore']}, 05:43:52 INFO - 'other_l64': {'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore']}, 05:43:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore']}, 05:43:52 INFO - 'svgr': {'tests': ['tsvgx', 05:43:52 INFO - 'tsvgr_opacity', 05:43:52 INFO - 'tart', 05:43:52 INFO - 'tscrollx', 05:43:52 INFO - 'cart']}, 05:43:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['tsvgx', 05:43:52 INFO - 'tsvgr_opacity', 05:43:52 INFO - 'tart', 05:43:52 INFO - 'tscrollx', 05:43:52 INFO - 'cart']}, 05:43:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'tests': ['tp5o']}, 05:43:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--e10s'], 05:43:52 INFO - 'tests': ['tp5o']}, 05:43:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--xperf_path', 05:43:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:52 INFO - 'tests': ['tp5n']}, 05:43:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--e10s', 05:43:52 INFO - '--xperf_path', 05:43:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:52 INFO - 'tests': ['tp5n']}}, 05:43:52 INFO - 'talos.zip': {'path': '', 05:43:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:52 INFO - Running post-action listener: _resource_record_post_action 05:43:52 INFO - ##### 05:43:52 INFO - ##### Running create-virtualenv step. 05:43:52 INFO - ##### 05:43:52 INFO - Running pre-action listener: _resource_record_pre_action 05:43:52 INFO - Running main action method: create_virtualenv 05:43:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:43:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:43:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:43:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:52 INFO - Using real prefix '/usr' 05:43:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:43:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:55 INFO - Installing pip.................done. 05:43:55 INFO - Return code: 0 05:43:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:43:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:55 INFO - Using env: {'DISPLAY': ':0', 05:43:55 INFO - 'HOME': '/home/cltbld', 05:43:55 INFO - 'LANG': 'en_US.UTF-8', 05:43:55 INFO - 'LANGUAGE': 'en_US:en', 05:43:55 INFO - 'LOGNAME': 'cltbld', 05:43:55 INFO - 'MAIL': '/var/mail/cltbld', 05:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:55 INFO - 'MOZ_NO_REMOTE': '1', 05:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:55 INFO - 'NO_EM_RESTART': '1', 05:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:55 INFO - 'SHELL': '/bin/bash', 05:43:55 INFO - 'SHLVL': '1', 05:43:55 INFO - 'TERM': 'linux', 05:43:55 INFO - 'TMOUT': '86400', 05:43:55 INFO - 'USER': 'cltbld', 05:43:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:55 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:55 INFO - Cleaning up... 05:43:55 INFO - Return code: 0 05:43:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:43:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:43:55 INFO - Using env: {'DISPLAY': ':0', 05:43:55 INFO - 'HOME': '/home/cltbld', 05:43:55 INFO - 'LANG': 'en_US.UTF-8', 05:43:55 INFO - 'LANGUAGE': 'en_US:en', 05:43:55 INFO - 'LOGNAME': 'cltbld', 05:43:55 INFO - 'MAIL': '/var/mail/cltbld', 05:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:55 INFO - 'MOZ_NO_REMOTE': '1', 05:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:55 INFO - 'NO_EM_RESTART': '1', 05:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:55 INFO - 'SHELL': '/bin/bash', 05:43:55 INFO - 'SHLVL': '1', 05:43:55 INFO - 'TERM': 'linux', 05:43:55 INFO - 'TMOUT': '86400', 05:43:55 INFO - 'USER': 'cltbld', 05:43:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:55 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Downloading/unpacking psutil>=0.7.1 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:43:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:57 INFO - Installing collected packages: psutil 05:43:57 INFO - Running setup.py install for psutil 05:43:57 INFO - building 'psutil._psutil_linux' extension 05:43:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:57 INFO - building 'psutil._psutil_posix' extension 05:43:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:58 INFO - Successfully installed psutil 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:44:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:44:00 INFO - Installing collected packages: mozsystemmonitor 05:44:00 INFO - Running setup.py install for mozsystemmonitor 05:44:00 INFO - Successfully installed mozsystemmonitor 05:44:00 INFO - Cleaning up... 05:44:00 INFO - Return code: 0 05:44:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:44: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')]} 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:44:00 INFO - Using env: {'DISPLAY': ':0', 05:44:00 INFO - 'HOME': '/home/cltbld', 05:44:00 INFO - 'LANG': 'en_US.UTF-8', 05:44:00 INFO - 'LANGUAGE': 'en_US:en', 05:44:00 INFO - 'LOGNAME': 'cltbld', 05:44:00 INFO - 'MAIL': '/var/mail/cltbld', 05:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:00 INFO - 'MOZ_NO_REMOTE': '1', 05:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:00 INFO - 'NO_EM_RESTART': '1', 05:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:00 INFO - 'SHELL': '/bin/bash', 05:44:00 INFO - 'SHLVL': '1', 05:44:00 INFO - 'TERM': 'linux', 05:44:00 INFO - 'TMOUT': '86400', 05:44:00 INFO - 'USER': 'cltbld', 05:44:00 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:00 INFO - '_': '/tools/buildbot/bin/python'} 05:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:44:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:44:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - Downloading docopt-0.6.1.tar.gz 05:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:44:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:03 INFO - Running setup.py install for blobuploader 05:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:44:03 INFO - Running setup.py install for requests 05:44:03 INFO - Running setup.py install for docopt 05:44:03 INFO - Successfully installed blobuploader requests docopt 05:44:03 INFO - Cleaning up... 05:44:03 INFO - Return code: 0 05:44:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:03 INFO - Using env: {'DISPLAY': ':0', 05:44:03 INFO - 'HOME': '/home/cltbld', 05:44:03 INFO - 'LANG': 'en_US.UTF-8', 05:44:03 INFO - 'LANGUAGE': 'en_US:en', 05:44:03 INFO - 'LOGNAME': 'cltbld', 05:44:03 INFO - 'MAIL': '/var/mail/cltbld', 05:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:03 INFO - 'MOZ_NO_REMOTE': '1', 05:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:03 INFO - 'NO_EM_RESTART': '1', 05:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:03 INFO - 'SHELL': '/bin/bash', 05:44:03 INFO - 'SHLVL': '1', 05:44:03 INFO - 'TERM': 'linux', 05:44:03 INFO - 'TMOUT': '86400', 05:44:03 INFO - 'USER': 'cltbld', 05:44:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:03 INFO - '_': '/tools/buildbot/bin/python'} 05:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:03 INFO - Running setup.py (path:/tmp/pip-PtNFxG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:03 INFO - Running setup.py (path:/tmp/pip-j0zXnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:04 INFO - Running setup.py (path:/tmp/pip-sTfXhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:04 INFO - Running setup.py (path:/tmp/pip-q1LYKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:04 INFO - Running setup.py (path:/tmp/pip-0qKRx2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:04 INFO - Running setup.py (path:/tmp/pip-SI5Lc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:04 INFO - Running setup.py (path:/tmp/pip-ifCzEY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:04 INFO - Running setup.py (path:/tmp/pip-XtbSfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:04 INFO - Running setup.py (path:/tmp/pip-oW6Bu7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:04 INFO - Running setup.py (path:/tmp/pip-VhqvAW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:04 INFO - Running setup.py (path:/tmp/pip-c5d2L6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:04 INFO - Running setup.py (path:/tmp/pip-4R1A_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:04 INFO - Running setup.py (path:/tmp/pip-sJ9clk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:04 INFO - Running setup.py (path:/tmp/pip-OcGYT9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:04 INFO - Running setup.py (path:/tmp/pip-D9N1Hk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:04 INFO - Running setup.py (path:/tmp/pip-lzVaFM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:05 INFO - Running setup.py (path:/tmp/pip-0PNzrK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:05 INFO - Running setup.py install for manifestparser 05:44:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Running setup.py install for mozcrash 05:44:05 INFO - Running setup.py install for mozdebug 05:44:05 INFO - Running setup.py install for mozdevice 05:44:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Running setup.py install for mozfile 05:44:05 INFO - Running setup.py install for mozhttpd 05:44:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Running setup.py install for mozinfo 05:44:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Running setup.py install for mozInstall 05:44:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:44:05 INFO - Running setup.py install for mozleak 05:44:05 INFO - Running setup.py install for mozlog 05:44:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Running setup.py install for moznetwork 05:44:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Running setup.py install for mozprocess 05:44:06 INFO - Running setup.py install for mozprofile 05:44:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Running setup.py install for mozrunner 05:44:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Running setup.py install for mozscreenshot 05:44:06 INFO - Running setup.py install for moztest 05:44:06 INFO - Running setup.py install for mozversion 05:44:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:44:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:06 INFO - Cleaning up... 05:44:06 INFO - Return code: 0 05:44:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:44:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:06 INFO - Using env: {'DISPLAY': ':0', 05:44:06 INFO - 'HOME': '/home/cltbld', 05:44:06 INFO - 'LANG': 'en_US.UTF-8', 05:44:06 INFO - 'LANGUAGE': 'en_US:en', 05:44:06 INFO - 'LOGNAME': 'cltbld', 05:44:06 INFO - 'MAIL': '/var/mail/cltbld', 05:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:06 INFO - 'MOZ_NO_REMOTE': '1', 05:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:06 INFO - 'NO_EM_RESTART': '1', 05:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:06 INFO - 'SHELL': '/bin/bash', 05:44:06 INFO - 'SHLVL': '1', 05:44:06 INFO - 'TERM': 'linux', 05:44:06 INFO - 'TMOUT': '86400', 05:44:06 INFO - 'USER': 'cltbld', 05:44:06 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:06 INFO - '_': '/tools/buildbot/bin/python'} 05:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:07 INFO - Running setup.py (path:/tmp/pip-vhP4nH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:07 INFO - Running setup.py (path:/tmp/pip-x_T2Nb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:07 INFO - Running setup.py (path:/tmp/pip-Jxd5Wo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:07 INFO - Running setup.py (path:/tmp/pip-i06ulW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:07 INFO - Running setup.py (path:/tmp/pip-nkbpRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:07 INFO - Running setup.py (path:/tmp/pip-Q8dLmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:07 INFO - Running setup.py (path:/tmp/pip-SlhKaz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:07 INFO - Running setup.py (path:/tmp/pip-tdzYSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:07 INFO - Running setup.py (path:/tmp/pip-bMf65V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:07 INFO - Running setup.py (path:/tmp/pip-W0_k6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:07 INFO - Running setup.py (path:/tmp/pip-LBHsf8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:07 INFO - Running setup.py (path:/tmp/pip-7JM9oM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:07 INFO - Running setup.py (path:/tmp/pip-mh3MVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:08 INFO - Running setup.py (path:/tmp/pip-CAW1Hi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:08 INFO - Running setup.py (path:/tmp/pip-YzN97i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:08 INFO - Running setup.py (path:/tmp/pip-Ky1DiR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:08 INFO - Running setup.py (path:/tmp/pip-xk676l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:10 INFO - Downloading blessings-1.5.1.tar.gz 05:44:10 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:44:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:10 INFO - Installing collected packages: blessings 05:44:10 INFO - Running setup.py install for blessings 05:44:10 INFO - Successfully installed blessings 05:44:10 INFO - Cleaning up... 05:44:10 INFO - Return code: 0 05:44:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:44:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:44:10 INFO - Reading from file tmpfile_stdout 05:44:10 INFO - Current package versions: 05:44:10 INFO - argparse == 1.2.1 05:44:10 INFO - blessings == 1.5.1 05:44:10 INFO - blobuploader == 1.2.4 05:44:10 INFO - docopt == 0.6.1 05:44:10 INFO - manifestparser == 1.1 05:44:10 INFO - mozInstall == 1.12 05:44:10 INFO - mozcrash == 0.16 05:44:10 INFO - mozdebug == 0.1 05:44:10 INFO - mozdevice == 0.47 05:44:10 INFO - mozfile == 1.2 05:44:10 INFO - mozhttpd == 0.7 05:44:10 INFO - mozinfo == 0.9 05:44:10 INFO - mozleak == 0.1 05:44:10 INFO - mozlog == 3.1 05:44:10 INFO - moznetwork == 0.27 05:44:10 INFO - mozprocess == 0.22 05:44:10 INFO - mozprofile == 0.28 05:44:10 INFO - mozrunner == 6.11 05:44:10 INFO - mozscreenshot == 0.1 05:44:10 INFO - mozsystemmonitor == 0.0 05:44:10 INFO - moztest == 0.7 05:44:10 INFO - mozversion == 1.4 05:44:10 INFO - psutil == 3.1.1 05:44:10 INFO - requests == 1.2.3 05:44:10 INFO - wsgiref == 0.1.2 05:44:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:10 INFO - Using env: {'DISPLAY': ':0', 05:44:10 INFO - 'HOME': '/home/cltbld', 05:44:10 INFO - 'LANG': 'en_US.UTF-8', 05:44:10 INFO - 'LANGUAGE': 'en_US:en', 05:44:10 INFO - 'LOGNAME': 'cltbld', 05:44:10 INFO - 'MAIL': '/var/mail/cltbld', 05:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:10 INFO - 'MOZ_NO_REMOTE': '1', 05:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:10 INFO - 'NO_EM_RESTART': '1', 05:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:10 INFO - 'SHELL': '/bin/bash', 05:44:10 INFO - 'SHLVL': '1', 05:44:10 INFO - 'TERM': 'linux', 05:44:10 INFO - 'TMOUT': '86400', 05:44:10 INFO - 'USER': 'cltbld', 05:44:10 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:10 INFO - '_': '/tools/buildbot/bin/python'} 05:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:44:10 INFO - Cleaning up... 05:44:10 INFO - Return code: 0 05:44:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:44:10 INFO - Using env: {'DISPLAY': ':0', 05:44:10 INFO - 'HOME': '/home/cltbld', 05:44:10 INFO - 'LANG': 'en_US.UTF-8', 05:44:10 INFO - 'LANGUAGE': 'en_US:en', 05:44:10 INFO - 'LOGNAME': 'cltbld', 05:44:10 INFO - 'MAIL': '/var/mail/cltbld', 05:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:10 INFO - 'MOZ_NO_REMOTE': '1', 05:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:10 INFO - 'NO_EM_RESTART': '1', 05:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:10 INFO - 'SHELL': '/bin/bash', 05:44:10 INFO - 'SHLVL': '1', 05:44:10 INFO - 'TERM': 'linux', 05:44:10 INFO - 'TMOUT': '86400', 05:44:10 INFO - 'USER': 'cltbld', 05:44:10 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:10 INFO - '_': '/tools/buildbot/bin/python'} 05:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:10 INFO - Downloading/unpacking jsonschema 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:44:12 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:44:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:12 INFO - warning: no files found matching '*.txt' 05:44:12 INFO - no previously-included directories found matching 'build' 05:44:12 INFO - no previously-included directories found matching 'dist' 05:44:12 INFO - no previously-included directories found matching '.git*' 05:44:12 INFO - Installing collected packages: jsonschema, functools32 05:44:12 INFO - Running setup.py install for functools32 05:44:12 INFO - warning: no files found matching '*.txt' 05:44:12 INFO - no previously-included directories found matching 'build' 05:44:12 INFO - no previously-included directories found matching 'dist' 05:44:12 INFO - no previously-included directories found matching '.git*' 05:44:12 INFO - Successfully installed jsonschema functools32 05:44:12 INFO - Cleaning up... 05:44:13 INFO - Return code: 0 05:44:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:44: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')]} 05:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d4a5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44: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', 'flake8'] in /builds/slave/test-pgo/build 05:44: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 flake8 05:44:13 INFO - Using env: {'DISPLAY': ':0', 05:44:13 INFO - 'HOME': '/home/cltbld', 05:44:13 INFO - 'LANG': 'en_US.UTF-8', 05:44:13 INFO - 'LANGUAGE': 'en_US:en', 05:44:13 INFO - 'LOGNAME': 'cltbld', 05:44:13 INFO - 'MAIL': '/var/mail/cltbld', 05:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:13 INFO - 'MOZ_NO_REMOTE': '1', 05:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:13 INFO - 'NO_EM_RESTART': '1', 05:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:13 INFO - 'SHELL': '/bin/bash', 05:44:13 INFO - 'SHLVL': '1', 05:44:13 INFO - 'TERM': 'linux', 05:44:13 INFO - 'TMOUT': '86400', 05:44:13 INFO - 'USER': 'cltbld', 05:44:13 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:13 INFO - '_': '/tools/buildbot/bin/python'} 05:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:13 INFO - Downloading/unpacking flake8 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:44:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:44:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:44:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:44:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:15 INFO - no previously-included directories found matching 'docs/_build' 05:44:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:15 INFO - Running setup.py install for pep8 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:15 INFO - no previously-included directories found matching 'docs/_build' 05:44:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:44:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:15 INFO - Cleaning up... 05:44:15 INFO - Return code: 0 05:44:15 INFO - Running post-action listener: _resource_record_post_action 05:44:15 INFO - Running post-action listener: _start_resource_monitoring 05:44:15 INFO - Starting resource monitoring. 05:44:15 INFO - ##### 05:44:15 INFO - ##### Running install step. 05:44:15 INFO - ##### 05:44:15 INFO - Running pre-action listener: _resource_record_pre_action 05:44:15 INFO - Running main action method: install 05:44:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:44:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:44:16 INFO - Reading from file tmpfile_stdout 05:44:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:44:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:44:16 INFO - Reading from file tmpfile_stdout 05:44:16 INFO - Output received: 05:44:16 INFO - Usage: mozinstall [options] installer 05:44:16 INFO - Options: 05:44:16 INFO - -h, --help show this help message and exit 05:44:16 INFO - -d DEST, --destination=DEST 05:44:16 INFO - Directory to install application into. [default: 05:44:16 INFO - "/builds/slave/test-pgo"] 05:44:16 INFO - --app=APP Application being installed. [default: firefox] 05:44:16 INFO - mkdir: /builds/slave/test-pgo/build/application 05:44:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:44:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:44:31 INFO - Reading from file tmpfile_stdout 05:44:31 INFO - Output received: 05:44:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:44:31 INFO - Running post-action listener: _resource_record_post_action 05:44:31 INFO - ##### 05:44:31 INFO - ##### Running run-tests step. 05:44:31 INFO - ##### 05:44:31 INFO - Running pre-action listener: _resource_record_pre_action 05:44:31 INFO - Running main action method: run_tests 05:44:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:44:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:44:31 INFO - Python 2.7.3 05:44:31 INFO - Return code: 0 05:44:31 INFO - grabbing minidump binary from tooltool 05:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:44:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:44:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:32 INFO - Return code: 0 05:44:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:44:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:44:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:44:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:44:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:44:32 INFO - Return code: 0 05:44:32 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/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:44:32 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/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:44:32 INFO - Using env: {'DISPLAY': ':0', 05:44:32 INFO - 'HOME': '/home/cltbld', 05:44:32 INFO - 'LANG': 'en_US.UTF-8', 05:44:32 INFO - 'LANGUAGE': 'en_US:en', 05:44:32 INFO - 'LOGNAME': 'cltbld', 05:44:32 INFO - 'MAIL': '/var/mail/cltbld', 05:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:32 INFO - 'MOZ_NO_REMOTE': '1', 05:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:32 INFO - 'NO_EM_RESTART': '1', 05:44:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:44:32 INFO - 'SHELL': '/bin/bash', 05:44:32 INFO - 'SHLVL': '1', 05:44:32 INFO - 'TERM': 'linux', 05:44:32 INFO - 'TMOUT': '86400', 05:44:32 INFO - 'USER': 'cltbld', 05:44:32 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706', 05:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:32 INFO - '_': '/tools/buildbot/bin/python'} 05:44:32 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/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:44:33 INFO - mozversion application_buildid: 20160103030302 05:44:33 INFO - mozversion application_changeset: d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 05:44:33 INFO - mozversion application_display_name: Nightly 05:44:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:33 INFO - mozversion application_name: Firefox 05:44:33 INFO - mozversion application_remotingname: firefox 05:44:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:33 INFO - mozversion application_vendor: Mozilla 05:44:33 INFO - mozversion application_version: 46.0a1 05:44:33 INFO - mozversion platform_buildid: 20160103030302 05:44:33 INFO - mozversion platform_changeset: d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 05:44:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:33 INFO - mozversion platform_version: 46.0a1 05:44:33 INFO - using testdate: 1451828673 05:44:33 INFO - actual date: 1451828673 05:44:33 INFO - starting webserver on 'localhost:39494' 05:44:33 INFO - SUITE-START | Running 3 tests 05:44:33 INFO - TEST-START | dromaeo_css 05:44:33 INFO - operating with platform_type : linux_ 05:44:33 INFO - Initialising browser for dromaeo_css test... 05:44:33 INFO - TEST-INFO | started process 2320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQDRjqf/profile http://localhost:39494/getInfo.html) 05:44:37 INFO - PROCESS | 2320 | __metrics Screen width/height:1600/1200 05:44:37 INFO - PROCESS | 2320 | colorDepth:24 05:44:37 INFO - PROCESS | 2320 | Browser inner width/height: 1024/670 05:44:37 INFO - PROCESS | 2320 | __metrics 05:44:37 INFO - PROCESS | 2320 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:44:38 INFO - TEST-INFO | 2320: exit 0 05:44:38 INFO - Browser initialized. 05:44:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:38 INFO - TEST-INFO | started process 2545 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQDRjqf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:50 INFO - PROCESS | 2545 | RSS: Main: 150355968 05:44:50 INFO - PROCESS | 2545 | 05:45:40 INFO - PROCESS | 2545 | 1451828740279 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:49 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:39494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39494/tests/dromaeo/cssquery-ext.html) 05:47:50 INFO - PROCESS | 2545 | RSS: Main: 156479488 05:47:50 INFO - PROCESS | 2545 | 05:50:52 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:39494/tests/dromaeo/cssquery-ext.html (next: http://localhost:39494/tests/dromaeo/cssquery-jquery.html) 05:50:53 INFO - PROCESS | 2545 | RSS: Main: 152420352 05:50:53 INFO - PROCESS | 2545 | 05:53:55 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:39494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39494/tests/dromaeo/cssquery-mootools.html) 05:53:55 INFO - PROCESS | 2545 | RSS: Main: 152821760 05:53:55 INFO - PROCESS | 2545 | 05:56:57 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:39494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39494/tests/dromaeo/cssquery-prototype.html) 05:56:57 INFO - PROCESS | 2545 | RSS: Main: 152117248 05:56:57 INFO - PROCESS | 2545 | 06:00:00 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:39494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39494/tests/dromaeo/cssquery-yui.html) 06:00:00 INFO - PROCESS | 2545 | RSS: Main: 152158208 06:00:00 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:39494/tests/dromaeo/cssquery-yui.html (next: http://localhost:39494/tests/dromaeo/cssquery-dojo.html) 06:03:03 INFO - PROCESS | 2545 | RSS: Main: 155004928 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | __start_tp_report 06:03:03 INFO - PROCESS | 2545 | _x_x_mozilla_page_load 06:03:03 INFO - PROCESS | 2545 | _x_x_mozilla_page_load_details 06:03:03 INFO - PROCESS | 2545 | |i|pagename|runs| 06:03:03 INFO - PROCESS | 2545 | |0;dojo.html;3156.479180935146;3194.8083115013087;3212.9036128916114;3229.69317914798;3246.123546642406;5276.234945932847;5392.379876314225;5398.64908780929;5406.67559946403;5419;5320.547753440953;5382;5429.918551221725;5446.15584584389;5448.591355648332;4890.999999999991;4922.310876477296;4980.128477516439;4989;5000.299958005882;4883.365162528884;4942.505749425065;4991.226359914219;4992.825251116212;5027.296178535008;4774.379330687006;4867.075255701406;4867.2212446008825;4902.436219834729;4950.851474455736;4879.6096312295285;4886.364772579542;4904.803807847682;4906.362172917534;4924.064427758714;4843.927341089887;4846.61227101831;4861.416630004387;4862.246351815475;4896.534829191221;5109.795608175668;5164;5167.741612919339;5201.817936372209;5231.398389185254;5810.738516766755;5852.795152169696;5855.121731740231;5888.499477544414;5935.4361335673475;5868.882622347529;5905.586608937376;5905.940940590582;5907.054871220584;5907.822765317047;5351.357837059539;5439.347278326626;5444.210589464545;5460.808871689472;5478.123500239983;5939.613925094855;5942.405759424109;5960.5827592068135;6001.159837622737;6044.486218671462;5644.717764111778;5704.286964129484;5710.400407957105;5721.5136713379;5736.913946290809;5688.63023903445;5762.538996880239;5802.564807639444;5825.50483208932;5839.240898683144;5776.306843178845;5777.62445441045;5777.971110144423;5779.3642699303045;5782.277215348082;5760.596758226884;5808.506276966421;5811.912821307684;5812.505936995402;5855.560832937462;4427.911441771146;4494.842680506166;4497.617702495259;4505.211587972091;4537;3908.296506628777;3949.368101103867;3985.9003524911527;4010.8997275068355;4030.7984600769846;5401.810936617199;5470.617056805985;5487.478689524489;5503.036968530491;5512.173174023928;5840.503557197686;5851.824445266649;5860.970695146497;5864.912026319608;5868.853278667982;5358.6248962572245;5443.891122177613;5460.453954604508;5501.394846566875;5578.497935185853;4921.581665558468;4933.876653083702;4934.555889969848;4939.506049395031;4954.108260513142;5987.580869339192;6009.978303688384;6010.3689112643415;6034.577579569388;6045.486133678686;5597.384287728428;5714.285714285715;5768.336641286306;5863.061910094364;5880.705964701662;6040.033594624839;6045.244344456943;6056.878862422815;6073.362296958756;6079.3312735598165;5585.609007369608;5689.687067211343;5707.714614269353;5726.9713651431475;5755.568332375173;5803.187553742564;5829.213056237354;5899.528037756883;5910;5938.970305148447;5725.484706376446;5764.452377024176;5772.04761214395;5784.82645520635;5786.479216870502;5674.829755107354;5757.424257574209;5760.971195143998;5782.681952492653;5782.826515204551;5544.168374743821;5622.353429355677;5701.686407247641;5702.315722113373;5752.194692742935;5672.404397538199;5700.657960522216;5758.481736643722;5764.250647415809;5768.163616275533;5459.590530710292;5519;5637.3235211774845;5647.350554686263;5648.689322087324 06:03:03 INFO - PROCESS | 2545 | |1;ext.html;506.1597747738754;522.5506064784284;529.2194013829601;544.7820871651342;550.5760564365437;35097.12257193572;36414.453783193276;36436.453453198155;36444.27111457769;36628.450573241425;38587.61412385875;38768.61231387685;38915.416268755995;38962.8051859741;39146.60853391465;8445.155484451552;8518.914810851906;8595.44129631575;8603.139686031409;8609.18212769789;8405.873911891327;8481.279091277249;8543.786405339853;8549.914500854975;8553.529555874424;8665.870011949826;8740.8688869667;8802.207801297882;8818.470891746483;8821.955890220572;8599.312055035582;8615.56922153893;8662.783430414258;8662.826743465095;8706;8545.871811922827;8658.177473140042;8671.219590236846;8681.826363472695;8696.652133914637;39721.40417893734;39981.20037599232;40240;40280;40349.394759078634;2571.2800415883585;3022.486177349856;3227.080282119608;3352.664733526652;3571.821408929543;27552.311192220153;27924;28404.431911361862;28485.85757071222;28984.855075724485;3672.4491326301;3674.926501469956;3677.632236776301;3769.0765762388114;3839.9808000960097;216605;220243;220561;220696;221222;55750.44249557453;57143.14285285724;58854.41145588575;60661.09008364878;62621;55303.72348138234;55654;55738.44261557414;55805.72097139488;55998;14660.340284687214;14953.925230373778;14974.775378369333;15077.773833392508;15101.924490377698;11684.824727629093;11739.413029348498;11749.177557571058;11750.823737643772;11902.404879755977;19465.51336216606;19751.703724444145;19795.406137815888;19936.90031549833;19995;7837.843243135106;8045.557494337868;8164.183581641907;8183.918160818434;8184;994.9502524873727;1002.9498525073717;1005.6228914157191;1021.305512251676;1051.8001579699833;25478.617820732703;25566.10518631839;25829.870850646003;25886.611700824502;25899.352516187246;1023.5394072667181;1038.9428581428094;1040.2406243442178;1067.9733006674896;1159.9710007249716;13878.791818122736;14293.142411455347;16183.10992895402;16195;16368.099754513616;388382;391806;393321;394584;394690;52407.73796130995;52584;52662;53024.46975530195;53134.20298695523;1303.9087263891436;1317.9934100329438;1336.084781924385;1338.772408690525;1349.015218890196;28454.57318140188;29440.558391623716;29757.851210743807;29782.404351912406;30197;44140.33789493224;44787.328190077824;44843.32735008912;44978.100437991714;45017;303438;303839;304222;304496;305323;30988.380232394775;42057.57942420659;43107.13785724205;43257.78371108124;43354;44831.551684482736;46145.76927115343;46499.30251046169;46651.635061966954;47010.29484557666;33188;33790.66209337875;33929;34097.82951085229;34330;33859.3228135431;35660;35689.82155089208;35742.64257357393;35876;34872.30255394929;35431.291374172884;35707.82146089253;35747.28505429825;35836.10409739777;31501.684983149877;32492;32599.348013040082;32848.83575582202;32870.835645821615;24734.876325618257;25261.494770104862;26502;26519.204423867315;26577.734222657527 06:03:03 INFO - PROCESS | 2545 | |2;jquery.html;355.16358974614775;357.72812662376595;360.8408384592887;362.07309288222154;362.19773202356777;16101.436449724262;17057.40299089532;17265.39571115011;17697.82302176978;18437.17032733527;12578.68553286166;13241.801372979413;13258.867411325884;13877.653058673539;16198.271077801497;5021.723805190713;5146.536811686948;5150.562202212797;5153.072446959546;5160.303359046518;5036.974815125919;5068.8732781680565;5091.770870310845;5106;5226.24219488174;5107.846764597068;5242.135047717122;5282.920756188661;5515.4760297771845;5529.3364796224505;5146.08897238098;5204.609654275944;5212.29633999409;5233.188855727369;5412.621116521845;5254.395744489356;5257.053730328539;5257.658252213632;5264.078786212397;5274.604404669665;12300.384980750927;12327.506899724;13333.866581346938;13413.262270575115;13425.12736672123;2038.8572799904014;2062;2065.6901464780253;2073.1810934680716;2080.7191029211012;9180.954095229481;9301.813963720688;9355.251579873662;9619.27855410847;9856;1652.140886738889;1707.1037705204742;1728.4987353667548;1761.4363403710818;1784;60433.69783151056;61983.380166198214;62353;62405.37594624041;62647.68676156636;9971.401715896924;10119.949400252952;10200.846987295197;10264.794704106025;10289.485525723834;13236.801447978289;13331.533396331082;13345.665433456577;13352.198868067948;13354.399052042487;7674.347680447225;7725.845483090419;7763.9223607764325;7768.689252429839;7776.844463110706;7562.357199638092;7582.317591416799;7611.764999875031;7615.657295421719;7672.769816905502;4406.140802543473;4428.756418396954;4454.3986561813745;4455.398521199661;4483.282674772021;1829.3048641516405;1834.6147309065245;1875.4373687893578;1880.4640677406874;1884.679604467244;406.20384047267095;826.442151547715;933.5239028095584;1009.9747506312401;1013.7212266626736;10065.798684026278;10828;11032.338059716443;11121.27711698737;11157.944210278896;430.43182998441756;431.2926800047924;440.84129713303184;451.2238949007702;455.1761312025245;5895.675737834375;5968.46283834457;6012.579119461596;6089.786857459968;6110.175126357974;556456;567776;572944;611533;611773;76857.61571192108;80764.59617701874;81495.59252203819;81598.59200703958;82438.58780706178;485.3617492996698;488.16523744396767;490.4776413120016;490.4923404276628;491.70743407672376;10135.442550659785;10182.847257290998;10192.745181370525;10365.63720269787;10399.272050956662;32589;32738.672613273564;33274.500882486296;33573.664263358034;34270.314593708485;42789.78605107079;43761.78119109384;45132.32301515545;45149.32276015928;46540.30189547092;9179.082091790768;9442.716718498456;9522.0954009369;9586.137247647745;9589.424634521672;11130.944345278222;16958.152092395085;17131.828681713025;17809.376671816422;17863;13552.728945421233;13781.931090344484;14083.225422601856;14569.708605828037;14721.509939468137;13976.301184940508;14224.79089277423;14385.208813515357;14712.485063022743;14888.032277901902;14264.358103885557;14347.497837575635;14577.85422145765;15116.773248401063;15163.545093646768;9426.387284826738;9504.714858554255;9614.759631009281;9735.513224338896;9789.706308810748;10805.621803237163;14574;14777.482788102365;15288.847111528743;15481.84518154804 06:03:03 INFO - PROCESS | 2545 | |3;mootools.html;1450.1154295879514;1460.0947412604185;1610.3397606981132;1764.7264673975537;1769.4249368955077;6862.519623626348;6987.965060174692;7571.6592753326095;7657;7747.728829490962;7145.285471452852;7302.233265507111;7504.737334193304;7596;7630.809229769258;2170.1427935965244;2190.496185877249;2207.9889600551974;2216.5345277491665;2217.0688310909377;2208.315422219109;2227.3652009177385;2229.342344008521;2235.519363336882;2257.6162052451123;2147.860389074713;2181.0730439563204;2183.017642061071;2215.0475295622878;2229.442639340165;2161;2197.571473562656;2200.1309482754223;2202.4603972026957;2204.900779464928;2144.3674116135776;2177.542716029636;2185;2194.3855720398315;2195.7255343082115;7644.655990480442;7656.770296891103;7663.463557550974;7674.884876726854;7704.65329060188;4370.191514569783;4410.823567057314;4414.536473670282;4417.668674849399;4421.07157496926;2848.8575571221563;2850.315924178203;2888.277930517371;2905.2010697058267;2913.2279945814375;928.9024652411534;941.5574679900436;952.8332541805156;956.3305686019814;989.2135752077116;9620.951895240549;9623.422594644273;9659.517024148765;9665.758356041086;9676.371035882716;3897.376419772879;4011.5988401160234;4028.436018957348;4029.4157347185082;4073.348264277701;8661.696840610548;8673.826523469495;8709;8743.56282185888;8748.34387420946;4595.379623750818;4616.030633566921;4637.675362724577;4638.327442520816;4644.465886423037;4014.739041962263;4050.8784736457956;4102.220578090153;4290.099079193405;4297.871063868027;3139.6232452105437;3182.379436009956;3198.2324242182176;3237.4981877808978;3254.723348515355;980.8822941246954;991.3358050106445;992.34009383759;999.6301368493704;1012.4735137728487;1247.5758242197514;1292.75437666843;1298.1691717300935;1306.4447609766003;1311.5016293808292;6657.40083392497;6939.479539034593;6977.1278590176225;6977.860442791217;6983.336583024605;445.5010388365052;449.77736020669977;456.7510706664876;457.72307753809133;457.922153233951;5394.379646340721;5407.297051383373;5414.052540805422;5440.564754819605;5446.618736688473;9032.819343613091;9044.81910361789;9212.907870921204;9291.76770580741;9371.531423428802;9146.451212927246;9152.222061124747;9230.446173229628;9246.121618446237;9276.443413395218;6964.651767411609;7110.893336599956;7117.181524124792;7197.532160409557;7377.9631101845225;7208.387287080657;7214.350708436056;7244.601546914971;7258.564486130849;7286.599237042014;8021.6791328348545;8122.837543248984;8184.140665230303;8186.54973976437;8317.584120793816;8138.552379618941;8341.290990265896;8364.581770911553;8402.621882015203;8475.194856488624;6577.177852768404;6585.275619681927;6585.341465853568;6667.133272674521;6759.966200168968;7189.676464559212;7198.964005179941;7201.13586369639;7229.710811567478;7234.74678386254;6647.734090636513;6686.030525573862;6699.665016749045;6776.525643204928;6791.796246112624;6657.900131497934;6712.160979877515;6759.222689390783;6844.555103918229;6848.452123829982;6704.396604305636;6728.259891411843;6779.084823548757;6786;6786.8642627148165;5922.851928701644;5938.465538101592;5957.731902064331;5965.463108320272;6061.818145455643;6196.81409557714;6240.500759939285;6245.469135123565;6245.500359971283;6248.281447633399 06:03:03 INFO - PROCESS | 2545 | |4;prototype.html;324.30113106256;325.1286552040532;337.73487812067515;342.58889332800635;349.5752660517472;6164.260288765348;6173.50611951044;6200.689965501718;6258.968705156479;6344.333844946272;6186.195794546703;6187.876242475148;6201.782937597185;6219.595726277788;6235.563510554263;4764.976175119137;4765;4772.379590653228;4772.665913386064;4773;4776.94907120433;4780.426348838144;4784.234522476405;4792.472827988936;4798.448178459469;4545.590896819285;4623.953760462403;4638.5593368629925;4653.6509761768;4691.835785747482;4605.401297831294;4628.421447319085;4645.094206629708;4651.488336283006;4654.115718013567;4009.6190861868076;4013.478247827793;4021.9743965288662;4037.4347591337237;4041.211963667086;5872.031114866042;5904.2029326040865;5911.881762364772;5919.319278283009;5933.465988061095;5320;5329.760160792774;5401.459854014567;5476.945230547723;5503.559715222773;6558.573692710006;6560.507961902877;6574.112494813235;6584;6602.60384376939;4516.458025037016;4520.50274469808;4520.909581808345;4540.18276710192;4543.5456454354635;6761.154855643044;6824.7952561423235;6880.380765731058;6887.862242755167;6896.862062758717;4653.395058642423;4653.674242803039;4655.4180727409075;4663.51033141522;4667.439907211156;4705.011947490997;4712.481627021025;4713.717176969393;4725.196716558194;4725.574698277172;5477.3427188737605;5479.863003424946;5481.917771233435;5488.643238189505;5497.945020549823;6440.259370172396;6631.86736265272;6647.567908085959;6650.268470468244;6668.033135195369;1658.4361317152227;1676.5054308978881;1676.9016294327234;1680.252287731972;1680.5546530169515;1116.1015382617072;1117.2067831839322;1127.0814286356592;1130.8190689489643;1138.345451365468;6244.2819075806865;6244.469220116341;6264.812055638338;6264.9373506265265;6271.874562508724;6798.2182049064;6806.387425131762;6816.386525212754;6826.624535650587;6829.863402731918;6155.861165684273;6257.530685198537;6275.623462592259;6278.686065696788;6290.654014029181;3724.0689827543115;3736.3461394255896;3747.3067482515276;3759.2105657811617;3760.887173384748;7236.204017558064;7260.891086633705;7261.5280006799385;7270.8182295441975;7280.0535930328715;6937.583744975318;7014.22843487216;7059.8235044123285;7067.293270672892;7083.716651333889;7218.205997340288;7220.638968051681;7224.566526008456;7225.674844632004;7227.5302105364035;6836.042953986545;6853.485988550979;6861.897071543831;6873.518853680194;6952;6655.101561289164;6811.386975172259;6834.2140653825445;6836.38472537474;6845.247022827584;7172;7199.388052015637;7203.603801790742;7226.096737907762;7254;4798.640101992295;4823.734694591831;4827.637927155407;4835;4850.95149048505;6685.197776266879;6807.5575087619145;6813.1142951415995;6830.326569990384;6840.623765692934;6618.536702430783;6639.3692599203;6639.634820084942;6657.4674026078765;6657.966710166418;6409.230892292768;6633.2040155181685;6636.13730215069;6642.070110184482;6642.76750313756;6486.902696459462;6496.603230305318;6507;6507.479401647952;6512.381323774234;6598.934010659832;6644.966775166094;6656.7004484797335;6669.666516674244;6671.733130674718;6321.652309123042;6437.7103030362805;6454.290028097;6465.321141280097;6496.967515162583 06:03:03 INFO - PROCESS | 2545 | |5;yui.html;718.9856202875943;720.1753991679527;730.8465222303317;747.6859718918054;785.3991696352291;13755.656108597277;13833.17000979942;13988.160710357373;14027.08823926444;14038.087524310926;12979.545715899945;13075.346232688375;13086.607401777937;13101.08292419531;13110.73778524429;803.317180396664;806.2018601584418;826.8428998490298;829.7884039569932;829.9626516806728;818.8567000774871;819.5574389829485;823.7940514871282;824.6536454689045;825.4304529874368;861.7242482405633;865.8657908024267;867.3798234262501;869.9652013919467;870.8476016697084;849.0957130655862;853.5988085599789;856.2293935458075;858.9226969572768;859.4499520307008;630.4294613374904;631.7062565906875;632.1245075570322;632.3423639415049;635.3551145587232;12735.936320318431;12851.614451566467;12859.42132604035;12874.806877896839;12878.484860605564;11073.557057717682;11270.380129092897;11424.200305978586;11581.36302503362;11912.880871191264;10161.59353625854;10173.694789156338;10248.48757562119;10648.094911932494;10749.946250268777;3487.424574945131;3564.324767359337;3589.784612923233;3624.855005799765;3677.007208053837;46624.300635490494;47319.76340118312;47653.28520072201;47731.28403073957;47760.28359574609;8653.956730216309;8674.95900491945;8696.565171741388;8777.51723655205;8798.16417440355;17505.7374139388;17755.15917453201;17792.11039448048;17804.821951780315;17812.91093544524;7295.781126566211;7469.887951680729;7514.9624251878395;7550.3582195514;7754.844903101906;4193.1404062167185;4209.137126888981;4258.53156152823;4271.786410679453;4295.484541854998;2812.943741125166;2847.5586284125993;2848.7720982321366;2862.3845873137375;2870.9712902870706;531.5614617940215;540.4757385336218;544.0207626272693;550.8127236739527;551.1017042221154;530.0591450175968;565.8726786473093;617.8887800196007;631.9431251187415;650.5153660522847;8598.312135029182;8833.160849719266;8864.157904999014;8933.59798809055;9137.63449462014;521.7521677203298;540.6431755041654;626.9655168965751;696.061444054433;698.0401947322432;3832.9616703833162;3892.5134358205223;3939.684825213976;3965.147493288957;4155.854545090907;52560.37198140078;58189.70905145447;58689.706551467825;58809;58973.70513147407;51783.22325165125;51885.22172167421;52044.47955520472;53431.46568534265;53696;47232.52767472281;47272.290915636295;47696.28455573169;47786;47801;8535.359848011549;8603.870941935751;8672.089430609694;8699.521526316114;8752.21230089295;32480.187995300308;32546.349073018882;32657.34685306328;32663.673363267015;33122.33755324928;42530.362044568734;44261.77869110634;44754.3286850691;44801.55198447974;45120;9718.70843874685;10029.849552256868;10234.948825255826;10467.581296748045;10780.29928054674;10936.835947460635;10988.285761425483;11089.50097245642;11320.830187547359;11437.199396042197;9973.102420782165;10361.171106311327;10372.740681483023;10387.94806025965;11794.46924888365;9975.900240997496;10098.293119481566;10172.643957461749;10401.8557958626;11034.503447345049;11482.712932176762;11717.238379505305;11917.16579839403;12096.45565949552;12262.938685306517;9222.95388523053;9953.832131251336;10041.799164016826;10152.492375381054;10286.2799604027;9502.524873756423;9711;9762.560684769345;9865.358751681119;10192 06:03:03 INFO - PROCESS | 2545 | __end_tp_report 06:03:03 INFO - PROCESS | 2545 | __start_cc_report 06:03:03 INFO - PROCESS | 2545 | _x_x_mozilla_cycle_collect,300 06:03:03 INFO - PROCESS | 2545 | __end_cc_report 06:03:03 INFO - PROCESS | 2545 | __startTimestamp1451829783584__endTimestamp 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | ------- Summary: start ------- 06:03:03 INFO - PROCESS | 2545 | Number of tests: 6 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | [#0] dojo.html Cycles:165 Average:5396.90 Median:5644.72 stddev:617.23 (10.9%) stddev-sans-first:593.57 06:03:03 INFO - PROCESS | 2545 | Values: 3156.5 3194.8 3212.9 3229.7 3246.1 5276.2 5392.4 5398.6 5406.7 5419.0 5320.5 5382.0 5429.9 5446.2 5448.6 4891.0 4922.3 4980.1 4989.0 5000.3 4883.4 4942.5 4991.2 4992.8 5027.3 4774.4 4867.1 4867.2 4902.4 4950.9 4879.6 4886.4 4904.8 4906.4 4924.1 4843.9 4846.6 4861.4 4862.2 4896.5 5109.8 5164.0 5167.7 5201.8 5231.4 5810.7 5852.8 5855.1 5888.5 5935.4 5868.9 5905.6 5905.9 5907.1 5907.8 5351.4 5439.3 5444.2 5460.8 5478.1 5939.6 5942.4 5960.6 6001.2 6044.5 5644.7 5704.3 5710.4 5721.5 5736.9 5688.6 5762.5 5802.6 5825.5 5839.2 5776.3 5777.6 5778.0 5779.4 5782.3 5760.6 5808.5 5811.9 5812.5 5855.6 4427.9 4494.8 4497.6 4505.2 4537.0 3908.3 3949.4 3985.9 4010.9 4030.8 5401.8 5470.6 5487.5 5503.0 5512.2 5840.5 5851.8 5861.0 5864.9 5868.9 5358.6 5443.9 5460.5 5501.4 5578.5 4921.6 4933.9 4934.6 4939.5 4954.1 5987.6 6010.0 6010.4 6034.6 6045.5 5597.4 5714.3 5768.3 5863.1 5880.7 6040.0 6045.2 6056.9 6073.4 6079.3 5585.6 5689.7 5707.7 5727.0 5755.6 5803.2 5829.2 5899.5 5910.0 5939.0 5725.5 5764.5 5772.0 5784.8 5786.5 5674.8 5757.4 5761.0 5782.7 5782.8 5544.2 5622.4 5701.7 5702.3 5752.2 5672.4 5700.7 5758.5 5764.3 5768.2 5459.6 5519.0 5637.3 5647.4 5648.7 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | [#1] ext.html Cycles:180 Average:47263.00 Median:36145.23 stddev:82455.58 (228.1%) stddev-sans-first:82612.16 06:03:03 INFO - PROCESS | 2545 | Values: 506.2 522.6 529.2 544.8 550.6 35097.1 36414.5 36436.5 36444.3 36628.5 38587.6 38768.6 38915.4 38962.8 39146.6 8445.2 8518.9 8595.4 8603.1 8609.2 8405.9 8481.3 8543.8 8549.9 8553.5 8665.9 8740.9 8802.2 8818.5 8822.0 8599.3 8615.6 8662.8 8662.8 8706.0 8545.9 8658.2 8671.2 8681.8 8696.7 39721.4 39981.2 40240.0 40280.0 40349.4 2571.3 3022.5 3227.1 3352.7 3571.8 27552.3 27924.0 28404.4 28485.9 28984.9 3672.4 3674.9 3677.6 3769.1 3840.0 216605.0 220243.0 220561.0 220696.0 221222.0 55750.4 57143.1 58854.4 60661.1 62621.0 55303.7 55654.0 55738.4 55805.7 55998.0 14660.3 14953.9 14974.8 15077.8 15101.9 11684.8 11739.4 11749.2 11750.8 11902.4 19465.5 19751.7 19795.4 19936.9 19995.0 7837.8 8045.6 8164.2 8183.9 8184.0 995.0 1002.9 1005.6 1021.3 1051.8 25478.6 25566.1 25829.9 25886.6 25899.4 1023.5 1038.9 1040.2 1068.0 1160.0 13878.8 14293.1 16183.1 16195.0 16368.1 388382.0 391806.0 393321.0 394584.0 394690.0 52407.7 52584.0 52662.0 53024.5 53134.2 1303.9 1318.0 1336.1 1338.8 1349.0 28454.6 29440.6 29757.9 29782.4 30197.0 44140.3 44787.3 44843.3 44978.1 45017.0 303438.0 303839.0 304222.0 304496.0 305323.0 30988.4 42057.6 43107.1 43257.8 43354.0 44831.6 46145.8 46499.3 46651.6 47010.3 33188.0 33790.7 33929.0 34097.8 34330.0 33859.3 35660.0 35689.8 35742.6 35876.0 34872.3 35431.3 35707.8 35747.3 35836.1 31501.7 32492.0 32599.3 32848.8 32870.8 24734.9 25261.5 26502.0 26519.2 26577.7 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | [#2] jquery.html Cycles:180 Average:29310.84 Median:22101.31 stddev:95584.39 (432.5%) stddev-sans-first:95827.79 06:03:03 INFO - PROCESS | 2545 | Values: 355.2 357.7 360.8 362.1 362.2 16101.4 17057.4 17265.4 17697.8 18437.2 12578.7 13241.8 13258.9 13877.7 16198.3 5021.7 5146.5 5150.6 5153.1 5160.3 5037.0 5068.9 5091.8 5106.0 5226.2 5107.8 5242.1 5282.9 5515.5 5529.3 5146.1 5204.6 5212.3 5233.2 5412.6 5254.4 5257.1 5257.7 5264.1 5274.6 12300.4 12327.5 13333.9 13413.3 13425.1 2038.9 2062.0 2065.7 2073.2 2080.7 9181.0 9301.8 9355.3 9619.3 9856.0 1652.1 1707.1 1728.5 1761.4 1784.0 60433.7 61983.4 62353.0 62405.4 62647.7 9971.4 10119.9 10200.8 10264.8 10289.5 13236.8 13331.5 13345.7 13352.2 13354.4 7674.3 7725.8 7763.9 7768.7 7776.8 7562.4 7582.3 7611.8 7615.7 7672.8 4406.1 4428.8 4454.4 4455.4 4483.3 1829.3 1834.6 1875.4 1880.5 1884.7 406.2 826.4 933.5 1010.0 1013.7 10065.8 10828.0 11032.3 11121.3 11157.9 430.4 431.3 440.8 451.2 455.2 5895.7 5968.5 6012.6 6089.8 6110.2 556456.0 567776.0 572944.0 611533.0 611773.0 76857.6 80764.6 81495.6 81598.6 82438.6 485.4 488.2 490.5 490.5 491.7 10135.4 10182.8 10192.7 10365.6 10399.3 32589.0 32738.7 33274.5 33573.7 34270.3 42789.8 43761.8 45132.3 45149.3 46540.3 9179.1 9442.7 9522.1 9586.1 9589.4 11130.9 16958.2 17131.8 17809.4 17863.0 13552.7 13781.9 14083.2 14569.7 14721.5 13976.3 14224.8 14385.2 14712.5 14888.0 14264.4 14347.5 14577.9 15116.8 15163.5 9426.4 9504.7 9614.8 9735.5 9789.7 10805.6 14574.0 14777.5 15288.8 15481.8 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | [#3] mootools.html Cycles:180 Average:5231.43 Median:6657.65 stddev:2741.27 (41.2%) stddev-sans-first:2734.22 06:03:03 INFO - PROCESS | 2545 | Values: 1450.1 1460.1 1610.3 1764.7 1769.4 6862.5 6988.0 7571.7 7657.0 7747.7 7145.3 7302.2 7504.7 7596.0 7630.8 2170.1 2190.5 2208.0 2216.5 2217.1 2208.3 2227.4 2229.3 2235.5 2257.6 2147.9 2181.1 2183.0 2215.0 2229.4 2161.0 2197.6 2200.1 2202.5 2204.9 2144.4 2177.5 2185.0 2194.4 2195.7 7644.7 7656.8 7663.5 7674.9 7704.7 4370.2 4410.8 4414.5 4417.7 4421.1 2848.9 2850.3 2888.3 2905.2 2913.2 928.9 941.6 952.8 956.3 989.2 9621.0 9623.4 9659.5 9665.8 9676.4 3897.4 4011.6 4028.4 4029.4 4073.3 8661.7 8673.8 8709.0 8743.6 8748.3 4595.4 4616.0 4637.7 4638.3 4644.5 4014.7 4050.9 4102.2 4290.1 4297.9 3139.6 3182.4 3198.2 3237.5 3254.7 980.9 991.3 992.3 999.6 1012.5 1247.6 1292.8 1298.2 1306.4 1311.5 6657.4 6939.5 6977.1 6977.9 6983.3 445.5 449.8 456.8 457.7 457.9 5394.4 5407.3 5414.1 5440.6 5446.6 9032.8 9044.8 9212.9 9291.8 9371.5 9146.5 9152.2 9230.4 9246.1 9276.4 6964.7 7110.9 7117.2 7197.5 7378.0 7208.4 7214.4 7244.6 7258.6 7286.6 8021.7 8122.8 8184.1 8186.5 8317.6 8138.6 8341.3 8364.6 8402.6 8475.2 6577.2 6585.3 6585.3 6667.1 6760.0 7189.7 7199.0 7201.1 7229.7 7234.7 6647.7 6686.0 6699.7 6776.5 6791.8 6657.9 6712.2 6759.2 6844.6 6848.5 6704.4 6728.3 6779.1 6786.0 6786.9 5922.9 5938.5 5957.7 5965.5 6061.8 6196.8 6240.5 6245.5 6245.5 6248.3 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | [#4] prototype.html Cycles:180 Average:5529.75 Median:6251.00 stddev:1684.25 (26.9%) stddev-sans-first:1643.03 06:03:03 INFO - PROCESS | 2545 | Values: 324.3 325.1 337.7 342.6 349.6 6164.3 6173.5 6200.7 6259.0 6344.3 6186.2 6187.9 6201.8 6219.6 6235.6 4765.0 4765.0 4772.4 4772.7 4773.0 4776.9 4780.4 4784.2 4792.5 4798.4 4545.6 4624.0 4638.6 4653.7 4691.8 4605.4 4628.4 4645.1 4651.5 4654.1 4009.6 4013.5 4022.0 4037.4 4041.2 5872.0 5904.2 5911.9 5919.3 5933.5 5320.0 5329.8 5401.5 5476.9 5503.6 6558.6 6560.5 6574.1 6584.0 6602.6 4516.5 4520.5 4520.9 4540.2 4543.5 6761.2 6824.8 6880.4 6887.9 6896.9 4653.4 4653.7 4655.4 4663.5 4667.4 4705.0 4712.5 4713.7 4725.2 4725.6 5477.3 5479.9 5481.9 5488.6 5497.9 6440.3 6631.9 6647.6 6650.3 6668.0 1658.4 1676.5 1676.9 1680.3 1680.6 1116.1 1117.2 1127.1 1130.8 1138.3 6244.3 6244.5 6264.8 6264.9 6271.9 6798.2 6806.4 6816.4 6826.6 6829.9 6155.9 6257.5 6275.6 6278.7 6290.7 3724.1 3736.3 3747.3 3759.2 3760.9 7236.2 7260.9 7261.5 7270.8 7280.1 6937.6 7014.2 7059.8 7067.3 7083.7 7218.2 7220.6 7224.6 7225.7 7227.5 6836.0 6853.5 6861.9 6873.5 6952.0 6655.1 6811.4 6834.2 6836.4 6845.2 7172.0 7199.4 7203.6 7226.1 7254.0 4798.6 4823.7 4827.6 4835.0 4851.0 6685.2 6807.6 6813.1 6830.3 6840.6 6618.5 6639.4 6639.6 6657.5 6658.0 6409.2 6633.2 6636.1 6642.1 6642.8 6486.9 6496.6 6507.0 6507.5 6512.4 6598.9 6645.0 6656.7 6669.7 6671.7 6321.7 6437.7 6454.3 6465.3 6497.0 06:03:03 INFO - PROCESS | 2545 | 06:03:03 INFO - PROCESS | 2545 | [#5] yui.html Cycles:180 Average:13617.97 Median:47674.78 stddev:15987.72 (33.5%) stddev-sans-first:16003.23 06:03:03 INFO - PROCESS | 2545 | Values: 719.0 720.2 730.8 747.7 785.4 13755.7 13833.2 13988.2 14027.1 14038.1 12979.5 13075.3 13086.6 13101.1 13110.7 803.3 806.2 826.8 829.8 830.0 818.9 819.6 823.8 824.7 825.4 861.7 865.9 867.4 870.0 870.8 849.1 853.6 856.2 858.9 859.4 630.4 631.7 632.1 632.3 635.4 12735.9 12851.6 12859.4 12874.8 12878.5 11073.6 11270.4 11424.2 11581.4 11912.9 10161.6 10173.7 10248.5 10648.1 10749.9 3487.4 3564.3 3589.8 3624.9 3677.0 46624.3 47319.8 47653.3 47731.3 47760.3 8654.0 8675.0 8696.6 8777.5 8798.2 17505.7 17755.2 17792.1 17804.8 17812.9 7295.8 7469.9 7515.0 7550.4 7754.8 4193.1 4209.1 4258.5 4271.8 4295.5 2812.9 2847.6 2848.8 2862.4 2871.0 531.6 540.5 544.0 550.8 551.1 530.1 565.9 617.9 631.9 650.5 8598.3 8833.2 8864.2 8933.6 9137.6 521.8 540.6 627.0 696.1 698.0 3833.0 3892.5 3939.7 3965.1 4155.9 52560.4 58189.7 58689.7 58809.0 58973.7 51783.2 51885.2 52044.5 53431.5 53696.0 47232.5 47272.3 47696.3 47786.0 47801.0 8535.4 8603.9 8672.1 8699.5 8752.2 32480.2 32546.3 32657.3 32663.7 33122.3 42530.4 44261.8 44754.3 44801.6 45120.0 9718.7 10029.8 10234.9 10467.6 10780.3 10936.8 10988.3 11089.5 11320.8 11437.2 9973.1 10361.2 10372.7 10387.9 11794.5 9975.9 10098.3 10172.6 10401.9 11034.5 11482.7 11717.2 11917.2 12096.5 12262.9 9223.0 9953.8 10041.8 10152.5 10286.3 9502.5 9711.0 9762.6 9865.4 10192.0 06:03:03 INFO - PROCESS | 2545 | -------- Summary: end -------- 06:03:03 INFO - PROCESS | 2545 | 06:03:04 INFO - TEST-INFO | 2545: exit 0 06:03:04 INFO - TEST-OK | dromaeo_css | took 1111088ms 06:03:04 INFO - TEST-START | kraken 06:03:04 INFO - operating with platform_type : linux_ 06:03:04 INFO - Initialising browser for kraken test... 06:03:04 INFO - TEST-INFO | started process 2881 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEfLP6s/profile http://localhost:39494/getInfo.html) 06:03:08 INFO - PROCESS | 2881 | __metrics Screen width/height:1600/1200 06:03:08 INFO - PROCESS | 2881 | colorDepth:24 06:03:08 INFO - PROCESS | 2881 | Browser inner width/height: 1024/670 06:03:08 INFO - PROCESS | 2881 | __metrics 06:03:08 INFO - PROCESS | 2881 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:03:09 INFO - TEST-INFO | 2881: exit 0 06:03:09 INFO - Browser initialized. 06:03:09 INFO - Running cycle 1/1 for kraken test... 06:03:09 INFO - TEST-INFO | started process 3014 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEfLP6s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:21 INFO - PROCESS | 3014 | RSS: Main: 150654976 06:03:21 INFO - PROCESS | 3014 | 06:03:24 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39494/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:24 INFO - PROCESS | 3014 | RSS: Main: 151068672 06:03:24 INFO - PROCESS | 3014 | 06:03:27 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39494/tests/kraken/driver.html?testName=audio-dft) 06:03:27 INFO - PROCESS | 3014 | RSS: Main: 151715840 06:03:27 INFO - PROCESS | 3014 | 06:03:30 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39494/tests/kraken/driver.html?testName=audio-fft) 06:03:31 INFO - PROCESS | 3014 | RSS: Main: 145104896 06:03:31 INFO - PROCESS | 3014 | 06:03:33 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39494/tests/kraken/driver.html?testName=audio-oscillator) 06:03:33 INFO - PROCESS | 3014 | RSS: Main: 146255872 06:03:33 INFO - PROCESS | 3014 | 06:03:36 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:36 INFO - PROCESS | 3014 | RSS: Main: 146038784 06:03:36 INFO - PROCESS | 3014 | 06:03:39 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39494/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:40 INFO - PROCESS | 3014 | RSS: Main: 147517440 06:03:40 INFO - PROCESS | 3014 | 06:03:43 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39494/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:44 INFO - PROCESS | 3014 | RSS: Main: 146903040 06:03:44 INFO - PROCESS | 3014 | 06:03:47 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39494/tests/kraken/driver.html?testName=json-parse-financial) 06:03:47 INFO - PROCESS | 3014 | RSS: Main: 148938752 06:03:47 INFO - PROCESS | 3014 | 06:03:49 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:49 INFO - PROCESS | 3014 | RSS: Main: 148037632 06:03:49 INFO - PROCESS | 3014 | 06:03:51 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:52 INFO - PROCESS | 3014 | RSS: Main: 148484096 06:03:52 INFO - PROCESS | 3014 | 06:03:54 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:54 INFO - PROCESS | 3014 | RSS: Main: 148811776 06:03:54 INFO - PROCESS | 3014 | 06:03:57 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:58 INFO - PROCESS | 3014 | RSS: Main: 148447232 06:03:58 INFO - PROCESS | 3014 | 06:04:00 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:01 INFO - PROCESS | 3014 | RSS: Main: 148721664 06:04:01 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | Cycle 1(1): loaded http://localhost:39494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39494/tests/kraken/driver.html?testName=ai-astar) 06:04:03 INFO - PROCESS | 3014 | RSS: Main: 149520384 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | __start_tp_report 06:04:03 INFO - PROCESS | 3014 | _x_x_mozilla_page_load 06:04:03 INFO - PROCESS | 3014 | _x_x_mozilla_page_load_details 06:04:03 INFO - PROCESS | 3014 | |i|pagename|runs| 06:04:03 INFO - PROCESS | 3014 | |0;ai-astar;111;105;115;112;112;123;110;110;113;111 06:04:03 INFO - PROCESS | 3014 | |1;audio-beat-detection;147;127;158;171;128;153;151;128;166;127 06:04:03 INFO - PROCESS | 3014 | |2;audio-dft;164;164;162;165;162;162;163;172;165;162 06:04:03 INFO - PROCESS | 3014 | |3;audio-fft;72;72;71;74;74;72;148;72;74;72 06:04:03 INFO - PROCESS | 3014 | |4;audio-oscillator;97;97;146;96;96;96;139;96;98;140 06:04:03 INFO - PROCESS | 3014 | |5;imaging-gaussian-blur;110;110;109;110;109;111;109;110;109;109 06:04:03 INFO - PROCESS | 3014 | |6;imaging-darkroom;150;147;148;148;146;148;147;146;146;147 06:04:03 INFO - PROCESS | 3014 | |7;imaging-desaturate;96;97;98;96;96;97;96;98;96;97 06:04:03 INFO - PROCESS | 3014 | |8;json-parse-financial;60;68;60;59;60;59;59;59;58;60 06:04:03 INFO - PROCESS | 3014 | |9;json-stringify-tinderbox;69;69;68;70;69;69;70;69;68;69 06:04:03 INFO - PROCESS | 3014 | |10;stanford-crypto-aes;86;86;87;87;86;86;86;95;88;86 06:04:03 INFO - PROCESS | 3014 | |11;stanford-crypto-ccm;124;122;129;125;121;124;134;134;119;123 06:04:03 INFO - PROCESS | 3014 | |12;stanford-crypto-pbkdf2;143;162;156;154;157;149;161;155;150;147 06:04:03 INFO - PROCESS | 3014 | |13;stanford-crypto-sha256-iterative;70;70;71;69;73;68;67;73;69;71 06:04:03 INFO - PROCESS | 3014 | __end_tp_report 06:04:03 INFO - PROCESS | 3014 | __start_cc_report 06:04:03 INFO - PROCESS | 3014 | _x_x_mozilla_cycle_collect,756 06:04:03 INFO - PROCESS | 3014 | __end_cc_report 06:04:03 INFO - PROCESS | 3014 | __startTimestamp1451829843256__endTimestamp 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | ------- Summary: start ------- 06:04:03 INFO - PROCESS | 3014 | Number of tests: 14 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.59 (4.1%) stddev-sans-first:4.85 06:04:03 INFO - PROCESS | 3014 | Values: 111.0 105.0 115.0 112.0 112.0 123.0 110.0 110.0 113.0 111.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.00 stddev:17.04 (11.2%) stddev-sans-first:18.06 06:04:03 INFO - PROCESS | 3014 | Values: 147.0 127.0 158.0 171.0 128.0 153.0 151.0 128.0 166.0 127.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.03 (1.9%) stddev-sans-first:3.22 06:04:03 INFO - PROCESS | 3014 | Values: 164.0 164.0 162.0 165.0 162.0 162.0 163.0 172.0 165.0 162.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#3] audio-fft Cycles:10 Average:80.10 Median:72.00 stddev:23.88 (33.2%) stddev-sans-first:25.15 06:04:03 INFO - PROCESS | 3014 | Values: 72.0 72.0 71.0 74.0 74.0 72.0 148.0 72.0 74.0 72.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:21.87 (22.8%) stddev-sans-first:22.67 06:04:03 INFO - PROCESS | 3014 | Values: 97.0 97.0 146.0 96.0 96.0 96.0 139.0 96.0 98.0 140.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:04:03 INFO - PROCESS | 3014 | Values: 110.0 110.0 109.0 110.0 109.0 111.0 109.0 110.0 109.0 109.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:0.87 06:04:03 INFO - PROCESS | 3014 | Values: 150.0 147.0 148.0 148.0 146.0 148.0 147.0 146.0 146.0 147.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 06:04:03 INFO - PROCESS | 3014 | Values: 96.0 97.0 98.0 96.0 96.0 97.0 96.0 98.0 96.0 97.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:2.82 (4.7%) stddev-sans-first:2.99 06:04:03 INFO - PROCESS | 3014 | Values: 60.0 68.0 60.0 59.0 60.0 59.0 59.0 59.0 58.0 60.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:04:03 INFO - PROCESS | 3014 | Values: 69.0 69.0 68.0 70.0 69.0 69.0 70.0 69.0 68.0 69.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.50 stddev:2.79 (3.2%) stddev-sans-first:2.92 06:04:03 INFO - PROCESS | 3014 | Values: 86.0 86.0 87.0 87.0 86.0 86.0 86.0 95.0 88.0 86.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:124.50 stddev:5.19 (4.2%) stddev-sans-first:5.48 06:04:03 INFO - PROCESS | 3014 | Values: 124.0 122.0 129.0 125.0 121.0 124.0 134.0 134.0 119.0 123.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:155.50 stddev:6.10 (3.9%) stddev-sans-first:5.17 06:04:03 INFO - PROCESS | 3014 | Values: 143.0 162.0 156.0 154.0 157.0 149.0 161.0 155.0 150.0 147.0 06:04:03 INFO - PROCESS | 3014 | 06:04:03 INFO - PROCESS | 3014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.97 (2.8%) stddev-sans-first:2.09 06:04:03 INFO - PROCESS | 3014 | Values: 70.0 70.0 71.0 69.0 73.0 68.0 67.0 73.0 69.0 71.0 06:04:03 INFO - PROCESS | 3014 | -------- Summary: end -------- 06:04:03 INFO - PROCESS | 3014 | 06:04:04 INFO - TEST-INFO | 3014: exit 0 06:04:04 INFO - TEST-OK | kraken | took 59926ms 06:04:04 INFO - TEST-START | v8_7 06:04:04 INFO - operating with platform_type : linux_ 06:04:04 INFO - Initialising browser for v8_7 test... 06:04:04 INFO - TEST-INFO | started process 3300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUf1Wg7/profile http://localhost:39494/getInfo.html) 06:04:08 INFO - PROCESS | 3300 | __metrics Screen width/height:1600/1200 06:04:08 INFO - PROCESS | 3300 | colorDepth:24 06:04:08 INFO - PROCESS | 3300 | Browser inner width/height: 1024/670 06:04:08 INFO - PROCESS | 3300 | __metrics 06:04:08 INFO - PROCESS | 3300 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:04:09 INFO - TEST-INFO | 3300: exit 0 06:04:09 INFO - Browser initialized. 06:04:09 INFO - Running cycle 1/1 for v8_7 test... 06:04:09 INFO - TEST-INFO | started process 3420 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUf1Wg7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:21 INFO - PROCESS | 3420 | RSS: Main: 151003136 06:04:21 INFO - PROCESS | 3420 | 06:04:42 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:39494/tests/v8_7/run.html (next: http://localhost:39494/tests/v8_7/run.html) 06:04:43 INFO - PROCESS | 3420 | RSS: Main: 145809408 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | __start_tp_report 06:04:43 INFO - PROCESS | 3420 | _x_x_mozilla_page_load 06:04:43 INFO - PROCESS | 3420 | _x_x_mozilla_page_load_details 06:04:43 INFO - PROCESS | 3420 | |i|pagename|runs| 06:04:43 INFO - PROCESS | 3420 | |0;Richards;168.86187098953056 06:04:43 INFO - PROCESS | 3420 | |1;DeltaBlue;189.6813353566009 06:04:43 INFO - PROCESS | 3420 | |2;Encrypt;280.0336040324839 06:04:43 INFO - PROCESS | 3420 | |3;Decrypt;5256.544502617801 06:04:43 INFO - PROCESS | 3420 | |4;RayTrace;1079.913606911447 06:04:43 INFO - PROCESS | 3420 | |5;Earley;707.4204946996466 06:04:43 INFO - PROCESS | 3420 | |6;Boyer;12304.878048780487 06:04:43 INFO - PROCESS | 3420 | |7;RegExp;25475 06:04:43 INFO - PROCESS | 3420 | |8;Splay;679.1044776119403 06:04:43 INFO - PROCESS | 3420 | |9;NavierStokes;4845.410628019324 06:04:43 INFO - PROCESS | 3420 | __end_tp_report 06:04:43 INFO - PROCESS | 3420 | __startTimestamp1451829883198__endTimestamp 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | ------- Summary: start ------- 06:04:43 INFO - PROCESS | 3420 | Number of tests: 10 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#0] Richards Cycles:1 Average:168.86 Median:168.86 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 168.9 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#1] DeltaBlue Cycles:1 Average:189.68 Median:189.68 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 189.7 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 280.0 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 5256.5 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 1079.9 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#5] Earley Cycles:1 Average:707.42 Median:707.42 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 707.4 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 12304.9 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 25475.0 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#8] Splay Cycles:1 Average:679.10 Median:679.10 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 679.1 06:04:43 INFO - PROCESS | 3420 | 06:04:43 INFO - PROCESS | 3420 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:04:43 INFO - PROCESS | 3420 | Values: 4845.4 06:04:43 INFO - PROCESS | 3420 | -------- Summary: end -------- 06:04:43 INFO - PROCESS | 3420 | 06:04:44 INFO - TEST-INFO | 3420: exit 0 06:04:44 INFO - TEST-OK | v8_7 | took 39839ms 06:04:44 INFO - SUITE-END | took 1210s 06:04:44 INFO - Completed test suite (00:20:10) 06:04:44 INFO - Working with test: dromaeo_css 06:04:44 INFO - Generating results file: dromaeo_css 06:04:44 INFO - Working with test: kraken 06:04:44 INFO - Generating results file: kraken 06:04:44 INFO - javascript benchmark 06:04:44 INFO - Working with test: v8_7 06:04:44 INFO - Generating results file: v8_7 06:04:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:04:44 INFO - process_Request line: dromaeo_css 6833.45 graph.html#tests=[[72,1,43]] 06:04:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:44 INFO - process_Request line: kraken 1531.20 graph.html#tests=[[232,1,43]] 06:04:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:44 INFO - process_Request line: v8_7 21013.57 graph.html#tests=[[230,1,43]] 06:04:44 INFO - RETURN: dromaeo_css: 6833.45 06:04:44 INFO - RETURN: kraken: 1531.20 06:04:44 INFO - RETURN: v8_7: 21013.57 06:04:44 INFO - javascript benchmark 06:04:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3156.479180935146, 3194.8083115013087, 3212.9036128916114, 3229.69317914798, 3246.123546642406, 5276.234945932847, 5392.379876314225, 5398.64908780929, 5406.67559946403, 5419.0, 5320.547753440953, 5382.0, 5429.918551221725, 5446.15584584389, 5448.591355648332, 4890.999999999991, 4922.310876477296, 4980.128477516439, 4989.0, 5000.299958005882, 4883.365162528884, 4942.505749425065, 4991.226359914219, 4992.825251116212, 5027.296178535008, 4774.379330687006, 4867.075255701406, 4867.2212446008825, 4902.436219834729, 4950.851474455736, 4879.6096312295285, 4886.364772579542, 4904.803807847682, 4906.362172917534, 4924.064427758714, 4843.927341089887, 4846.61227101831, 4861.416630004387, 4862.246351815475, 4896.534829191221, 5109.795608175668, 5164.0, 5167.741612919339, 5201.817936372209, 5231.398389185254, 5810.738516766755, 5852.795152169696, 5855.121731740231, 5888.499477544414, 5935.4361335673475, 5868.882622347529, 5905.586608937376, 5905.940940590582, 5907.054871220584, 5907.822765317047, 5351.357837059539, 5439.347278326626, 5444.210589464545, 5460.808871689472, 5478.123500239983, 5939.613925094855, 5942.405759424109, 5960.5827592068135, 6001.159837622737, 6044.486218671462, 5644.717764111778, 5704.286964129484, 5710.400407957105, 5721.5136713379, 5736.913946290809, 5688.63023903445, 5762.538996880239, 5802.564807639444, 5825.50483208932, 5839.240898683144, 5776.306843178845, 5777.62445441045, 5777.971110144423, 5779.3642699303045, 5782.277215348082, 5760.596758226884, 5808.506276966421, 5811.912821307684, 5812.505936995402, 5855.560832937462, 4427.911441771146, 4494.842680506166, 4497.617702495259, 4505.211587972091, 4537.0, 3908.296506628777, 3949.368101103867, 3985.9003524911527, 4010.8997275068355, 4030.7984600769846, 5401.810936617199, 5470.617056805985, 5487.478689524489, 5503.036968530491, 5512.173174023928, 5840.503557197686, 5851.824445266649, 5860.970695146497, 5864.912026319608, 5868.853278667982, 5358.6248962572245, 5443.891122177613, 5460.453954604508, 5501.394846566875, 5578.497935185853, 4921.581665558468, 4933.876653083702, 4934.555889969848, 4939.506049395031, 4954.108260513142, 5987.580869339192, 6009.978303688384, 6010.3689112643415, 6034.577579569388, 6045.486133678686, 5597.384287728428, 5714.285714285715, 5768.336641286306, 5863.061910094364, 5880.705964701662, 6040.033594624839, 6045.244344456943, 6056.878862422815, 6073.362296958756, 6079.3312735598165, 5585.609007369608, 5689.687067211343, 5707.714614269353, 5726.9713651431475, 5755.568332375173, 5803.187553742564, 5829.213056237354, 5899.528037756883, 5910.0, 5938.970305148447, 5725.484706376446, 5764.452377024176, 5772.04761214395, 5784.82645520635, 5786.479216870502, 5674.829755107354, 5757.424257574209, 5760.971195143998, 5782.681952492653, 5782.826515204551, 5544.168374743821, 5622.353429355677, 5701.686407247641, 5702.315722113373, 5752.194692742935, 5672.404397538199, 5700.657960522216, 5758.481736643722, 5764.250647415809, 5768.163616275533, 5459.590530710292, 5519.0, 5637.3235211774845, 5647.350554686263, 5648.689322087324], "unit": "score", "name": "dojo.html", "value": 5355.6162617133905}, {"lowerIsBetter": false, "replicates": [506.1597747738754, 522.5506064784284, 529.2194013829601, 544.7820871651342, 550.5760564365437, 35097.12257193572, 36414.453783193276, 36436.453453198155, 36444.27111457769, 36628.450573241425, 38587.61412385875, 38768.61231387685, 38915.416268755995, 38962.8051859741, 39146.60853391465, 8445.155484451552, 8518.914810851906, 8595.44129631575, 8603.139686031409, 8609.18212769789, 8405.873911891327, 8481.279091277249, 8543.786405339853, 8549.914500854975, 8553.529555874424, 8665.870011949826, 8740.8688869667, 8802.207801297882, 8818.470891746483, 8821.955890220572, 8599.312055035582, 8615.56922153893, 8662.783430414258, 8662.826743465095, 8706.0, 8545.871811922827, 8658.177473140042, 8671.219590236846, 8681.826363472695, 8696.652133914637, 39721.40417893734, 39981.20037599232, 40240.0, 40280.0, 40349.394759078634, 2571.2800415883585, 3022.486177349856, 3227.080282119608, 3352.664733526652, 3571.821408929543, 27552.311192220153, 27924.0, 28404.431911361862, 28485.85757071222, 28984.855075724485, 3672.4491326301, 3674.926501469956, 3677.632236776301, 3769.0765762388114, 3839.9808000960097, 216605.0, 220243.0, 220561.0, 220696.0, 221222.0, 55750.44249557453, 57143.14285285724, 58854.41145588575, 60661.09008364878, 62621.0, 55303.72348138234, 55654.0, 55738.44261557414, 55805.72097139488, 55998.0, 14660.340284687214, 14953.925230373778, 14974.775378369333, 15077.773833392508, 15101.924490377698, 11684.824727629093, 11739.413029348498, 11749.177557571058, 11750.823737643772, 11902.404879755977, 19465.51336216606, 19751.703724444145, 19795.406137815888, 19936.90031549833, 19995.0, 7837.843243135106, 8045.557494337868, 8164.183581641907, 8183.918160818434, 8184.0, 994.9502524873727, 1002.9498525073717, 1005.6228914157191, 1021.305512251676, 1051.8001579699833, 25478.617820732703, 25566.10518631839, 25829.870850646003, 25886.611700824502, 25899.352516187246, 1023.5394072667181, 1038.9428581428094, 1040.2406243442178, 1067.9733006674896, 1159.9710007249716, 13878.791818122736, 14293.142411455347, 16183.10992895402, 16195.0, 16368.099754513616, 388382.0, 391806.0, 393321.0, 394584.0, 394690.0, 52407.73796130995, 52584.0, 52662.0, 53024.46975530195, 53134.20298695523, 1303.9087263891436, 1317.9934100329438, 1336.084781924385, 1338.772408690525, 1349.015218890196, 28454.57318140188, 29440.558391623716, 29757.851210743807, 29782.404351912406, 30197.0, 44140.33789493224, 44787.328190077824, 44843.32735008912, 44978.100437991714, 45017.0, 303438.0, 303839.0, 304222.0, 304496.0, 305323.0, 30988.380232394775, 42057.57942420659, 43107.13785724205, 43257.78371108124, 43354.0, 44831.551684482736, 46145.76927115343, 46499.30251046169, 46651.635061966954, 47010.29484557666, 33188.0, 33790.66209337875, 33929.0, 34097.82951085229, 34330.0, 33859.3228135431, 35660.0, 35689.82155089208, 35742.64257357393, 35876.0, 34872.30255394929, 35431.291374172884, 35707.82146089253, 35747.28505429825, 35836.10409739777, 31501.684983149877, 32492.0, 32599.348013040082, 32848.83575582202, 32870.835645821615, 24734.876325618257, 25261.494770104862, 26502.0, 26519.204423867315, 26577.734222657527], "unit": "score", "name": "ext.html", "value": 18348.299567172926}, {"lowerIsBetter": false, "replicates": [355.16358974614775, 357.72812662376595, 360.8408384592887, 362.07309288222154, 362.19773202356777, 16101.436449724262, 17057.40299089532, 17265.39571115011, 17697.82302176978, 18437.17032733527, 12578.68553286166, 13241.801372979413, 13258.867411325884, 13877.653058673539, 16198.271077801497, 5021.723805190713, 5146.536811686948, 5150.562202212797, 5153.072446959546, 5160.303359046518, 5036.974815125919, 5068.8732781680565, 5091.770870310845, 5106.0, 5226.24219488174, 5107.846764597068, 5242.135047717122, 5282.920756188661, 5515.4760297771845, 5529.3364796224505, 5146.08897238098, 5204.609654275944, 5212.29633999409, 5233.188855727369, 5412.621116521845, 5254.395744489356, 5257.053730328539, 5257.658252213632, 5264.078786212397, 5274.604404669665, 12300.384980750927, 12327.506899724, 13333.866581346938, 13413.262270575115, 13425.12736672123, 2038.8572799904014, 2062.0, 2065.6901464780253, 2073.1810934680716, 2080.7191029211012, 9180.954095229481, 9301.813963720688, 9355.251579873662, 9619.27855410847, 9856.0, 1652.140886738889, 1707.1037705204742, 1728.4987353667548, 1761.4363403710818, 1784.0, 60433.69783151056, 61983.380166198214, 62353.0, 62405.37594624041, 62647.68676156636, 9971.401715896924, 10119.949400252952, 10200.846987295197, 10264.794704106025, 10289.485525723834, 13236.801447978289, 13331.533396331082, 13345.665433456577, 13352.198868067948, 13354.399052042487, 7674.347680447225, 7725.845483090419, 7763.9223607764325, 7768.689252429839, 7776.844463110706, 7562.357199638092, 7582.317591416799, 7611.764999875031, 7615.657295421719, 7672.769816905502, 4406.140802543473, 4428.756418396954, 4454.3986561813745, 4455.398521199661, 4483.282674772021, 1829.3048641516405, 1834.6147309065245, 1875.4373687893578, 1880.4640677406874, 1884.679604467244, 406.20384047267095, 826.442151547715, 933.5239028095584, 1009.9747506312401, 1013.7212266626736, 10065.798684026278, 10828.0, 11032.338059716443, 11121.27711698737, 11157.944210278896, 430.43182998441756, 431.2926800047924, 440.84129713303184, 451.2238949007702, 455.1761312025245, 5895.675737834375, 5968.46283834457, 6012.579119461596, 6089.786857459968, 6110.175126357974, 556456.0, 567776.0, 572944.0, 611533.0, 611773.0, 76857.61571192108, 80764.59617701874, 81495.59252203819, 81598.59200703958, 82438.58780706178, 485.3617492996698, 488.16523744396767, 490.4776413120016, 490.4923404276628, 491.70743407672376, 10135.442550659785, 10182.847257290998, 10192.745181370525, 10365.63720269787, 10399.272050956662, 32589.0, 32738.672613273564, 33274.500882486296, 33573.664263358034, 34270.314593708485, 42789.78605107079, 43761.78119109384, 45132.32301515545, 45149.32276015928, 46540.30189547092, 9179.082091790768, 9442.716718498456, 9522.0954009369, 9586.137247647745, 9589.424634521672, 11130.944345278222, 16958.152092395085, 17131.828681713025, 17809.376671816422, 17863.0, 13552.728945421233, 13781.931090344484, 14083.225422601856, 14569.708605828037, 14721.509939468137, 13976.301184940508, 14224.79089277423, 14385.208813515357, 14712.485063022743, 14888.032277901902, 14264.358103885557, 14347.497837575635, 14577.85422145765, 15116.773248401063, 15163.545093646768, 9426.387284826738, 9504.714858554255, 9614.759631009281, 9735.513224338896, 9789.706308810748, 10805.621803237163, 14574.0, 14777.482788102365, 15288.847111528743, 15481.84518154804], "unit": "score", "name": "jquery.html", "value": 7995.396329295111}, {"lowerIsBetter": false, "replicates": [1450.1154295879514, 1460.0947412604185, 1610.3397606981132, 1764.7264673975537, 1769.4249368955077, 6862.519623626348, 6987.965060174692, 7571.6592753326095, 7657.0, 7747.728829490962, 7145.285471452852, 7302.233265507111, 7504.737334193304, 7596.0, 7630.809229769258, 2170.1427935965244, 2190.496185877249, 2207.9889600551974, 2216.5345277491665, 2217.0688310909377, 2208.315422219109, 2227.3652009177385, 2229.342344008521, 2235.519363336882, 2257.6162052451123, 2147.860389074713, 2181.0730439563204, 2183.017642061071, 2215.0475295622878, 2229.442639340165, 2161.0, 2197.571473562656, 2200.1309482754223, 2202.4603972026957, 2204.900779464928, 2144.3674116135776, 2177.542716029636, 2185.0, 2194.3855720398315, 2195.7255343082115, 7644.655990480442, 7656.770296891103, 7663.463557550974, 7674.884876726854, 7704.65329060188, 4370.191514569783, 4410.823567057314, 4414.536473670282, 4417.668674849399, 4421.07157496926, 2848.8575571221563, 2850.315924178203, 2888.277930517371, 2905.2010697058267, 2913.2279945814375, 928.9024652411534, 941.5574679900436, 952.8332541805156, 956.3305686019814, 989.2135752077116, 9620.951895240549, 9623.422594644273, 9659.517024148765, 9665.758356041086, 9676.371035882716, 3897.376419772879, 4011.5988401160234, 4028.436018957348, 4029.4157347185082, 4073.348264277701, 8661.696840610548, 8673.826523469495, 8709.0, 8743.56282185888, 8748.34387420946, 4595.379623750818, 4616.030633566921, 4637.675362724577, 4638.327442520816, 4644.465886423037, 4014.739041962263, 4050.8784736457956, 4102.220578090153, 4290.099079193405, 4297.871063868027, 3139.6232452105437, 3182.379436009956, 3198.2324242182176, 3237.4981877808978, 3254.723348515355, 980.8822941246954, 991.3358050106445, 992.34009383759, 999.6301368493704, 1012.4735137728487, 1247.5758242197514, 1292.75437666843, 1298.1691717300935, 1306.4447609766003, 1311.5016293808292, 6657.40083392497, 6939.479539034593, 6977.1278590176225, 6977.860442791217, 6983.336583024605, 445.5010388365052, 449.77736020669977, 456.7510706664876, 457.72307753809133, 457.922153233951, 5394.379646340721, 5407.297051383373, 5414.052540805422, 5440.564754819605, 5446.618736688473, 9032.819343613091, 9044.81910361789, 9212.907870921204, 9291.76770580741, 9371.531423428802, 9146.451212927246, 9152.222061124747, 9230.446173229628, 9246.121618446237, 9276.443413395218, 6964.651767411609, 7110.893336599956, 7117.181524124792, 7197.532160409557, 7377.9631101845225, 7208.387287080657, 7214.350708436056, 7244.601546914971, 7258.564486130849, 7286.599237042014, 8021.6791328348545, 8122.837543248984, 8184.140665230303, 8186.54973976437, 8317.584120793816, 8138.552379618941, 8341.290990265896, 8364.581770911553, 8402.621882015203, 8475.194856488624, 6577.177852768404, 6585.275619681927, 6585.341465853568, 6667.133272674521, 6759.966200168968, 7189.676464559212, 7198.964005179941, 7201.13586369639, 7229.710811567478, 7234.74678386254, 6647.734090636513, 6686.030525573862, 6699.665016749045, 6776.525643204928, 6791.796246112624, 6657.900131497934, 6712.160979877515, 6759.222689390783, 6844.555103918229, 6848.452123829982, 6704.396604305636, 6728.259891411843, 6779.084823548757, 6786.0, 6786.8642627148165, 5922.851928701644, 5938.465538101592, 5957.731902064331, 5965.463108320272, 6061.818145455643, 6196.81409557714, 6240.500759939285, 6245.469135123565, 6245.500359971283, 6248.281447633399], "unit": "score", "name": "mootools.html", "value": 4215.602772467553}, {"lowerIsBetter": false, "replicates": [324.30113106256, 325.1286552040532, 337.73487812067515, 342.58889332800635, 349.5752660517472, 6164.260288765348, 6173.50611951044, 6200.689965501718, 6258.968705156479, 6344.333844946272, 6186.195794546703, 6187.876242475148, 6201.782937597185, 6219.595726277788, 6235.563510554263, 4764.976175119137, 4765.0, 4772.379590653228, 4772.665913386064, 4773.0, 4776.94907120433, 4780.426348838144, 4784.234522476405, 4792.472827988936, 4798.448178459469, 4545.590896819285, 4623.953760462403, 4638.5593368629925, 4653.6509761768, 4691.835785747482, 4605.401297831294, 4628.421447319085, 4645.094206629708, 4651.488336283006, 4654.115718013567, 4009.6190861868076, 4013.478247827793, 4021.9743965288662, 4037.4347591337237, 4041.211963667086, 5872.031114866042, 5904.2029326040865, 5911.881762364772, 5919.319278283009, 5933.465988061095, 5320.0, 5329.760160792774, 5401.459854014567, 5476.945230547723, 5503.559715222773, 6558.573692710006, 6560.507961902877, 6574.112494813235, 6584.0, 6602.60384376939, 4516.458025037016, 4520.50274469808, 4520.909581808345, 4540.18276710192, 4543.5456454354635, 6761.154855643044, 6824.7952561423235, 6880.380765731058, 6887.862242755167, 6896.862062758717, 4653.395058642423, 4653.674242803039, 4655.4180727409075, 4663.51033141522, 4667.439907211156, 4705.011947490997, 4712.481627021025, 4713.717176969393, 4725.196716558194, 4725.574698277172, 5477.3427188737605, 5479.863003424946, 5481.917771233435, 5488.643238189505, 5497.945020549823, 6440.259370172396, 6631.86736265272, 6647.567908085959, 6650.268470468244, 6668.033135195369, 1658.4361317152227, 1676.5054308978881, 1676.9016294327234, 1680.252287731972, 1680.5546530169515, 1116.1015382617072, 1117.2067831839322, 1127.0814286356592, 1130.8190689489643, 1138.345451365468, 6244.2819075806865, 6244.469220116341, 6264.812055638338, 6264.9373506265265, 6271.874562508724, 6798.2182049064, 6806.387425131762, 6816.386525212754, 6826.624535650587, 6829.863402731918, 6155.861165684273, 6257.530685198537, 6275.623462592259, 6278.686065696788, 6290.654014029181, 3724.0689827543115, 3736.3461394255896, 3747.3067482515276, 3759.2105657811617, 3760.887173384748, 7236.204017558064, 7260.891086633705, 7261.5280006799385, 7270.8182295441975, 7280.0535930328715, 6937.583744975318, 7014.22843487216, 7059.8235044123285, 7067.293270672892, 7083.716651333889, 7218.205997340288, 7220.638968051681, 7224.566526008456, 7225.674844632004, 7227.5302105364035, 6836.042953986545, 6853.485988550979, 6861.897071543831, 6873.518853680194, 6952.0, 6655.101561289164, 6811.386975172259, 6834.2140653825445, 6836.38472537474, 6845.247022827584, 7172.0, 7199.388052015637, 7203.603801790742, 7226.096737907762, 7254.0, 4798.640101992295, 4823.734694591831, 4827.637927155407, 4835.0, 4850.95149048505, 6685.197776266879, 6807.5575087619145, 6813.1142951415995, 6830.326569990384, 6840.623765692934, 6618.536702430783, 6639.3692599203, 6639.634820084942, 6657.4674026078765, 6657.966710166418, 6409.230892292768, 6633.2040155181685, 6636.13730215069, 6642.070110184482, 6642.76750313756, 6486.902696459462, 6496.603230305318, 6507.0, 6507.479401647952, 6512.381323774234, 6598.934010659832, 6644.966775166094, 6656.7004484797335, 6669.666516674244, 6671.733130674718, 6321.652309123042, 6437.7103030362805, 6454.290028097, 6465.321141280097, 6496.967515162583], "unit": "score", "name": "prototype.html", "value": 4978.580663899882}, {"lowerIsBetter": false, "replicates": [718.9856202875943, 720.1753991679527, 730.8465222303317, 747.6859718918054, 785.3991696352291, 13755.656108597277, 13833.17000979942, 13988.160710357373, 14027.08823926444, 14038.087524310926, 12979.545715899945, 13075.346232688375, 13086.607401777937, 13101.08292419531, 13110.73778524429, 803.317180396664, 806.2018601584418, 826.8428998490298, 829.7884039569932, 829.9626516806728, 818.8567000774871, 819.5574389829485, 823.7940514871282, 824.6536454689045, 825.4304529874368, 861.7242482405633, 865.8657908024267, 867.3798234262501, 869.9652013919467, 870.8476016697084, 849.0957130655862, 853.5988085599789, 856.2293935458075, 858.9226969572768, 859.4499520307008, 630.4294613374904, 631.7062565906875, 632.1245075570322, 632.3423639415049, 635.3551145587232, 12735.936320318431, 12851.614451566467, 12859.42132604035, 12874.806877896839, 12878.484860605564, 11073.557057717682, 11270.380129092897, 11424.200305978586, 11581.36302503362, 11912.880871191264, 10161.59353625854, 10173.694789156338, 10248.48757562119, 10648.094911932494, 10749.946250268777, 3487.424574945131, 3564.324767359337, 3589.784612923233, 3624.855005799765, 3677.007208053837, 46624.300635490494, 47319.76340118312, 47653.28520072201, 47731.28403073957, 47760.28359574609, 8653.956730216309, 8674.95900491945, 8696.565171741388, 8777.51723655205, 8798.16417440355, 17505.7374139388, 17755.15917453201, 17792.11039448048, 17804.821951780315, 17812.91093544524, 7295.781126566211, 7469.887951680729, 7514.9624251878395, 7550.3582195514, 7754.844903101906, 4193.1404062167185, 4209.137126888981, 4258.53156152823, 4271.786410679453, 4295.484541854998, 2812.943741125166, 2847.5586284125993, 2848.7720982321366, 2862.3845873137375, 2870.9712902870706, 531.5614617940215, 540.4757385336218, 544.0207626272693, 550.8127236739527, 551.1017042221154, 530.0591450175968, 565.8726786473093, 617.8887800196007, 631.9431251187415, 650.5153660522847, 8598.312135029182, 8833.160849719266, 8864.157904999014, 8933.59798809055, 9137.63449462014, 521.7521677203298, 540.6431755041654, 626.9655168965751, 696.061444054433, 698.0401947322432, 3832.9616703833162, 3892.5134358205223, 3939.684825213976, 3965.147493288957, 4155.854545090907, 52560.37198140078, 58189.70905145447, 58689.706551467825, 58809.0, 58973.70513147407, 51783.22325165125, 51885.22172167421, 52044.47955520472, 53431.46568534265, 53696.0, 47232.52767472281, 47272.290915636295, 47696.28455573169, 47786.0, 47801.0, 8535.359848011549, 8603.870941935751, 8672.089430609694, 8699.521526316114, 8752.21230089295, 32480.187995300308, 32546.349073018882, 32657.34685306328, 32663.673363267015, 33122.33755324928, 42530.362044568734, 44261.77869110634, 44754.3286850691, 44801.55198447974, 45120.0, 9718.70843874685, 10029.849552256868, 10234.948825255826, 10467.581296748045, 10780.29928054674, 10936.835947460635, 10988.285761425483, 11089.50097245642, 11320.830187547359, 11437.199396042197, 9973.102420782165, 10361.171106311327, 10372.740681483023, 10387.94806025965, 11794.46924888365, 9975.900240997496, 10098.293119481566, 10172.643957461749, 10401.8557958626, 11034.503447345049, 11482.712932176762, 11717.238379505305, 11917.16579839403, 12096.45565949552, 12262.938685306517, 9222.95388523053, 9953.832131251336, 10041.799164016826, 10152.492375381054, 10286.2799604027, 9502.524873756423, 9711.0, 9762.560684769345, 9865.358751681119, 10192.0], "unit": "score", "name": "yui.html", "value": 6174.368900985474}], "name": "dromaeo_css", "value": 6833.453362515397}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 115.0, 112.0, 112.0, 123.0, 110.0, 110.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [147.0, 127.0, 158.0, 171.0, 128.0, 153.0, 151.0, 128.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 162.0, 165.0, 162.0, 162.0, 163.0, 172.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 74.0, 74.0, 72.0, 148.0, 72.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 146.0, 96.0, 96.0, 96.0, 139.0, 96.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 111.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 148.0, 148.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 98.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 68.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 58.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 70.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 87.0, 86.0, 86.0, 86.0, 95.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 129.0, 125.0, 121.0, 124.0, 134.0, 134.0, 119.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [143.0, 162.0, 156.0, 154.0, 157.0, 149.0, 161.0, 155.0, 150.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 69.0, 73.0, 68.0, 67.0, 73.0, 69.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1531.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.86187098953056], "unit": "score", "name": "Richards", "value": 209.058444}, {"lowerIsBetter": false, "replicates": [189.6813353566009], "unit": "score", "name": "DeltaBlue", "value": 348.57409599999994}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [707.4204946996466], "unit": "score", "name": "Earley", "value": 942.1030419580425}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [679.1044776119403], "unit": "score", "name": "Splay", "value": 119.9977362637363}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21013.56899248081}]} 06:04:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21013.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1531.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6833.45"}}} 06:04:44 INFO - Return code: 0 06:04:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:04:44 INFO - # TBPL SUCCESS # 06:04:44 INFO - Running post-action listener: _resource_record_post_action 06:04:44 INFO - Running post-run listener: _resource_record_post_run 06:04:45 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 32768; Write bytes: 556892160; Read time: 336; Write time: 429532 06:04:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 235454464; Read time: 76; Write time: 233688 06:04:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 28672; Write bytes: 321437696; Read time: 260; Write time: 195844 06:04:45 INFO - Running post-run listener: _upload_blobber_files 06:04:45 INFO - Blob upload gear active. 06:04:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:04:45 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 06:04:45 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'] 06:04:45 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 06:04:46 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:46 INFO - (blobuploader) - INFO - Done attempting. 06:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:47 INFO - (blobuploader) - INFO - Done attempting. 06:04:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:47 INFO - Return code: 0 06:04:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:04:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e654c1b0d1aa241b22cf4c8271d0cee46608891cd03fda73ded77cd10044a4bdaafca3d5415768c3ebc99ea9234a1625af8be16954bfdacda85d6df0eacabc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c48a32c91818acad854102552b26d74ec6e15dc44e5c7b5b249281fba46e91181f878c6b4009474d6c65638636fca9ed8dcc7704f48ea2fcf5ec595e8e1bd7f1"} 06:04:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:04:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:04:47 INFO - Contents: 06:04:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e654c1b0d1aa241b22cf4c8271d0cee46608891cd03fda73ded77cd10044a4bdaafca3d5415768c3ebc99ea9234a1625af8be16954bfdacda85d6df0eacabc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c48a32c91818acad854102552b26d74ec6e15dc44e5c7b5b249281fba46e91181f878c6b4009474d6c65638636fca9ed8dcc7704f48ea2fcf5ec595e8e1bd7f1"} 06:04:47 INFO - Copying logs to upload dir... 06:04:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.545260 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-03 06:04:47.530627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 06:04:47.534995) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 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/7e654c1b0d1aa241b22cf4c8271d0cee46608891cd03fda73ded77cd10044a4bdaafca3d5415768c3ebc99ea9234a1625af8be16954bfdacda85d6df0eacabc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c48a32c91818acad854102552b26d74ec6e15dc44e5c7b5b249281fba46e91181f878c6b4009474d6c65638636fca9ed8dcc7704f48ea2fcf5ec595e8e1bd7f1"} build_url:https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/AJU-n2ZlThmC9_TiOF1uHQ/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/7e654c1b0d1aa241b22cf4c8271d0cee46608891cd03fda73ded77cd10044a4bdaafca3d5415768c3ebc99ea9234a1625af8be16954bfdacda85d6df0eacabc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c48a32c91818acad854102552b26d74ec6e15dc44e5c7b5b249281fba46e91181f878c6b4009474d6c65638636fca9ed8dcc7704f48ea2fcf5ec595e8e1bd7f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 06:04:47.565856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 06:04:47.566391) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1451822225.840551-612236706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 06:04:47.647460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 06:04:47.647815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 06:04:47.648173) ========= ========= Total master_lag: 0.28 =========