builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1451137464.71 results: success (0) buildid: 20151226030212 builduid: bed3a79fb5fd49cea77d679664efff83 revision: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.707038) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.707418) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.707712) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006331 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.737701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.737982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.831403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.831656) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.888771) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.889063) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.889429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:24.889968) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 05:44:25-- 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% 215M=0s 2015-12-26 05:44:25 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177169 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:25.096229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:25.096587) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014552 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:25.149164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-26 05:44:25.149540) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 05:44:26,047 truncating revision to first 12 chars 2015-12-26 05:44:26,047 Setting DEBUG logging. 2015-12-26 05:44:26,047 attempt 1/10 2015-12-26 05:44:26,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a559a618d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 05:44:27,383 unpacking tar archive at: mozilla-central-4a559a618d67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-26 05:44:26.790411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:26.790778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:26.800059) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:26.800407) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 05:44:26.800860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-26 05:44:26.801184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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', '--system-bits', '64', '--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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:27 INFO - MultiFileLogger online at 20151226 05:44:27 in /builds/slave/test-pgo 05:44:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:44:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:44:27 INFO - {'append_to_log': False, 05:44:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:44:27 INFO - 'blob_upload_branch': 'Firefox', 05:44:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:44:27 INFO - 'branch': 'Firefox', 05:44:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:27 INFO - 'config_files': ('talos/linux_config.py',), 05:44:27 INFO - 'default_actions': ('clobber', 05:44:27 INFO - 'read-buildbot-config', 05:44:27 INFO - 'download-and-extract', 05:44:27 INFO - 'populate-webroot', 05:44:27 INFO - 'create-virtualenv', 05:44:27 INFO - 'install', 05:44:27 INFO - 'run-tests'), 05:44:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:27 INFO - 'download_minidump_stackwalk': True, 05:44:27 INFO - 'download_symbols': 'ondemand', 05:44:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:27 INFO - 'installer_path': 'installer.exe', 05:44:27 INFO - 'log_level': 'info', 05:44:27 INFO - 'log_name': 'talos', 05:44:27 INFO - 'log_to_console': True, 05:44:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:27 INFO - 'opt_config_files': (), 05:44:27 INFO - 'pip_index': False, 05:44:27 INFO - 'sps_profile': False, 05:44:27 INFO - 'sps_profile_interval': 0, 05:44:27 INFO - 'suite': 'dromaeojs-e10s', 05:44:27 INFO - 'system_bits': '64', 05:44:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:27 INFO - 'title': 'talos-linux64-ix-035', 05:44:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:27 INFO - 'use_talos_json': True, 05:44:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:44:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:27 INFO - 'work_dir': 'build'} 05:44:27 INFO - ##### 05:44:27 INFO - ##### Running clobber step. 05:44:27 INFO - ##### 05:44:27 INFO - Running pre-action listener: _resource_record_pre_action 05:44:27 INFO - Running main action method: clobber 05:44:27 INFO - rmtree: /builds/slave/test-pgo/build 05:44:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:44:28 INFO - Running post-action listener: _resource_record_post_action 05:44:28 INFO - ##### 05:44:28 INFO - ##### Running read-buildbot-config step. 05:44:28 INFO - ##### 05:44:28 INFO - Running pre-action listener: _resource_record_pre_action 05:44:28 INFO - Running main action method: read_buildbot_config 05:44:28 INFO - Using buildbot properties: 05:44:28 INFO - { 05:44:28 INFO - "project": "", 05:44:28 INFO - "product": "firefox", 05:44:28 INFO - "script_repo_revision": "production", 05:44:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:44:28 INFO - "repository": "", 05:44:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:44:28 INFO - "buildid": "20151226030212", 05:44:28 INFO - "stage_platform": "linux64-pgo", 05:44:28 INFO - "basedir": "/builds/slave/test-pgo", 05:44:28 INFO - "nightly_build": "True", 05:44:28 INFO - "buildnumber": 596, 05:44:28 INFO - "slavename": "talos-linux64-ix-035", 05:44:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:44:28 INFO - "platform": "ubuntu64_hw", 05:44:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:28 INFO - "branch": "mozilla-central", 05:44:28 INFO - "repo_path": "mozilla-central", 05:44:28 INFO - "revision": "4a559a618d6798eb9a8fdc559f5a7a00085e2062", 05:44:28 INFO - "pgo_build": "True", 05:44:28 INFO - "builduid": "bed3a79fb5fd49cea77d679664efff83", 05:44:28 INFO - "slavebuilddir": "test" 05:44:28 INFO - } 05:44:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:44:28 INFO - Running post-action listener: _resource_record_post_action 05:44:28 INFO - ##### 05:44:28 INFO - ##### Running download-and-extract step. 05:44:28 INFO - ##### 05:44:28 INFO - Running pre-action listener: _resource_record_pre_action 05:44:28 INFO - Running main action method: download_and_extract 05:44:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:44:28 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:28 INFO - https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/test_packages.json 05:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/test_packages.json 05:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:44:33 INFO - Downloaded 1302 bytes. 05:44:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:44:33 INFO - Using the following test package requirements: 05:44:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'jsshell-linux-x86_64.zip'], 05:44:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:33 INFO - https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:44 INFO - Downloaded 23191462 bytes. 05:44:44 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:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:44 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:44:45 INFO - Return code: 0 05:44:45 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:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:45 INFO - https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:46 INFO - Downloaded 23191462 bytes. 05:44:46 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:44:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:46 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:44:48 INFO - Return code: 0 05:44:48 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:48 INFO - https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:49 INFO - Downloaded 11132270 bytes. 05:44:49 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:44:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:49 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:44:49 INFO - Return code: 0 05:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:49 INFO - https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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:44:50 INFO - Downloaded 54921457 bytes. 05:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:50 INFO - mkdir: /builds/slave/test-pgo/properties 05:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:44:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:44:50 INFO - Contents: 05:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:50 INFO - Running post-action listener: _resource_record_post_action 05:44:50 INFO - Running post-action listener: set_extra_try_arguments 05:44:50 INFO - ##### 05:44:50 INFO - ##### Running populate-webroot step. 05:44:50 INFO - ##### 05:44:50 INFO - Running pre-action listener: _resource_record_pre_action 05:44:50 INFO - Running main action method: populate_webroot 05:44:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:50 INFO - '--tppagecycles', 05:44:50 INFO - '7'], 05:44:50 INFO - 'tests': ['tsvgm']}}, 05:44:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:44:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'tests': ['damp', 'tps']}, 05:44:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['damp', 'tps']}, 05:44:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:44:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:50 INFO - 'other': {'tests': ['a11yr', 05:44:50 INFO - 'ts_paint', 05:44:50 INFO - 'tpaint', 05:44:50 INFO - 'sessionrestore', 05:44:50 INFO - 'sessionrestore_no_auto_restore']}, 05:44:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['a11yr', 05:44:50 INFO - 'ts_paint', 05:44:50 INFO - 'tpaint', 05:44:50 INFO - 'sessionrestore', 05:44:50 INFO - 'sessionrestore_no_auto_restore']}, 05:44:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['a11yr', 05:44:50 INFO - 'ts_paint', 05:44:50 INFO - 'tpaint', 05:44:50 INFO - 'sessionrestore', 05:44:50 INFO - 'sessionrestore_no_auto_restore']}, 05:44:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['a11yr', 05:44:50 INFO - 'ts_paint', 05:44:50 INFO - 'tpaint', 05:44:50 INFO - 'sessionrestore', 05:44:50 INFO - 'sessionrestore_no_auto_restore']}, 05:44:50 INFO - 'other_l64': {'tests': ['a11yr', 05:44:50 INFO - 'ts_paint', 05:44:50 INFO - 'tpaint', 05:44:50 INFO - 'sessionrestore', 05:44:50 INFO - 'sessionrestore_no_auto_restore']}, 05:44:50 INFO - 'other_nol64': {'tests': ['a11yr', 05:44:50 INFO - 'ts_paint', 05:44:50 INFO - 'tpaint', 05:44:50 INFO - 'sessionrestore', 05:44:50 INFO - 'sessionrestore_no_auto_restore']}, 05:44:50 INFO - 'svgr': {'tests': ['tsvgx', 05:44:50 INFO - 'tsvgr_opacity', 05:44:50 INFO - 'tart', 05:44:50 INFO - 'tscrollx', 05:44:50 INFO - 'cart']}, 05:44:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['tsvgx', 05:44:50 INFO - 'tsvgr_opacity', 05:44:50 INFO - 'tart', 05:44:50 INFO - 'tscrollx', 05:44:50 INFO - 'cart']}, 05:44:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'tests': ['tp5o']}, 05:44:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'talos_options': ['--e10s'], 05:44:50 INFO - 'tests': ['tp5o']}, 05:44:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'talos_options': ['--xperf_path', 05:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:50 INFO - 'tests': ['tp5n']}, 05:44:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:50 INFO - 'talos_options': ['--e10s', 05:44:50 INFO - '--xperf_path', 05:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:50 INFO - 'tests': ['tp5n']}}, 05:44:50 INFO - 'talos.zip': {'path': '', 05:44:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:50 INFO - Running post-action listener: _resource_record_post_action 05:44:50 INFO - ##### 05:44:50 INFO - ##### Running create-virtualenv step. 05:44:50 INFO - ##### 05:44:50 INFO - Running pre-action listener: _resource_record_pre_action 05:44:50 INFO - Running main action method: create_virtualenv 05:44:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:44:50 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:44:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:44:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:50 INFO - Using real prefix '/usr' 05:44:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:44:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:53 INFO - Installing pip.................done. 05:44:53 INFO - Return code: 0 05:44:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:44:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:53 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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:53 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:44:53 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:44:53 INFO - Using env: {'DISPLAY': ':0', 05:44:53 INFO - 'HOME': '/home/cltbld', 05:44:53 INFO - 'LANG': 'en_US.UTF-8', 05:44:53 INFO - 'LANGUAGE': 'en_US:en', 05:44:53 INFO - 'LOGNAME': 'cltbld', 05:44:53 INFO - 'MAIL': '/var/mail/cltbld', 05:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:53 INFO - 'MOZ_NO_REMOTE': '1', 05:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:53 INFO - 'NO_EM_RESTART': '1', 05:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:53 INFO - 'SHELL': '/bin/bash', 05:44:53 INFO - 'SHLVL': '1', 05:44:53 INFO - 'TERM': 'linux', 05:44:53 INFO - 'TMOUT': '86400', 05:44:53 INFO - 'USER': 'cltbld', 05:44:53 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:53 INFO - '_': '/tools/buildbot/bin/python'} 05:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:53 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:44:53 INFO - Cleaning up... 05:44:53 INFO - Return code: 0 05:44:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:44:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:53 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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:53 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:44:53 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:44:53 INFO - Using env: {'DISPLAY': ':0', 05:44:53 INFO - 'HOME': '/home/cltbld', 05:44:53 INFO - 'LANG': 'en_US.UTF-8', 05:44:53 INFO - 'LANGUAGE': 'en_US:en', 05:44:53 INFO - 'LOGNAME': 'cltbld', 05:44:53 INFO - 'MAIL': '/var/mail/cltbld', 05:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:53 INFO - 'MOZ_NO_REMOTE': '1', 05:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:53 INFO - 'NO_EM_RESTART': '1', 05:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:53 INFO - 'SHELL': '/bin/bash', 05:44:53 INFO - 'SHLVL': '1', 05:44:53 INFO - 'TERM': 'linux', 05:44:53 INFO - 'TMOUT': '86400', 05:44:53 INFO - 'USER': 'cltbld', 05:44:53 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:53 INFO - '_': '/tools/buildbot/bin/python'} 05:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:53 INFO - Downloading/unpacking psutil>=0.7.1 05:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:44:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:44:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:44:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:55 INFO - Installing collected packages: psutil 05:44:55 INFO - Running setup.py install for psutil 05:44:55 INFO - building 'psutil._psutil_linux' extension 05:44:55 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:44:55 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:44:55 INFO - building 'psutil._psutil_posix' extension 05:44:55 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:44:55 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:44:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:55 INFO - Successfully installed psutil 05:44:55 INFO - Cleaning up... 05:44:55 INFO - Return code: 0 05:44:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:44: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:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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', '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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:44: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 mozsystemmonitor==0.0.0 05:44:55 INFO - Using env: {'DISPLAY': ':0', 05:44:55 INFO - 'HOME': '/home/cltbld', 05:44:55 INFO - 'LANG': 'en_US.UTF-8', 05:44:55 INFO - 'LANGUAGE': 'en_US:en', 05:44:55 INFO - 'LOGNAME': 'cltbld', 05:44:55 INFO - 'MAIL': '/var/mail/cltbld', 05:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:55 INFO - 'MOZ_NO_REMOTE': '1', 05:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:55 INFO - 'NO_EM_RESTART': '1', 05:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:55 INFO - 'SHELL': '/bin/bash', 05:44:55 INFO - 'SHLVL': '1', 05:44:55 INFO - 'TERM': 'linux', 05:44:55 INFO - 'TMOUT': '86400', 05:44:55 INFO - 'USER': 'cltbld', 05:44:55 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:55 INFO - '_': '/tools/buildbot/bin/python'} 05:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:44:57 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:57 INFO - Installing collected packages: mozsystemmonitor 05:44:57 INFO - Running setup.py install for mozsystemmonitor 05:44:57 INFO - Successfully installed mozsystemmonitor 05:44:57 INFO - Cleaning up... 05:44:58 INFO - Return code: 0 05:44:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:44: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:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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', '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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:44: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 blobuploader==1.2.4 05:44:58 INFO - Using env: {'DISPLAY': ':0', 05:44:58 INFO - 'HOME': '/home/cltbld', 05:44:58 INFO - 'LANG': 'en_US.UTF-8', 05:44:58 INFO - 'LANGUAGE': 'en_US:en', 05:44:58 INFO - 'LOGNAME': 'cltbld', 05:44:58 INFO - 'MAIL': '/var/mail/cltbld', 05:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:58 INFO - 'MOZ_NO_REMOTE': '1', 05:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:58 INFO - 'NO_EM_RESTART': '1', 05:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:58 INFO - 'SHELL': '/bin/bash', 05:44:58 INFO - 'SHLVL': '1', 05:44:58 INFO - 'TERM': 'linux', 05:44:58 INFO - 'TMOUT': '86400', 05:44:58 INFO - 'USER': 'cltbld', 05:44:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:58 INFO - '_': '/tools/buildbot/bin/python'} 05:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:44: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:44: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: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:44: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:44: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:44: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:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:59 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:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:59 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:59 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:59 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:59 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:59 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:59 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:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45: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:45: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:45: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:45: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:45: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:45: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:45:00 INFO - Downloading docopt-0.6.1.tar.gz 05:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:00 INFO - Running setup.py install for blobuploader 05:45:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:00 INFO - Running setup.py install for requests 05:45:01 INFO - Running setup.py install for docopt 05:45:01 INFO - Successfully installed blobuploader requests docopt 05:45:01 INFO - Cleaning up... 05:45:01 INFO - Return code: 0 05:45:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:01 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:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:01 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:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:01 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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:45:01 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:45:01 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:45:01 INFO - Using env: {'DISPLAY': ':0', 05:45:01 INFO - 'HOME': '/home/cltbld', 05:45:01 INFO - 'LANG': 'en_US.UTF-8', 05:45:01 INFO - 'LANGUAGE': 'en_US:en', 05:45:01 INFO - 'LOGNAME': 'cltbld', 05:45:01 INFO - 'MAIL': '/var/mail/cltbld', 05:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:01 INFO - 'MOZ_NO_REMOTE': '1', 05:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:01 INFO - 'NO_EM_RESTART': '1', 05:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:01 INFO - 'SHELL': '/bin/bash', 05:45:01 INFO - 'SHLVL': '1', 05:45:01 INFO - 'TERM': 'linux', 05:45:01 INFO - 'TMOUT': '86400', 05:45:01 INFO - 'USER': 'cltbld', 05:45:01 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:01 INFO - '_': '/tools/buildbot/bin/python'} 05:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:01 INFO - Running setup.py (path:/tmp/pip-HI5doU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:01 INFO - Running setup.py (path:/tmp/pip-0YgGrO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:01 INFO - Running setup.py (path:/tmp/pip-j_nyhg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:01 INFO - Running setup.py (path:/tmp/pip-uqqe6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:01 INFO - Running setup.py (path:/tmp/pip-6PH2ih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:01 INFO - Running setup.py (path:/tmp/pip-xnlYU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:01 INFO - Running setup.py (path:/tmp/pip-_V1e1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:01 INFO - Running setup.py (path:/tmp/pip-e9TFXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:01 INFO - Running setup.py (path:/tmp/pip-4jvzqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:02 INFO - Running setup.py (path:/tmp/pip-IDzoVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:02 INFO - Running setup.py (path:/tmp/pip-vrzgcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:02 INFO - Running setup.py (path:/tmp/pip-d0oVtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:02 INFO - Running setup.py (path:/tmp/pip-OmqL6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:02 INFO - Running setup.py (path:/tmp/pip-kCcOnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:02 INFO - Running setup.py (path:/tmp/pip-hOdV7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:02 INFO - Running setup.py (path:/tmp/pip-Gi9a7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:02 INFO - Running setup.py (path:/tmp/pip-N00N93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:02 INFO - Running setup.py install for manifestparser 05:45:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:02 INFO - Running setup.py install for mozcrash 05:45:02 INFO - Running setup.py install for mozdebug 05:45:02 INFO - Running setup.py install for mozdevice 05:45:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for mozfile 05:45:03 INFO - Running setup.py install for mozhttpd 05:45:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for mozinfo 05:45:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for mozInstall 05:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for mozleak 05:45:03 INFO - Running setup.py install for mozlog 05:45:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for moznetwork 05:45:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for mozprocess 05:45:03 INFO - Running setup.py install for mozprofile 05:45:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:03 INFO - Running setup.py install for mozrunner 05:45:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:04 INFO - Running setup.py install for mozscreenshot 05:45:04 INFO - Running setup.py install for moztest 05:45:04 INFO - Running setup.py install for mozversion 05:45:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:04 INFO - Cleaning up... 05:45:04 INFO - Return code: 0 05:45:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:04 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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:45:04 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:45:04 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:45:04 INFO - Using env: {'DISPLAY': ':0', 05:45:04 INFO - 'HOME': '/home/cltbld', 05:45:04 INFO - 'LANG': 'en_US.UTF-8', 05:45:04 INFO - 'LANGUAGE': 'en_US:en', 05:45:04 INFO - 'LOGNAME': 'cltbld', 05:45:04 INFO - 'MAIL': '/var/mail/cltbld', 05:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:04 INFO - 'MOZ_NO_REMOTE': '1', 05:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:04 INFO - 'NO_EM_RESTART': '1', 05:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:04 INFO - 'SHELL': '/bin/bash', 05:45:04 INFO - 'SHLVL': '1', 05:45:04 INFO - 'TERM': 'linux', 05:45:04 INFO - 'TMOUT': '86400', 05:45:04 INFO - 'USER': 'cltbld', 05:45:04 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:04 INFO - '_': '/tools/buildbot/bin/python'} 05:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:04 INFO - Running setup.py (path:/tmp/pip-yOVks1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:04 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:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:04 INFO - Running setup.py (path:/tmp/pip-J0PqHo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:04 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:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:04 INFO - Running setup.py (path:/tmp/pip-UlaC3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:04 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:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:04 INFO - Running setup.py (path:/tmp/pip-9UBkuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:04 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:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:04 INFO - Running setup.py (path:/tmp/pip-qOqQf7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:05 INFO - Running setup.py (path:/tmp/pip-87m0J6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:05 INFO - Running setup.py (path:/tmp/pip-Ub5GvP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:05 INFO - Running setup.py (path:/tmp/pip-A42utP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:05 INFO - Running setup.py (path:/tmp/pip-5DzQlj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:05 INFO - Running setup.py (path:/tmp/pip-xWWwFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:05 INFO - Running setup.py (path:/tmp/pip-meJr1l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:05 INFO - Running setup.py (path:/tmp/pip-16qVhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:05 INFO - Running setup.py (path:/tmp/pip-ILuODz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:05 INFO - Running setup.py (path:/tmp/pip-wzt3h7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:05 INFO - Running setup.py (path:/tmp/pip-NKsWt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:05 INFO - Running setup.py (path:/tmp/pip-TOE72t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:05 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:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:05 INFO - Running setup.py (path:/tmp/pip-Ql0iDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:06 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:45:06 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:45:06 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:45:06 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:45:06 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:45:06 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:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:06 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:45:06 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:45:06 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:45:06 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:45:06 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:45:06 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:45:07 INFO - Downloading blessings-1.5.1.tar.gz 05:45:07 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:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:07 INFO - Installing collected packages: blessings 05:45:07 INFO - Running setup.py install for blessings 05:45:07 INFO - Successfully installed blessings 05:45:07 INFO - Cleaning up... 05:45:07 INFO - Return code: 0 05:45:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:08 INFO - Reading from file tmpfile_stdout 05:45:08 INFO - Current package versions: 05:45:08 INFO - argparse == 1.2.1 05:45:08 INFO - blessings == 1.5.1 05:45:08 INFO - blobuploader == 1.2.4 05:45:08 INFO - docopt == 0.6.1 05:45:08 INFO - manifestparser == 1.1 05:45:08 INFO - mozInstall == 1.12 05:45:08 INFO - mozcrash == 0.16 05:45:08 INFO - mozdebug == 0.1 05:45:08 INFO - mozdevice == 0.47 05:45:08 INFO - mozfile == 1.2 05:45:08 INFO - mozhttpd == 0.7 05:45:08 INFO - mozinfo == 0.9 05:45:08 INFO - mozleak == 0.1 05:45:08 INFO - mozlog == 3.1 05:45:08 INFO - moznetwork == 0.27 05:45:08 INFO - mozprocess == 0.22 05:45:08 INFO - mozprofile == 0.28 05:45:08 INFO - mozrunner == 6.11 05:45:08 INFO - mozscreenshot == 0.1 05:45:08 INFO - mozsystemmonitor == 0.0 05:45:08 INFO - moztest == 0.7 05:45:08 INFO - mozversion == 1.4 05:45:08 INFO - psutil == 3.1.1 05:45:08 INFO - requests == 1.2.3 05:45:08 INFO - wsgiref == 0.1.2 05:45:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:45:08 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:45:08 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:45:08 INFO - Using env: {'DISPLAY': ':0', 05:45:08 INFO - 'HOME': '/home/cltbld', 05:45:08 INFO - 'LANG': 'en_US.UTF-8', 05:45:08 INFO - 'LANGUAGE': 'en_US:en', 05:45:08 INFO - 'LOGNAME': 'cltbld', 05:45:08 INFO - 'MAIL': '/var/mail/cltbld', 05:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:08 INFO - 'MOZ_NO_REMOTE': '1', 05:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:08 INFO - 'NO_EM_RESTART': '1', 05:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:08 INFO - 'SHELL': '/bin/bash', 05:45:08 INFO - 'SHLVL': '1', 05:45:08 INFO - 'TERM': 'linux', 05:45:08 INFO - 'TMOUT': '86400', 05:45:08 INFO - 'USER': 'cltbld', 05:45:08 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:08 INFO - '_': '/tools/buildbot/bin/python'} 05:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:45:08 INFO - Cleaning up... 05:45:08 INFO - Return code: 0 05:45:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:45:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:45:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:08 INFO - Using env: {'DISPLAY': ':0', 05:45:08 INFO - 'HOME': '/home/cltbld', 05:45:08 INFO - 'LANG': 'en_US.UTF-8', 05:45:08 INFO - 'LANGUAGE': 'en_US:en', 05:45:08 INFO - 'LOGNAME': 'cltbld', 05:45:08 INFO - 'MAIL': '/var/mail/cltbld', 05:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:08 INFO - 'MOZ_NO_REMOTE': '1', 05:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:08 INFO - 'NO_EM_RESTART': '1', 05:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:08 INFO - 'SHELL': '/bin/bash', 05:45:08 INFO - 'SHLVL': '1', 05:45:08 INFO - 'TERM': 'linux', 05:45:08 INFO - 'TMOUT': '86400', 05:45:08 INFO - 'USER': 'cltbld', 05:45:08 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:08 INFO - '_': '/tools/buildbot/bin/python'} 05:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:08 INFO - Downloading/unpacking jsonschema 05:45: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:45: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:45: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:45: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:45: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:45: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:45:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:10 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:45:10 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45: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:45: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:45: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:45: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:45: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:45: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:45:10 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:10 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:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:10 INFO - warning: no files found matching '*.txt' 05:45:10 INFO - no previously-included directories found matching 'build' 05:45:10 INFO - no previously-included directories found matching 'dist' 05:45:10 INFO - no previously-included directories found matching '.git*' 05:45:10 INFO - Installing collected packages: jsonschema, functools32 05:45:10 INFO - Running setup.py install for functools32 05:45:10 INFO - warning: no files found matching '*.txt' 05:45:10 INFO - no previously-included directories found matching 'build' 05:45:10 INFO - no previously-included directories found matching 'dist' 05:45:10 INFO - no previously-included directories found matching '.git*' 05:45:10 INFO - Successfully installed jsonschema functools32 05:45:10 INFO - Cleaning up... 05:45:10 INFO - Return code: 0 05:45:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64a01e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', '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:45: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', 'flake8'] in /builds/slave/test-pgo/build 05:45: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 flake8 05:45:10 INFO - Using env: {'DISPLAY': ':0', 05:45:10 INFO - 'HOME': '/home/cltbld', 05:45:10 INFO - 'LANG': 'en_US.UTF-8', 05:45:10 INFO - 'LANGUAGE': 'en_US:en', 05:45:10 INFO - 'LOGNAME': 'cltbld', 05:45:10 INFO - 'MAIL': '/var/mail/cltbld', 05:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:10 INFO - 'MOZ_NO_REMOTE': '1', 05:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:10 INFO - 'NO_EM_RESTART': '1', 05:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:10 INFO - 'SHELL': '/bin/bash', 05:45:10 INFO - 'SHLVL': '1', 05:45:10 INFO - 'TERM': 'linux', 05:45:10 INFO - 'TMOUT': '86400', 05:45:10 INFO - 'USER': 'cltbld', 05:45:10 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:10 INFO - '_': '/tools/buildbot/bin/python'} 05:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:10 INFO - Downloading/unpacking flake8 05:45: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:45: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:45: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:45: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:45: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:45: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:45:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:12 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:45:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45: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:45: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:45: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:45: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:45: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:45: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:45:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:12 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:45:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45: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:45: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:45: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:45: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:45: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:45: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:45:12 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:45:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45: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:45: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:45: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:45: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:45: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:45: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:45:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:45:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:13 INFO - no previously-included directories found matching 'docs/_build' 05:45:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:13 INFO - Running setup.py install for pep8 05:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:13 INFO - no previously-included directories found matching 'docs/_build' 05:45:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:45:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:13 INFO - Cleaning up... 05:45:13 INFO - Return code: 0 05:45:13 INFO - Running post-action listener: _resource_record_post_action 05:45:13 INFO - Running post-action listener: _start_resource_monitoring 05:45:13 INFO - Starting resource monitoring. 05:45:13 INFO - ##### 05:45:13 INFO - ##### Running install step. 05:45:13 INFO - ##### 05:45:13 INFO - Running pre-action listener: _resource_record_pre_action 05:45:13 INFO - Running main action method: install 05:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:13 INFO - Reading from file tmpfile_stdout 05:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:45:13 INFO - Reading from file tmpfile_stdout 05:45:13 INFO - Output received: 05:45:13 INFO - Usage: mozinstall [options] installer 05:45:13 INFO - Options: 05:45:13 INFO - -h, --help show this help message and exit 05:45:13 INFO - -d DEST, --destination=DEST 05:45:13 INFO - Directory to install application into. [default: 05:45:13 INFO - "/builds/slave/test-pgo"] 05:45:13 INFO - --app=APP Application being installed. [default: firefox] 05:45:13 INFO - mkdir: /builds/slave/test-pgo/build/application 05:45:13 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:45:13 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:45:29 INFO - Reading from file tmpfile_stdout 05:45:29 INFO - Output received: 05:45:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:45:29 INFO - Running post-action listener: _resource_record_post_action 05:45:29 INFO - ##### 05:45:29 INFO - ##### Running run-tests step. 05:45:29 INFO - ##### 05:45:29 INFO - Running pre-action listener: _resource_record_pre_action 05:45:29 INFO - Running main action method: run_tests 05:45:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:45:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:45:29 INFO - Python 2.7.3 05:45:29 INFO - Return code: 0 05:45:29 INFO - grabbing minidump binary from tooltool 05:45:29 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:45:29 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 0x1f04840>, '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 0x1e716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e71b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:45:29 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:45:29 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:45:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:29 INFO - Return code: 0 05:45:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:45:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:45:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:45:30 INFO - Return code: 0 05:45:30 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/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:45:30 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/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:45:30 INFO - Using env: {'DISPLAY': ':0', 05:45:30 INFO - 'HOME': '/home/cltbld', 05:45:30 INFO - 'LANG': 'en_US.UTF-8', 05:45:30 INFO - 'LANGUAGE': 'en_US:en', 05:45:30 INFO - 'LOGNAME': 'cltbld', 05:45:30 INFO - 'MAIL': '/var/mail/cltbld', 05:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:30 INFO - 'MOZ_NO_REMOTE': '1', 05:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:30 INFO - 'NO_EM_RESTART': '1', 05:45:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:45:30 INFO - 'SHELL': '/bin/bash', 05:45:30 INFO - 'SHLVL': '1', 05:45:30 INFO - 'TERM': 'linux', 05:45:30 INFO - 'TMOUT': '86400', 05:45:30 INFO - 'USER': 'cltbld', 05:45:30 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615', 05:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:30 INFO - '_': '/tools/buildbot/bin/python'} 05:45:30 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/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:45:30 INFO - mozversion application_buildid: 20151226030212 05:45:30 INFO - mozversion application_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 05:45:30 INFO - mozversion application_display_name: Nightly 05:45:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:30 INFO - mozversion application_name: Firefox 05:45:30 INFO - mozversion application_remotingname: firefox 05:45:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:45:30 INFO - mozversion application_vendor: Mozilla 05:45:30 INFO - mozversion application_version: 46.0a1 05:45:30 INFO - mozversion platform_buildid: 20151226030212 05:45:30 INFO - mozversion platform_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 05:45:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:45:30 INFO - mozversion platform_version: 46.0a1 05:45:30 INFO - using testdate: 1451137530 05:45:30 INFO - actual date: 1451137530 05:45:30 INFO - starting webserver on 'localhost:49662' 05:45:30 INFO - SUITE-START | Running 3 tests 05:45:30 INFO - TEST-START | dromaeo_css 05:45:30 INFO - operating with platform_type : linux_ 05:45:30 INFO - Initialising browser for dromaeo_css test... 05:45:30 INFO - TEST-INFO | started process 28427 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJAkelt/profile http://localhost:49662/getInfo.html) 05:45:35 INFO - PROCESS | 28427 | __metrics Screen width/height:1600/1200 05:45:35 INFO - PROCESS | 28427 | colorDepth:24 05:45:35 INFO - PROCESS | 28427 | Browser inner width/height: 1024/670 05:45:35 INFO - PROCESS | 28427 | __metrics 05:45:35 INFO - PROCESS | 28427 | 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:45:36 INFO - TEST-INFO | 28427: exit 0 05:45:36 INFO - Browser initialized. 05:45:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:36 INFO - TEST-INFO | started process 28562 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJAkelt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:48 INFO - PROCESS | 28562 | RSS: Main: 149262336 05:45:48 INFO - PROCESS | 28562 | 05:46:37 INFO - PROCESS | 28562 | 1451137597961 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:48:46 INFO - PROCESS | 28562 | Cycle 1(1): loaded http://localhost:49662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49662/tests/dromaeo/cssquery-ext.html) 05:48:47 INFO - PROCESS | 28562 | RSS: Main: 156844032 05:48:47 INFO - PROCESS | 28562 | 05:51:49 INFO - PROCESS | 28562 | Cycle 1(1): loaded http://localhost:49662/tests/dromaeo/cssquery-ext.html (next: http://localhost:49662/tests/dromaeo/cssquery-jquery.html) 05:51:50 INFO - PROCESS | 28562 | RSS: Main: 152440832 05:51:50 INFO - PROCESS | 28562 | 05:54:51 INFO - PROCESS | 28562 | Cycle 1(1): loaded http://localhost:49662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49662/tests/dromaeo/cssquery-mootools.html) 05:54:52 INFO - PROCESS | 28562 | RSS: Main: 153042944 05:54:52 INFO - PROCESS | 28562 | 05:57:54 INFO - PROCESS | 28562 | Cycle 1(1): loaded http://localhost:49662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49662/tests/dromaeo/cssquery-prototype.html) 05:57:54 INFO - PROCESS | 28562 | RSS: Main: 152203264 05:57:54 INFO - PROCESS | 28562 | 06:00:57 INFO - PROCESS | 28562 | Cycle 1(1): loaded http://localhost:49662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49662/tests/dromaeo/cssquery-yui.html) 06:00:57 INFO - PROCESS | 28562 | RSS: Main: 152854528 06:00:57 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | Cycle 1(1): loaded http://localhost:49662/tests/dromaeo/cssquery-yui.html (next: http://localhost:49662/tests/dromaeo/cssquery-dojo.html) 06:04:00 INFO - PROCESS | 28562 | RSS: Main: 155049984 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | __start_tp_report 06:04:00 INFO - PROCESS | 28562 | _x_x_mozilla_page_load 06:04:00 INFO - PROCESS | 28562 | _x_x_mozilla_page_load_details 06:04:00 INFO - PROCESS | 28562 | |i|pagename|runs| 06:04:00 INFO - PROCESS | 28562 | |0;dojo.html;3136.2316232523035;3187.888423905162;3208.021553426207;3234.0944535530043;3235.4823228283462;4962.230854217593;5136.229565565162;5158.329417175762;5174.379074511059;5229.032628963644;5093.388793344804;5148.433672296044;5156.381234251895;5211.218317252405;5214.217867319894;4734.289856521524;4747.335373047776;4755.690880092783;4801.135795556798;4893.314935908976;4819.180739274332;4820.228763397857;4851.126797176506;4876.9268460972935;4914.508549145093;4684.508126646704;4696.718196908197;4771.856844294659;4798.568128868384;4810.302506136591;4745.098431298043;4747.810087596492;4761.523847615211;4772.331873537708;4789.880252993668;4617.191991401525;4739.6208303336;4741.786619602091;4745.098431298077;4775.856724298276;4985.526374994406;4988.725620090893;5020.071286811952;5023.522765337287;5054.3176671149295;5481.616286859921;5493.2034854946205;5509.393966663663;5511.889762204733;5568.49883510482;5512.4211957744665;5514.889702205974;5541.445855414467;5564.137558678412;5603.691796951166;5147.253648220987;5199.4800519948085;5224.947750522484;5226.97386513065;5246.895062098775;5683.715814209273;5690.601657883991;5715.31416230055;5758.712064396764;5759.280089988752;5413.188021796762;5478.753456094485;5510.614257002052;5555.861103472445;5588.776448941997;5537.141743029837;5546.667199968015;5548.4174161713245;5557.888842223214;5602.159676048625;5486.506214440719;5503.174523821459;5511.862203444946;5513.889722205534;5525.917111243334;5453.263809385682;5501.697406642673;5550.056490396642;5550.694711790809;5552.250446189793;4327.870163895088;4329.177456283296;4348.108637729258;4364.869053928323;4382.035952090535;3910.648041676263;3911.8044097794996;3928.5285765707727;3948.2893079245437;3949.3878448840474;5070.315507406527;5193.532582067632;5216.37403511581;5239.476052394806;5267.341582302212;5545.556355491551;5550.16747487872;5555.527780138653;5562.443755624405;5592.916106258409;5066.417362003343;5208;5217.556507696889;5218.165093585084;5252.1596544552685;4752.881177970509;4800.855974320776;4827.951720482821;4842.273658951115;4890.070886531547;5743.913841292384;5763.88472230553;5764.423557644202;5766.452187042224;5782.537397008229;5424.783008679608;5503.367112782082;5583.860403489945;5590.189422533791;5632.690202038927;5747.281589801275;5782.681952492485;5801.129830525455;5817.301923769175;5843.766249349978;5526.47498487643;5562.193481945176;5566.415526369673;5567.276254086943;5573.581981351496;5443.047466693392;5540.944590554042;5596.972015139898;5606.803761868315;5638.041532939328;5413.079776438094;5418.187271909087;5418.593605479684;5423.376311724044;5467.152591348347;5401.837944861661;5402.51377376038;5407.405185429521;5431.4296998816135;5454.836354909359;5266.526012658879;5269.1569348903995;5274.736263186748;5371.973140134274;5440.755166017618;5433.565314774887;5440.102383106743;5498;5509.724513774215;5518.889622207453;5367.973160134331;5381.381141168816;5394.406615272238;5411.945880541144;5453.263809385682 06:04:00 INFO - PROCESS | 28562 | |1;ext.html;555.8942552793152;576.1501784867321;587.3069777662362;594.3937184072249;603.0803025386285;35854.103647408825;36617;36857.76135744384;36945.630543694555;36975.445368319495;38431.231375372474;38742.41886371707;39041.41437878434;39044.41433378502;39136.21727565447;8535.70125045625;8647.567621618926;8671;8679.522626255584;8718.564071796385;8494.235518803338;8581.184787445183;8584.74245772628;8587.785305367384;8593;8585.742427727178;8757.124287571256;8775.824483510325;8788.736337909873;8813.73558793234;8606.397552171351;8622.870656940182;8706.477611343307;8822.823543529157;8823.29413646913;8589;8759.649614015432;8761.474311541328;8762.518061506615;8765.254953328975;39795.21433499656;40059;40347.7982610088;40353.79823100895;40361.79819100886;3242.7243684286864;3265.7224135948472;3312.1222875937897;3607.981960090209;3969.6824254059607;29726;29847.25381865449;30069.548956765666;30792.692073079208;30872.228194295323;3922.156736301709;3971.146203566247;4015.5582885882823;4081.3265811141127;4188;187556;187878.06060969608;187925;188267;188453;42774.57225427768;42802;43174.78412607917;43217;59464.10803837946;40163;40235.195296093916;40300.596994029685;40303.19393612111;40353.79823100866;14852.2573871306;15098.622534436727;15190.316435760416;15207.467738629095;15208.543743687707;11594.536218551331;11624.825627615592;11643.76712465746;11654.825177622342;11742.236754610924;14356.856431435552;14415.207163605892;14519.274036298142;14537.709245815236;14582.708345833023;5747.195392645033;5780.277465316835;5803.7388317524965;5871.148683440877;5922.851928701817;970.5486948568949;1011.944343061124;1012.372329155928;1035.1822060572215;1079.8002369561657;26002.73997260041;26602.334941626614;26953;27473.17580472589;28286.15141545757;1062.2564205056492;1064.9307794993456;1068.3643232276784;1086.0334302470808;1126.7464820415341;14998.550043498712;15408.922955385151;15510.379584816706;15766.842331576767;15998.200089995453;345971;350809;354791;354851;355290;52840.471595283554;53428.73285633547;53443.73278133662;53568.464315356345;53585.73207134017;1377.435251546861;1389.805427240187;1391.9095258808145;1395.5673741140279;1396.1343966740685;27515.449691005666;28763.5685464714;28841;28924.85537572383;29043.419131616825;45631;45933.08133837371;45959.77020114878;46035.30947035864;46179.30731039104;288062;288166;288441;288882;289782;30639.846800765852;42543.3618495729;42607.01354099425;43122.78438607787;43854;39314;39405.802970984965;39462.80268598753;40274.59725402708;40720;34581.654183457846;35426.82286588551;35651.28697426089;35850;36221.63778362182;35624.64375356213;35874;36182.819085904404;36183.27633447369;36250;33342;33360.49959250662;35234.47148292726;35689.286214276086;35861.82069089638;30858.382832343676;31968.840155799073;32242;32687.34625307433;32715.509267360532;24757.133500327403;25055.373615659755;25065.624015639416;25185;25249.87375063113 06:04:00 INFO - PROCESS | 28562 | |2;jquery.html;348.39379479705303;349.92826470573533;352.07755680118095;354.0846910735749;357.1107941226346;16472.50582482526;17215.827841721595;17512.82487175128;17831;18292.451226463196;14133.85866141341;16253.512394628151;16409.425670101547;16437.753433698475;16646.83353166468;4927.285543596186;5045.798168073273;5046.016026874761;5049.4698056704065;5061.898762024757;4982.825601103962;5018.874528136807;5020.799168033274;5025.597952163818;5387.757550910218;5320.122179840322;5486.396496385394;5510.6969116698565;5515.310586176728;5522.641028333145;5410.026195284867;5412.675239485624;5415.10650742627;5419.349678038621;5439.782408703647;5236;5246.947530524722;5251.816186433456;5398.676079435208;5399.4600539945695;13136.40886160125;13198.274094924775;13355.599332020054;19418.417447476597;21142.471438214016;2017.6065667194903;2042.5097976485686;2072.813446789781;2151.5696860627936;2169.3275084723787;9790.804183916282;9811.705648830546;9932.602695892156;9956.15372693322;10045.146162576117;1841.9907900460412;1847.9722804157948;1861.2089861808677;1909.5798924236785;1921.2795201799324;60274.69862650702;61637.38362616361;62534.37465625331;62954.68522657403;63228.68385658042;10199.439030853226;10200.489975501196;10220;10335.534900929477;10374.948125259325;13399.12905661129;13461.596152115451;13470.259135747432;13525.45898164082;13539.932300338436;7584.924150758532;7644.847103057908;7722.691092356243;7729.072511298567;7768.41736869737;7478.887816682645;7493.475456717977;7498.025256716592;7527;7568.205338439495;4438.911221775546;4454.418681368133;4461.57615026572;4474.239379305461;4479.529649386833;1795.9191836367395;1820.4356649438716;1834.4588346437833;1850.8334249917573;1879.8402135818335;438.67318847458847;444.1184249265206;457.1816448557046;893.3210759822582;946.5551190940247;10564.260501764957;11236.269642473213;16839.91580042092;17111.486655400357;17489.825101749073;720.6792977125234;820.5774026376421;827.2351256760979;907.1563445995156;930.544033423631;8259;8705.686069803323;8850.33622478304;9017.323700722472;9081.409708368936;485223;490442;518192;518673;523836;48127.278090828666;83488;84526.577367114;84568.57715711505;85718.57140714256;1078.185969592968;1116.3413585984308;1117.3016864459712;1131.5077941095649;1136.72718547548;16166.67666646637;16249.67500650004;16446.506604801874;16456.177191140156;16488;37354.43968340531;37660.43509347307;38248.470061197244;38518.42222366723;40044.39933400943;51782;52859.735701321246;52912.470875292296;53818.73090634522;54757.72621136869;9691.224702023681;9877.604895804376;10063.597456101674;10122.544485498318;10149.289549731448;11918.75656332886;11980.58067967617;12070.939645301718;12122.878771212176;18224.4532664015;15123.470678526199;15244.085354878744;15383.692326153638;15576;15629.218539073228;14697.648376259747;14908.925455372653;14982.40070397172;15074.698506030038;15371.769423458434;14919.701605968037;14957.40170393172;15221.543353699406;15798.9210053949;15851.286692098653;9889.752756181153;9989.750256243651;10024.599016039569;10103.242256830914;10156.898431015596;10614.681559553226;10640.733981650521;11258.437078146224;15373.923130384725;15567.532974010797 06:04:00 INFO - PROCESS | 28562 | |3;mootools.html;1411.9788203176954;1416.9929150354246;1553.3165407220822;1695.3811858671572;1733.1161107835;6303.4011768882;6330.177076979986;7415.999999999994;7468.96265518673;7559.39524838013;7101.431885449165;7148.463865210117;7217.097862767154;7234.023406840075;7266.382357499619;2150.419386765572;2167.3497950614833;2195.681626164205;2202.361315218585;2203.2178576605315;2162.1783722185546;2188.9671654925187;2192.8355373346985;2207.128184367182;2208.712867327245;2166.869987800737;2172.8261739060836;2186.180182431588;2192.4628466025847;2213.1589995801573;2186.464316242515;2222.2555443926385;2224.310463756233;2230.7434645015705;2231.163313757341;2177.150911144655;2217.2904670505445;2217.667349897512;2222.022310183514;2222.055626358791;7373.926260737378;7441.888371674429;7456.254374562554;7459.776206713807;7477.439192060618;4474.664400169968;4488.775561221959;4491.214037543416;4493.707908985905;4516.41286632739;2883.8413887236193;2891.219370769901;2897.492938735713;2915.02346713849;2917.081119447367;953.2135987810016;967.351874244258;971.8590804333403;985.4530735441826;1000.9049140331657;10124.54439550222;10150.23873209505;10151.187904967584;10155.949220253851;10179.592816287339;3914.099757055893;3924.0582260257333;3935.9016024599614;3962.425448309979;4032.495938007749;8625.611847466878;8681.392302538761;8701.086385929513;8706.1729135732;8739.169778870997;4465.531119232499;4509.346144808985;4514.781009127517;4525.796339164745;4543.38664280318;4008.679305655599;4081.8571350002608;4085.20338533983;4115.691323150776;4132.152908653718;3342.147752323142;3368.6294507604143;3385.0860267727576;3402.625711171769;3424.931501369959;985.0887928666099;996.4170959988343;1010.7068950004564;1012.6202673997251;1020.8162530744389;1046.5447530324334;1259.3640211693037;1263.873612638747;1273.3251376770327;1292.2052937443405;6975.511714179958;6979.581225126509;6994.160700715946;7003.194632617314;7017.61403122823;479.0777752825866;482.9879253018703;500.9098362294749;503.0517474560407;504.66944151580776;5129.640925135204;5146.87132821675;5192.5586325162785;5210.166373380241;5259.868503287448;8516.148385161434;8623.611937462829;8685.261752751087;8702.30381569473;8800.075992020873;8607.956960215159;8635.093315201939;8675.305975521944;8693.652253909899;8716.259117975043;6807.319268073153;6832.0435139081565;6869.450443964471;6878.965605171942;6931.202911665122;6786.8642627148165;6829.146356705412;6854.6229957352825;6891.724331026903;6892.896606550806;7598.240175982579;7813.648385822538;7828;7831.882521762064;7972;7884.4086693497065;8033.236842499953;8069;8071.313938315309;8073.233042860918;5887.852803679943;5983.521318294439;6180.320164781961;6293.213348331458;6335.746570137143;6833.3166683331265;6852.725890964306;6854.6229957352825;6856.074429951893;6884.208316043719;6351;6498.805035848932;6520.967395162994;6594.802155935329;6604;6182.752689892533;6183.350748171377;6198.535109866688;6359.713812878339;6394.360563943755;6041.426064523863;6063.636181829104;6066.272047354346;6095.238095238095;6101.786437474667;5627.52166065889;5645.971770141123;5661.037623604079;5669.036263835075;5676.2337084493065;5916.378780228014;5934.792282270272;5956.731947062306;5980.820575382745;5983.37174596661 06:04:00 INFO - PROCESS | 28562 | |4;prototype.html;323.5341108803323;330.4547496630559;336.55910756908435;337.90707555422256;340.27181830881904;6166.53750968678;6328.905066423996;6335.208098987627;6347.523935704823;6354.7775827846035;6170.907436388457;6262.592931459452;6274.623522588648;6284.434400903918;6339.587926784768;4835.782389792459;4848.587870031034;4850.44219914709;4853.344798452216;4857.708537487744;4814.590759785422;4839.830605928793;4849.296851956464;4854.490278520758;4860.05228980349;4705.976470117645;4806.0628177505405;4813.470518242991;4818.855434336975;4819.7590120494015;4772.90454190916;4806.399200099988;4807.326974223594;4809.951900480985;4820.927686084711;4202.201581699467;4202.642775364097;4211.4946206455115;4218.578142185787;4224.5353011168745;5955.285365756094;5985.461308482258;5987.281526216838;5989.3711160327975;5995.970020149915;5441.347038355423;5633.63381380209;5643.943560564383;5647.689377084259;5664.348599911022;6657.600543967377;6660.633665148415;6661.566998145154;6662.833429164261;6664;4620.514845941161;4640.443146822403;4646.814127434898;4654;4659.720416775004;6777.932220677829;6930.792076237721;6943.409810166091;6963.582185068912;6966.094407726963;4738.147133515931;4778.976105119522;4781.2350023996;4846.7818948147415;4853;4915.606751459874;4916.311716359713;4917.016596680678;4917.385326834145;4919.926201106986;5665.263515742927;5666.829995100154;5671.035923892948;5680.943190568124;5683.715814209273;6556.082148499214;6713.865722685519;6721;6803.48973826965;6803.897941530881;1695.1100672146974;1720.0195888343774;1737.54823745827;1740.2342969093559;1754.8420642142269;1148.3569201247328;1167.3637867362308;1173.284296579103;1185.9407029648482;1189.7382575833303;6218.160548326008;6283.842903927347;6300.401461861115;6305.527085468608;6313.084602732578;6848.486363522656;6852.5203235774015;6865.0732151159955;6910.619915904674;6910.827229319308;6146.508279337642;6253.749850005949;6268.937310626927;6273.215848018997;6314.55798094129;3798.867039653599;3816.5229346331707;3834.7699138051807;3847.5575308839284;3851.5556666250154;7277.053982982285;7323.633818309063;7361.558306501627;7362.4478164136835;7403.185649578542;7088.468364872655;7210.170830354471;7246.637668116573;7250.492465527468;7261.164966028869;7351.448641351813;7361.668724907392;7373.188949215582;7386.74146404884;7390.778276651817;6982.79051628452;6986;7033.542819716702;7036.437085033082;7050.330218629222;6725.663716814238;6916.170059592881;6925.68834402443;6961.79114626562;6981.476389270723;7361.705531778669;7369.078865141857;7385.446091543263;7390.778276651709;7402.037735094404;4708.599769019672;4758.5241475852135;4759.571638552547;4766.189747742961;4772.164871147605;6794.966025169842;6845.418139458003;7011.964940175267;7065.434765218667;7079.115110611174;6815.693293801692;6820.31796820314;6849.794506164823;6879.89680154788;6903.896441553481;6860.48546359035;6862;6863.347981941708;6873.931260687329;6874.312568743286;6599.373059559334;6723.159605049369;6745.460363171032;6749.831254218488;6761.93238067613;6880.759173428906;6899.655017249218;6928.1339832520935;6943.166819981635;6944.444444444332;6694.631795251308;6697.162854643169;6734.494912881455;6752.561083529751;6753.2909044549615 06:04:00 INFO - PROCESS | 28562 | |5;yui.html;842.2083241752756;851.0553584137521;863.2921004776086;865.900421451533;886.83593535196;13614.795778063324;13732.382042808073;13758.174509529435;13778.517751878686;13857.445702171914;12574.937125314384;12709.491620335199;12799.232046077243;12811.42348594313;12839.42222599983;804.8148925747082;805.4804651000117;818.0510607695074;819.7294892685429;820.9507429554246;815.1400272712286;815.2255357410454;817.697451942782;819.0908092017855;822.1039067416515;843.3716880923721;844.2781421884292;846.2848892685702;847.5846835050843;854.692310768123;835.2733122183678;842.2083241752763;844.6705784743893;845.2561745663808;845.3786466946789;625.5121005615628;626.1328060636051;626.1734510446213;626.5207116555838;627.7991042866284;13713.382897769625;13895.027348085638;13896.652583685387;13916.512922047781;13952.720945581133;11846.81531846817;12101.757964840654;12363.196392234477;12476.8128478072;12498.500059997588;10446.529906154241;10465.319754215952;10679.83980240297;11040.447977601088;11071.833922491169;3614.9277014459826;3618.9276214475562;3620.601733809279;3647.1976165243605;3751.981240093782;44467;44763.552364476265;45091;45170.09659806819;45351.31973020407;9957.850632240523;9964.800703986024;10013.79972400548;10151.847722284172;10291.485425728684;16510.917445412695;16514.091724955004;16531.421400250932;16670.416535421202;17693.646127077387;7427.740029098955;7565.659545320474;7656.693732250759;7662.3487003604205;7721.420893433015;4538.11506756186;4573.359729637853;4619.792109355087;4622.653301002439;4711.81152753886;3021.8942337018098;3031.378567393679;3034.5296479045783;3054.511278195478;3063.0657649416694;554.9306336707912;580.6719203649924;585.5842351930092;589.6609449566516;592.9288485381695;631.409631994087;635.8664680417072;654.8068319845657;664.7208172567533;713.5255055388212;8568.228859402683;8594.914050859412;8644.178803013703;8778.209961103532;9237.815243695088;497.56711660855285;554.3154204557369;632.4971647540125;659.1365311442026;665.4975493502375;3809.4095415210686;3809.8095095245126;3820.1595648957186;3880.4567360569545;3983.5418926823786;48823;53458.46541534612;54645.72677136589;55244;55535.722321388945;46640;48018.75990620025;48071.5192848067;48346.758266208446;48567;45496.54503454989;45811.3128303069;45829.54170458319;45902.770486147354;46068.078638427716;7705.499142555716;7874.1338452769005;7966.721164759206;7977.122516523294;8041.673123934485;33015.50476742899;33125.83437082799;33290.69252325703;33652.3269534603;34090.14774630654;40734.38898416467;43408.34887476627;43513.129737404444;43513.34729978989;43993.78003109964;10181;10268.383896966207;10367.844482332923;10472.371657700562;10684.198685098494;11199.440027998404;11215.943920280346;11271.718207044889;11433;11878.168528203289;9934.354266972623;10019.148372388428;10044.849327259952;10315.27793054479;11010.834837477605;10113.797724045331;10250.692479225636;10472.790544189225;10707.732306692395;10951.83572246401;9553.761155970878;10348.678372369031;10945;11050.502727377127;11431.142664300045;8135.755927321953;8182.140875208018;8235.917640823514;8345.457545259538;8478.448900821428;8270.172982701682;8743.431676940978;8803.29573634095;8985.505797181218;9128.863067053866 06:04:00 INFO - PROCESS | 28562 | __end_tp_report 06:04:00 INFO - PROCESS | 28562 | __start_cc_report 06:04:00 INFO - PROCESS | 28562 | _x_x_mozilla_cycle_collect,309 06:04:00 INFO - PROCESS | 28562 | __end_cc_report 06:04:00 INFO - PROCESS | 28562 | __startTimestamp1451138640368__endTimestamp 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | ------- Summary: start ------- 06:04:00 INFO - PROCESS | 28562 | Number of tests: 6 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | [#0] dojo.html Cycles:165 Average:5176.51 Median:5401.84 stddev:546.83 (10.1%) stddev-sans-first:524.56 06:04:00 INFO - PROCESS | 28562 | Values: 3136.2 3187.9 3208.0 3234.1 3235.5 4962.2 5136.2 5158.3 5174.4 5229.0 5093.4 5148.4 5156.4 5211.2 5214.2 4734.3 4747.3 4755.7 4801.1 4893.3 4819.2 4820.2 4851.1 4876.9 4914.5 4684.5 4696.7 4771.9 4798.6 4810.3 4745.1 4747.8 4761.5 4772.3 4789.9 4617.2 4739.6 4741.8 4745.1 4775.9 4985.5 4988.7 5020.1 5023.5 5054.3 5481.6 5493.2 5509.4 5511.9 5568.5 5512.4 5514.9 5541.4 5564.1 5603.7 5147.3 5199.5 5224.9 5227.0 5246.9 5683.7 5690.6 5715.3 5758.7 5759.3 5413.2 5478.8 5510.6 5555.9 5588.8 5537.1 5546.7 5548.4 5557.9 5602.2 5486.5 5503.2 5511.9 5513.9 5525.9 5453.3 5501.7 5550.1 5550.7 5552.3 4327.9 4329.2 4348.1 4364.9 4382.0 3910.6 3911.8 3928.5 3948.3 3949.4 5070.3 5193.5 5216.4 5239.5 5267.3 5545.6 5550.2 5555.5 5562.4 5592.9 5066.4 5208.0 5217.6 5218.2 5252.2 4752.9 4800.9 4828.0 4842.3 4890.1 5743.9 5763.9 5764.4 5766.5 5782.5 5424.8 5503.4 5583.9 5590.2 5632.7 5747.3 5782.7 5801.1 5817.3 5843.8 5526.5 5562.2 5566.4 5567.3 5573.6 5443.0 5540.9 5597.0 5606.8 5638.0 5413.1 5418.2 5418.6 5423.4 5467.2 5401.8 5402.5 5407.4 5431.4 5454.8 5266.5 5269.2 5274.7 5372.0 5440.8 5433.6 5440.1 5498.0 5509.7 5518.9 5368.0 5381.4 5394.4 5411.9 5453.3 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | [#1] ext.html Cycles:180 Average:43832.73 Median:19895.40 stddev:74615.70 (375.0%) stddev-sans-first:74754.27 06:04:00 INFO - PROCESS | 28562 | Values: 555.9 576.2 587.3 594.4 603.1 35854.1 36617.0 36857.8 36945.6 36975.4 38431.2 38742.4 39041.4 39044.4 39136.2 8535.7 8647.6 8671.0 8679.5 8718.6 8494.2 8581.2 8584.7 8587.8 8593.0 8585.7 8757.1 8775.8 8788.7 8813.7 8606.4 8622.9 8706.5 8822.8 8823.3 8589.0 8759.6 8761.5 8762.5 8765.3 39795.2 40059.0 40347.8 40353.8 40361.8 3242.7 3265.7 3312.1 3608.0 3969.7 29726.0 29847.3 30069.5 30792.7 30872.2 3922.2 3971.1 4015.6 4081.3 4188.0 187556.0 187878.1 187925.0 188267.0 188453.0 42774.6 42802.0 43174.8 43217.0 59464.1 40163.0 40235.2 40300.6 40303.2 40353.8 14852.3 15098.6 15190.3 15207.5 15208.5 11594.5 11624.8 11643.8 11654.8 11742.2 14356.9 14415.2 14519.3 14537.7 14582.7 5747.2 5780.3 5803.7 5871.1 5922.9 970.5 1011.9 1012.4 1035.2 1079.8 26002.7 26602.3 26953.0 27473.2 28286.2 1062.3 1064.9 1068.4 1086.0 1126.7 14998.6 15408.9 15510.4 15766.8 15998.2 345971.0 350809.0 354791.0 354851.0 355290.0 52840.5 53428.7 53443.7 53568.5 53585.7 1377.4 1389.8 1391.9 1395.6 1396.1 27515.4 28763.6 28841.0 28924.9 29043.4 45631.0 45933.1 45959.8 46035.3 46179.3 288062.0 288166.0 288441.0 288882.0 289782.0 30639.8 42543.4 42607.0 43122.8 43854.0 39314.0 39405.8 39462.8 40274.6 40720.0 34581.7 35426.8 35651.3 35850.0 36221.6 35624.6 35874.0 36182.8 36183.3 36250.0 33342.0 33360.5 35234.5 35689.3 35861.8 30858.4 31968.8 32242.0 32687.3 32715.5 24757.1 25055.4 25065.6 25185.0 25249.9 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | [#2] jquery.html Cycles:180 Average:27990.37 Median:355.60 stddev:83071.95 (23361.2%) stddev-sans-first:83279.06 06:04:00 INFO - PROCESS | 28562 | Values: 348.4 349.9 352.1 354.1 357.1 16472.5 17215.8 17512.8 17831.0 18292.5 14133.9 16253.5 16409.4 16437.8 16646.8 4927.3 5045.8 5046.0 5049.5 5061.9 4982.8 5018.9 5020.8 5025.6 5387.8 5320.1 5486.4 5510.7 5515.3 5522.6 5410.0 5412.7 5415.1 5419.3 5439.8 5236.0 5246.9 5251.8 5398.7 5399.5 13136.4 13198.3 13355.6 19418.4 21142.5 2017.6 2042.5 2072.8 2151.6 2169.3 9790.8 9811.7 9932.6 9956.2 10045.1 1842.0 1848.0 1861.2 1909.6 1921.3 60274.7 61637.4 62534.4 62954.7 63228.7 10199.4 10200.5 10220.0 10335.5 10374.9 13399.1 13461.6 13470.3 13525.5 13539.9 7584.9 7644.8 7722.7 7729.1 7768.4 7478.9 7493.5 7498.0 7527.0 7568.2 4438.9 4454.4 4461.6 4474.2 4479.5 1795.9 1820.4 1834.5 1850.8 1879.8 438.7 444.1 457.2 893.3 946.6 10564.3 11236.3 16839.9 17111.5 17489.8 720.7 820.6 827.2 907.2 930.5 8259.0 8705.7 8850.3 9017.3 9081.4 485223.0 490442.0 518192.0 518673.0 523836.0 48127.3 83488.0 84526.6 84568.6 85718.6 1078.2 1116.3 1117.3 1131.5 1136.7 16166.7 16249.7 16446.5 16456.2 16488.0 37354.4 37660.4 38248.5 38518.4 40044.4 51782.0 52859.7 52912.5 53818.7 54757.7 9691.2 9877.6 10063.6 10122.5 10149.3 11918.8 11980.6 12070.9 12122.9 18224.5 15123.5 15244.1 15383.7 15576.0 15629.2 14697.6 14908.9 14982.4 15074.7 15371.8 14919.7 14957.4 15221.5 15798.9 15851.3 9889.8 9989.8 10024.6 10103.2 10156.9 10614.7 10640.7 11258.4 15373.9 15567.5 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | [#3] mootools.html Cycles:180 Average:5072.12 Median:5925.59 stddev:2634.21 (44.5%) stddev-sans-first:2627.23 06:04:00 INFO - PROCESS | 28562 | Values: 1412.0 1417.0 1553.3 1695.4 1733.1 6303.4 6330.2 7416.0 7469.0 7559.4 7101.4 7148.5 7217.1 7234.0 7266.4 2150.4 2167.3 2195.7 2202.4 2203.2 2162.2 2189.0 2192.8 2207.1 2208.7 2166.9 2172.8 2186.2 2192.5 2213.2 2186.5 2222.3 2224.3 2230.7 2231.2 2177.2 2217.3 2217.7 2222.0 2222.1 7373.9 7441.9 7456.3 7459.8 7477.4 4474.7 4488.8 4491.2 4493.7 4516.4 2883.8 2891.2 2897.5 2915.0 2917.1 953.2 967.4 971.9 985.5 1000.9 10124.5 10150.2 10151.2 10155.9 10179.6 3914.1 3924.1 3935.9 3962.4 4032.5 8625.6 8681.4 8701.1 8706.2 8739.2 4465.5 4509.3 4514.8 4525.8 4543.4 4008.7 4081.9 4085.2 4115.7 4132.2 3342.1 3368.6 3385.1 3402.6 3424.9 985.1 996.4 1010.7 1012.6 1020.8 1046.5 1259.4 1263.9 1273.3 1292.2 6975.5 6979.6 6994.2 7003.2 7017.6 479.1 483.0 500.9 503.1 504.7 5129.6 5146.9 5192.6 5210.2 5259.9 8516.1 8623.6 8685.3 8702.3 8800.1 8608.0 8635.1 8675.3 8693.7 8716.3 6807.3 6832.0 6869.5 6879.0 6931.2 6786.9 6829.1 6854.6 6891.7 6892.9 7598.2 7813.6 7828.0 7831.9 7972.0 7884.4 8033.2 8069.0 8071.3 8073.2 5887.9 5983.5 6180.3 6293.2 6335.7 6833.3 6852.7 6854.6 6856.1 6884.2 6351.0 6498.8 6521.0 6594.8 6604.0 6182.8 6183.4 6198.5 6359.7 6394.4 6041.4 6063.6 6066.3 6095.2 6101.8 5627.5 5646.0 5661.0 5669.0 5676.2 5916.4 5934.8 5956.7 5980.8 5983.4 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | [#4] prototype.html Cycles:180 Average:5652.79 Median:6292.42 stddev:1714.10 (27.2%) stddev-sans-first:1671.59 06:04:00 INFO - PROCESS | 28562 | Values: 323.5 330.5 336.6 337.9 340.3 6166.5 6328.9 6335.2 6347.5 6354.8 6170.9 6262.6 6274.6 6284.4 6339.6 4835.8 4848.6 4850.4 4853.3 4857.7 4814.6 4839.8 4849.3 4854.5 4860.1 4706.0 4806.1 4813.5 4818.9 4819.8 4772.9 4806.4 4807.3 4810.0 4820.9 4202.2 4202.6 4211.5 4218.6 4224.5 5955.3 5985.5 5987.3 5989.4 5996.0 5441.3 5633.6 5643.9 5647.7 5664.3 6657.6 6660.6 6661.6 6662.8 6664.0 4620.5 4640.4 4646.8 4654.0 4659.7 6777.9 6930.8 6943.4 6963.6 6966.1 4738.1 4779.0 4781.2 4846.8 4853.0 4915.6 4916.3 4917.0 4917.4 4919.9 5665.3 5666.8 5671.0 5680.9 5683.7 6556.1 6713.9 6721.0 6803.5 6803.9 1695.1 1720.0 1737.5 1740.2 1754.8 1148.4 1167.4 1173.3 1185.9 1189.7 6218.2 6283.8 6300.4 6305.5 6313.1 6848.5 6852.5 6865.1 6910.6 6910.8 6146.5 6253.7 6268.9 6273.2 6314.6 3798.9 3816.5 3834.8 3847.6 3851.6 7277.1 7323.6 7361.6 7362.4 7403.2 7088.5 7210.2 7246.6 7250.5 7261.2 7351.4 7361.7 7373.2 7386.7 7390.8 6982.8 6986.0 7033.5 7036.4 7050.3 6725.7 6916.2 6925.7 6961.8 6981.5 7361.7 7369.1 7385.4 7390.8 7402.0 4708.6 4758.5 4759.6 4766.2 4772.2 6795.0 6845.4 7012.0 7065.4 7079.1 6815.7 6820.3 6849.8 6879.9 6903.9 6860.5 6862.0 6863.3 6873.9 6874.3 6599.4 6723.2 6745.5 6749.8 6761.9 6880.8 6899.7 6928.1 6943.2 6944.4 6694.6 6697.2 6734.5 6752.6 6753.3 06:04:00 INFO - PROCESS | 28562 | 06:04:00 INFO - PROCESS | 28562 | [#5] yui.html Cycles:180 Average:13204.03 Median:45866.16 stddev:15093.19 (32.9%) stddev-sans-first:15106.99 06:04:00 INFO - PROCESS | 28562 | Values: 842.2 851.1 863.3 865.9 886.8 13614.8 13732.4 13758.2 13778.5 13857.4 12574.9 12709.5 12799.2 12811.4 12839.4 804.8 805.5 818.1 819.7 821.0 815.1 815.2 817.7 819.1 822.1 843.4 844.3 846.3 847.6 854.7 835.3 842.2 844.7 845.3 845.4 625.5 626.1 626.2 626.5 627.8 13713.4 13895.0 13896.7 13916.5 13952.7 11846.8 12101.8 12363.2 12476.8 12498.5 10446.5 10465.3 10679.8 11040.4 11071.8 3614.9 3618.9 3620.6 3647.2 3752.0 44467.0 44763.6 45091.0 45170.1 45351.3 9957.9 9964.8 10013.8 10151.8 10291.5 16510.9 16514.1 16531.4 16670.4 17693.6 7427.7 7565.7 7656.7 7662.3 7721.4 4538.1 4573.4 4619.8 4622.7 4711.8 3021.9 3031.4 3034.5 3054.5 3063.1 554.9 580.7 585.6 589.7 592.9 631.4 635.9 654.8 664.7 713.5 8568.2 8594.9 8644.2 8778.2 9237.8 497.6 554.3 632.5 659.1 665.5 3809.4 3809.8 3820.2 3880.5 3983.5 48823.0 53458.5 54645.7 55244.0 55535.7 46640.0 48018.8 48071.5 48346.8 48567.0 45496.5 45811.3 45829.5 45902.8 46068.1 7705.5 7874.1 7966.7 7977.1 8041.7 33015.5 33125.8 33290.7 33652.3 34090.1 40734.4 43408.3 43513.1 43513.3 43993.8 10181.0 10268.4 10367.8 10472.4 10684.2 11199.4 11215.9 11271.7 11433.0 11878.2 9934.4 10019.1 10044.8 10315.3 11010.8 10113.8 10250.7 10472.8 10707.7 10951.8 9553.8 10348.7 10945.0 11050.5 11431.1 8135.8 8182.1 8235.9 8345.5 8478.4 8270.2 8743.4 8803.3 8985.5 9128.9 06:04:00 INFO - PROCESS | 28562 | -------- Summary: end -------- 06:04:00 INFO - PROCESS | 28562 | 06:04:01 INFO - TEST-INFO | 28562: exit 0 06:04:01 INFO - TEST-OK | dromaeo_css | took 1110138ms 06:04:01 INFO - TEST-START | kraken 06:04:01 INFO - operating with platform_type : linux_ 06:04:01 INFO - Initialising browser for kraken test... 06:04:01 INFO - TEST-INFO | started process 28798 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr7vkU6/profile http://localhost:49662/getInfo.html) 06:04:05 INFO - PROCESS | 28798 | __metrics Screen width/height:1600/1200 06:04:05 INFO - PROCESS | 28798 | colorDepth:24 06:04:05 INFO - PROCESS | 28798 | Browser inner width/height: 1024/670 06:04:05 INFO - PROCESS | 28798 | __metrics 06:04:05 INFO - PROCESS | 28798 | 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:06 INFO - TEST-INFO | 28798: exit 0 06:04:06 INFO - Browser initialized. 06:04:06 INFO - Running cycle 1/1 for kraken test... 06:04:06 INFO - TEST-INFO | started process 28916 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr7vkU6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:18 INFO - PROCESS | 28916 | RSS: Main: 149360640 06:04:18 INFO - PROCESS | 28916 | 06:04:20 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49662/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:21 INFO - PROCESS | 28916 | RSS: Main: 151977984 06:04:21 INFO - PROCESS | 28916 | 06:04:24 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49662/tests/kraken/driver.html?testName=audio-dft) 06:04:24 INFO - PROCESS | 28916 | RSS: Main: 151932928 06:04:24 INFO - PROCESS | 28916 | 06:04:27 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49662/tests/kraken/driver.html?testName=audio-fft) 06:04:28 INFO - PROCESS | 28916 | RSS: Main: 144957440 06:04:28 INFO - PROCESS | 28916 | 06:04:30 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49662/tests/kraken/driver.html?testName=audio-oscillator) 06:04:31 INFO - PROCESS | 28916 | RSS: Main: 145907712 06:04:31 INFO - PROCESS | 28916 | 06:04:33 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:33 INFO - PROCESS | 28916 | RSS: Main: 147345408 06:04:33 INFO - PROCESS | 28916 | 06:04:36 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49662/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:37 INFO - PROCESS | 28916 | RSS: Main: 147607552 06:04:37 INFO - PROCESS | 28916 | 06:04:40 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49662/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:41 INFO - PROCESS | 28916 | RSS: Main: 148135936 06:04:41 INFO - PROCESS | 28916 | 06:04:44 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49662/tests/kraken/driver.html?testName=json-parse-financial) 06:04:44 INFO - PROCESS | 28916 | RSS: Main: 148324352 06:04:44 INFO - PROCESS | 28916 | 06:04:46 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:46 INFO - PROCESS | 28916 | RSS: Main: 147742720 06:04:46 INFO - PROCESS | 28916 | 06:04:48 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:49 INFO - PROCESS | 28916 | RSS: Main: 148549632 06:04:49 INFO - PROCESS | 28916 | 06:04:51 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:52 INFO - PROCESS | 28916 | RSS: Main: 148381696 06:04:52 INFO - PROCESS | 28916 | 06:04:54 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:55 INFO - PROCESS | 28916 | RSS: Main: 148615168 06:04:55 INFO - PROCESS | 28916 | 06:04:57 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:58 INFO - PROCESS | 28916 | RSS: Main: 148811776 06:04:58 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | Cycle 1(1): loaded http://localhost:49662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49662/tests/kraken/driver.html?testName=ai-astar) 06:05:00 INFO - PROCESS | 28916 | RSS: Main: 149266432 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | __start_tp_report 06:05:00 INFO - PROCESS | 28916 | _x_x_mozilla_page_load 06:05:00 INFO - PROCESS | 28916 | _x_x_mozilla_page_load_details 06:05:00 INFO - PROCESS | 28916 | |i|pagename|runs| 06:05:00 INFO - PROCESS | 28916 | |0;ai-astar;111;105;111;110;113;122;111;111;114;117 06:05:00 INFO - PROCESS | 28916 | |1;audio-beat-detection;155;131;152;167;130;158;153;131;166;125 06:05:00 INFO - PROCESS | 28916 | |2;audio-dft;160;163;161;161;162;160;160;168;169;162 06:05:00 INFO - PROCESS | 28916 | |3;audio-fft;71;71;71;71;70;74;75;150;74;72 06:05:00 INFO - PROCESS | 28916 | |4;audio-oscillator;96;96;138;95;96;96;148;96;96;138 06:05:00 INFO - PROCESS | 28916 | |5;imaging-gaussian-blur;109;111;110;110;111;110;110;110;110;110 06:05:00 INFO - PROCESS | 28916 | |6;imaging-darkroom;146;146;146;148;147;148;147;146;147;147 06:05:00 INFO - PROCESS | 28916 | |7;imaging-desaturate;96;96;96;99;96;96;96;96;95;97 06:05:00 INFO - PROCESS | 28916 | |8;json-parse-financial;60;63;60;61;61;60;60;60;62;60 06:05:00 INFO - PROCESS | 28916 | |9;json-stringify-tinderbox;66;73;66;67;70;68;67;67;66;67 06:05:00 INFO - PROCESS | 28916 | |10;stanford-crypto-aes;85;83;85;89;85;86;89;86;85;86 06:05:00 INFO - PROCESS | 28916 | |11;stanford-crypto-ccm;121;124;131;124;134;129;120;120;119;114 06:05:00 INFO - PROCESS | 28916 | |12;stanford-crypto-pbkdf2;155;152;152;164;148;154;154;144;157;151 06:05:00 INFO - PROCESS | 28916 | |13;stanford-crypto-sha256-iterative;70;67;70;69;68;70;70;70;67;67 06:05:00 INFO - PROCESS | 28916 | __end_tp_report 06:05:00 INFO - PROCESS | 28916 | __start_cc_report 06:05:00 INFO - PROCESS | 28916 | _x_x_mozilla_cycle_collect,730 06:05:00 INFO - PROCESS | 28916 | __end_cc_report 06:05:00 INFO - PROCESS | 28916 | __startTimestamp1451138700258__endTimestamp 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | ------- Summary: start ------- 06:05:00 INFO - PROCESS | 28916 | Number of tests: 14 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.53 (4.0%) stddev-sans-first:4.77 06:05:00 INFO - PROCESS | 28916 | Values: 111.0 105.0 111.0 110.0 113.0 122.0 111.0 111.0 114.0 117.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:154.00 stddev:15.96 (10.4%) stddev-sans-first:16.65 06:05:00 INFO - PROCESS | 28916 | Values: 155.0 131.0 152.0 167.0 130.0 158.0 153.0 131.0 166.0 125.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:3.27 (2.0%) stddev-sans-first:3.33 06:05:00 INFO - PROCESS | 28916 | Values: 160.0 163.0 161.0 161.0 162.0 160.0 160.0 168.0 169.0 162.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#3] audio-fft Cycles:10 Average:79.90 Median:71.50 stddev:24.69 (34.5%) stddev-sans-first:25.97 06:05:00 INFO - PROCESS | 28916 | Values: 71.0 71.0 71.0 71.0 70.0 74.0 75.0 150.0 74.0 72.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:22.14 (23.1%) stddev-sans-first:22.93 06:05:00 INFO - PROCESS | 28916 | Values: 96.0 96.0 138.0 95.0 96.0 96.0 148.0 96.0 96.0 138.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:05:00 INFO - PROCESS | 28916 | Values: 109.0 111.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:05:00 INFO - PROCESS | 28916 | Values: 146.0 146.0 146.0 148.0 147.0 148.0 147.0 146.0 147.0 147.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 06:05:00 INFO - PROCESS | 28916 | Values: 96.0 96.0 96.0 99.0 96.0 96.0 96.0 96.0 95.0 97.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.50 stddev:1.06 (1.8%) stddev-sans-first:1.09 06:05:00 INFO - PROCESS | 28916 | Values: 60.0 63.0 60.0 61.0 61.0 60.0 60.0 60.0 62.0 60.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:2.21 (3.3%) stddev-sans-first:2.26 06:05:00 INFO - PROCESS | 28916 | Values: 66.0 73.0 66.0 67.0 70.0 68.0 67.0 67.0 66.0 67.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.85 (2.2%) stddev-sans-first:1.94 06:05:00 INFO - PROCESS | 28916 | Values: 85.0 83.0 85.0 89.0 85.0 86.0 89.0 86.0 85.0 86.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:6.13 (4.9%) stddev-sans-first:6.43 06:05:00 INFO - PROCESS | 28916 | Values: 121.0 124.0 131.0 124.0 134.0 129.0 120.0 120.0 119.0 114.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:5.32 (3.5%) stddev-sans-first:5.60 06:05:00 INFO - PROCESS | 28916 | Values: 155.0 152.0 152.0 164.0 148.0 154.0 154.0 144.0 157.0 151.0 06:05:00 INFO - PROCESS | 28916 | 06:05:00 INFO - PROCESS | 28916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:70.00 stddev:1.40 (2.0%) stddev-sans-first:1.41 06:05:00 INFO - PROCESS | 28916 | Values: 70.0 67.0 70.0 69.0 68.0 70.0 70.0 70.0 67.0 67.0 06:05:00 INFO - PROCESS | 28916 | -------- Summary: end -------- 06:05:00 INFO - PROCESS | 28916 | 06:05:01 INFO - TEST-INFO | 28916: exit 0 06:05:01 INFO - TEST-OK | kraken | took 60139ms 06:05:01 INFO - TEST-START | v8_7 06:05:01 INFO - operating with platform_type : linux_ 06:05:01 INFO - Initialising browser for v8_7 test... 06:05:01 INFO - TEST-INFO | started process 29200 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy5BJtT/profile http://localhost:49662/getInfo.html) 06:05:05 INFO - PROCESS | 29200 | __metrics Screen width/height:1600/1200 06:05:05 INFO - PROCESS | 29200 | colorDepth:24 06:05:05 INFO - PROCESS | 29200 | Browser inner width/height: 1024/670 06:05:05 INFO - PROCESS | 29200 | __metrics 06:05:06 INFO - PROCESS | 29200 | 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:05:06 INFO - TEST-INFO | 29200: exit 0 06:05:06 INFO - Browser initialized. 06:05:06 INFO - Running cycle 1/1 for v8_7 test... 06:05:06 INFO - TEST-INFO | started process 29320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy5BJtT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:18 INFO - PROCESS | 29320 | RSS: Main: 148828160 06:05:18 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | Cycle 1(1): loaded http://localhost:49662/tests/v8_7/run.html (next: http://localhost:49662/tests/v8_7/run.html) 06:05:40 INFO - PROCESS | 29320 | RSS: Main: 145747968 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | __start_tp_report 06:05:40 INFO - PROCESS | 29320 | _x_x_mozilla_page_load 06:05:40 INFO - PROCESS | 29320 | _x_x_mozilla_page_load_details 06:05:40 INFO - PROCESS | 29320 | |i|pagename|runs| 06:05:40 INFO - PROCESS | 29320 | |0;Richards;166.333998669328 06:05:40 INFO - PROCESS | 29320 | |1;DeltaBlue;190.7304978065993 06:05:40 INFO - PROCESS | 29320 | |2;Encrypt;280.0336040324839 06:05:40 INFO - PROCESS | 29320 | |3;Decrypt;5256.544502617801 06:05:40 INFO - PROCESS | 29320 | |4;RayTrace;1053.740779768177 06:05:40 INFO - PROCESS | 29320 | |5;Earley;713.7758743754462 06:05:40 INFO - PROCESS | 29320 | |6;Boyer;12243.90243902439 06:05:40 INFO - PROCESS | 29320 | |7;RegExp;25475 06:05:40 INFO - PROCESS | 29320 | |8;Splay;704.2253521126761 06:05:40 INFO - PROCESS | 29320 | |9;NavierStokes;4822.115384615385 06:05:40 INFO - PROCESS | 29320 | __end_tp_report 06:05:40 INFO - PROCESS | 29320 | __startTimestamp1451138740312__endTimestamp 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | ------- Summary: start ------- 06:05:40 INFO - PROCESS | 29320 | Number of tests: 10 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 166.3 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#1] DeltaBlue Cycles:1 Average:190.73 Median:190.73 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 190.7 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 280.0 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 5256.5 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 1053.7 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 713.8 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 12243.9 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 25475.0 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#8] Splay Cycles:1 Average:704.23 Median:704.23 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 704.2 06:05:40 INFO - PROCESS | 29320 | 06:05:40 INFO - PROCESS | 29320 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:05:40 INFO - PROCESS | 29320 | Values: 4822.1 06:05:40 INFO - PROCESS | 29320 | -------- Summary: end -------- 06:05:40 INFO - PROCESS | 29320 | 06:05:41 INFO - TEST-INFO | 29320: exit 0 06:05:41 INFO - TEST-OK | v8_7 | took 39976ms 06:05:41 INFO - SUITE-END | took 1210s 06:05:41 INFO - Completed test suite (00:20:10) 06:05:41 INFO - Working with test: dromaeo_css 06:05:41 INFO - Generating results file: dromaeo_css 06:05:41 INFO - Working with test: kraken 06:05:41 INFO - Generating results file: kraken 06:05:41 INFO - javascript benchmark 06:05:41 INFO - Working with test: v8_7 06:05:41 INFO - Generating results file: v8_7 06:05:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:05:41 INFO - process_Request line: dromaeo_css 6840.87 graph.html#tests=[[72,1,43]] 06:05:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:41 INFO - process_Request line: kraken 1524.30 graph.html#tests=[[232,1,43]] 06:05:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:41 INFO - process_Request line: v8_7 21010.91 graph.html#tests=[[230,1,43]] 06:05:41 INFO - RETURN: dromaeo_css: 6840.87 06:05:41 INFO - RETURN: kraken: 1524.30 06:05:41 INFO - RETURN: v8_7: 21010.91 06:05:41 INFO - javascript benchmark 06:05:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3136.2316232523035, 3187.888423905162, 3208.021553426207, 3234.0944535530043, 3235.4823228283462, 4962.230854217593, 5136.229565565162, 5158.329417175762, 5174.379074511059, 5229.032628963644, 5093.388793344804, 5148.433672296044, 5156.381234251895, 5211.218317252405, 5214.217867319894, 4734.289856521524, 4747.335373047776, 4755.690880092783, 4801.135795556798, 4893.314935908976, 4819.180739274332, 4820.228763397857, 4851.126797176506, 4876.9268460972935, 4914.508549145093, 4684.508126646704, 4696.718196908197, 4771.856844294659, 4798.568128868384, 4810.302506136591, 4745.098431298043, 4747.810087596492, 4761.523847615211, 4772.331873537708, 4789.880252993668, 4617.191991401525, 4739.6208303336, 4741.786619602091, 4745.098431298077, 4775.856724298276, 4985.526374994406, 4988.725620090893, 5020.071286811952, 5023.522765337287, 5054.3176671149295, 5481.616286859921, 5493.2034854946205, 5509.393966663663, 5511.889762204733, 5568.49883510482, 5512.4211957744665, 5514.889702205974, 5541.445855414467, 5564.137558678412, 5603.691796951166, 5147.253648220987, 5199.4800519948085, 5224.947750522484, 5226.97386513065, 5246.895062098775, 5683.715814209273, 5690.601657883991, 5715.31416230055, 5758.712064396764, 5759.280089988752, 5413.188021796762, 5478.753456094485, 5510.614257002052, 5555.861103472445, 5588.776448941997, 5537.141743029837, 5546.667199968015, 5548.4174161713245, 5557.888842223214, 5602.159676048625, 5486.506214440719, 5503.174523821459, 5511.862203444946, 5513.889722205534, 5525.917111243334, 5453.263809385682, 5501.697406642673, 5550.056490396642, 5550.694711790809, 5552.250446189793, 4327.870163895088, 4329.177456283296, 4348.108637729258, 4364.869053928323, 4382.035952090535, 3910.648041676263, 3911.8044097794996, 3928.5285765707727, 3948.2893079245437, 3949.3878448840474, 5070.315507406527, 5193.532582067632, 5216.37403511581, 5239.476052394806, 5267.341582302212, 5545.556355491551, 5550.16747487872, 5555.527780138653, 5562.443755624405, 5592.916106258409, 5066.417362003343, 5208.0, 5217.556507696889, 5218.165093585084, 5252.1596544552685, 4752.881177970509, 4800.855974320776, 4827.951720482821, 4842.273658951115, 4890.070886531547, 5743.913841292384, 5763.88472230553, 5764.423557644202, 5766.452187042224, 5782.537397008229, 5424.783008679608, 5503.367112782082, 5583.860403489945, 5590.189422533791, 5632.690202038927, 5747.281589801275, 5782.681952492485, 5801.129830525455, 5817.301923769175, 5843.766249349978, 5526.47498487643, 5562.193481945176, 5566.415526369673, 5567.276254086943, 5573.581981351496, 5443.047466693392, 5540.944590554042, 5596.972015139898, 5606.803761868315, 5638.041532939328, 5413.079776438094, 5418.187271909087, 5418.593605479684, 5423.376311724044, 5467.152591348347, 5401.837944861661, 5402.51377376038, 5407.405185429521, 5431.4296998816135, 5454.836354909359, 5266.526012658879, 5269.1569348903995, 5274.736263186748, 5371.973140134274, 5440.755166017618, 5433.565314774887, 5440.102383106743, 5498.0, 5509.724513774215, 5518.889622207453, 5367.973160134331, 5381.381141168816, 5394.406615272238, 5411.945880541144, 5453.263809385682], "unit": "score", "name": "dojo.html", "value": 5143.1120340394145}, {"lowerIsBetter": false, "replicates": [555.8942552793152, 576.1501784867321, 587.3069777662362, 594.3937184072249, 603.0803025386285, 35854.103647408825, 36617.0, 36857.76135744384, 36945.630543694555, 36975.445368319495, 38431.231375372474, 38742.41886371707, 39041.41437878434, 39044.41433378502, 39136.21727565447, 8535.70125045625, 8647.567621618926, 8671.0, 8679.522626255584, 8718.564071796385, 8494.235518803338, 8581.184787445183, 8584.74245772628, 8587.785305367384, 8593.0, 8585.742427727178, 8757.124287571256, 8775.824483510325, 8788.736337909873, 8813.73558793234, 8606.397552171351, 8622.870656940182, 8706.477611343307, 8822.823543529157, 8823.29413646913, 8589.0, 8759.649614015432, 8761.474311541328, 8762.518061506615, 8765.254953328975, 39795.21433499656, 40059.0, 40347.7982610088, 40353.79823100895, 40361.79819100886, 3242.7243684286864, 3265.7224135948472, 3312.1222875937897, 3607.981960090209, 3969.6824254059607, 29726.0, 29847.25381865449, 30069.548956765666, 30792.692073079208, 30872.228194295323, 3922.156736301709, 3971.146203566247, 4015.5582885882823, 4081.3265811141127, 4188.0, 187556.0, 187878.06060969608, 187925.0, 188267.0, 188453.0, 42774.57225427768, 42802.0, 43174.78412607917, 43217.0, 59464.10803837946, 40163.0, 40235.195296093916, 40300.596994029685, 40303.19393612111, 40353.79823100866, 14852.2573871306, 15098.622534436727, 15190.316435760416, 15207.467738629095, 15208.543743687707, 11594.536218551331, 11624.825627615592, 11643.76712465746, 11654.825177622342, 11742.236754610924, 14356.856431435552, 14415.207163605892, 14519.274036298142, 14537.709245815236, 14582.708345833023, 5747.195392645033, 5780.277465316835, 5803.7388317524965, 5871.148683440877, 5922.851928701817, 970.5486948568949, 1011.944343061124, 1012.372329155928, 1035.1822060572215, 1079.8002369561657, 26002.73997260041, 26602.334941626614, 26953.0, 27473.17580472589, 28286.15141545757, 1062.2564205056492, 1064.9307794993456, 1068.3643232276784, 1086.0334302470808, 1126.7464820415341, 14998.550043498712, 15408.922955385151, 15510.379584816706, 15766.842331576767, 15998.200089995453, 345971.0, 350809.0, 354791.0, 354851.0, 355290.0, 52840.471595283554, 53428.73285633547, 53443.73278133662, 53568.464315356345, 53585.73207134017, 1377.435251546861, 1389.805427240187, 1391.9095258808145, 1395.5673741140279, 1396.1343966740685, 27515.449691005666, 28763.5685464714, 28841.0, 28924.85537572383, 29043.419131616825, 45631.0, 45933.08133837371, 45959.77020114878, 46035.30947035864, 46179.30731039104, 288062.0, 288166.0, 288441.0, 288882.0, 289782.0, 30639.846800765852, 42543.3618495729, 42607.01354099425, 43122.78438607787, 43854.0, 39314.0, 39405.802970984965, 39462.80268598753, 40274.59725402708, 40720.0, 34581.654183457846, 35426.82286588551, 35651.28697426089, 35850.0, 36221.63778362182, 35624.64375356213, 35874.0, 36182.819085904404, 36183.27633447369, 36250.0, 33342.0, 33360.49959250662, 35234.47148292726, 35689.286214276086, 35861.82069089638, 30858.382832343676, 31968.840155799073, 32242.0, 32687.34625307433, 32715.509267360532, 24757.133500327403, 25055.373615659755, 25065.624015639416, 25185.0, 25249.87375063113], "unit": "score", "name": "ext.html", "value": 17769.979393940994}, {"lowerIsBetter": false, "replicates": [348.39379479705303, 349.92826470573533, 352.07755680118095, 354.0846910735749, 357.1107941226346, 16472.50582482526, 17215.827841721595, 17512.82487175128, 17831.0, 18292.451226463196, 14133.85866141341, 16253.512394628151, 16409.425670101547, 16437.753433698475, 16646.83353166468, 4927.285543596186, 5045.798168073273, 5046.016026874761, 5049.4698056704065, 5061.898762024757, 4982.825601103962, 5018.874528136807, 5020.799168033274, 5025.597952163818, 5387.757550910218, 5320.122179840322, 5486.396496385394, 5510.6969116698565, 5515.310586176728, 5522.641028333145, 5410.026195284867, 5412.675239485624, 5415.10650742627, 5419.349678038621, 5439.782408703647, 5236.0, 5246.947530524722, 5251.816186433456, 5398.676079435208, 5399.4600539945695, 13136.40886160125, 13198.274094924775, 13355.599332020054, 19418.417447476597, 21142.471438214016, 2017.6065667194903, 2042.5097976485686, 2072.813446789781, 2151.5696860627936, 2169.3275084723787, 9790.804183916282, 9811.705648830546, 9932.602695892156, 9956.15372693322, 10045.146162576117, 1841.9907900460412, 1847.9722804157948, 1861.2089861808677, 1909.5798924236785, 1921.2795201799324, 60274.69862650702, 61637.38362616361, 62534.37465625331, 62954.68522657403, 63228.68385658042, 10199.439030853226, 10200.489975501196, 10220.0, 10335.534900929477, 10374.948125259325, 13399.12905661129, 13461.596152115451, 13470.259135747432, 13525.45898164082, 13539.932300338436, 7584.924150758532, 7644.847103057908, 7722.691092356243, 7729.072511298567, 7768.41736869737, 7478.887816682645, 7493.475456717977, 7498.025256716592, 7527.0, 7568.205338439495, 4438.911221775546, 4454.418681368133, 4461.57615026572, 4474.239379305461, 4479.529649386833, 1795.9191836367395, 1820.4356649438716, 1834.4588346437833, 1850.8334249917573, 1879.8402135818335, 438.67318847458847, 444.1184249265206, 457.1816448557046, 893.3210759822582, 946.5551190940247, 10564.260501764957, 11236.269642473213, 16839.91580042092, 17111.486655400357, 17489.825101749073, 720.6792977125234, 820.5774026376421, 827.2351256760979, 907.1563445995156, 930.544033423631, 8259.0, 8705.686069803323, 8850.33622478304, 9017.323700722472, 9081.409708368936, 485223.0, 490442.0, 518192.0, 518673.0, 523836.0, 48127.278090828666, 83488.0, 84526.577367114, 84568.57715711505, 85718.57140714256, 1078.185969592968, 1116.3413585984308, 1117.3016864459712, 1131.5077941095649, 1136.72718547548, 16166.67666646637, 16249.67500650004, 16446.506604801874, 16456.177191140156, 16488.0, 37354.43968340531, 37660.43509347307, 38248.470061197244, 38518.42222366723, 40044.39933400943, 51782.0, 52859.735701321246, 52912.470875292296, 53818.73090634522, 54757.72621136869, 9691.224702023681, 9877.604895804376, 10063.597456101674, 10122.544485498318, 10149.289549731448, 11918.75656332886, 11980.58067967617, 12070.939645301718, 12122.878771212176, 18224.4532664015, 15123.470678526199, 15244.085354878744, 15383.692326153638, 15576.0, 15629.218539073228, 14697.648376259747, 14908.925455372653, 14982.40070397172, 15074.698506030038, 15371.769423458434, 14919.701605968037, 14957.40170393172, 15221.543353699406, 15798.9210053949, 15851.286692098653, 9889.752756181153, 9989.750256243651, 10024.599016039569, 10103.242256830914, 10156.898431015596, 10614.681559553226, 10640.733981650521, 11258.437078146224, 15373.923130384725, 15567.532974010797], "unit": "score", "name": "jquery.html", "value": 8678.333727102885}, {"lowerIsBetter": false, "replicates": [1411.9788203176954, 1416.9929150354246, 1553.3165407220822, 1695.3811858671572, 1733.1161107835, 6303.4011768882, 6330.177076979986, 7415.999999999994, 7468.96265518673, 7559.39524838013, 7101.431885449165, 7148.463865210117, 7217.097862767154, 7234.023406840075, 7266.382357499619, 2150.419386765572, 2167.3497950614833, 2195.681626164205, 2202.361315218585, 2203.2178576605315, 2162.1783722185546, 2188.9671654925187, 2192.8355373346985, 2207.128184367182, 2208.712867327245, 2166.869987800737, 2172.8261739060836, 2186.180182431588, 2192.4628466025847, 2213.1589995801573, 2186.464316242515, 2222.2555443926385, 2224.310463756233, 2230.7434645015705, 2231.163313757341, 2177.150911144655, 2217.2904670505445, 2217.667349897512, 2222.022310183514, 2222.055626358791, 7373.926260737378, 7441.888371674429, 7456.254374562554, 7459.776206713807, 7477.439192060618, 4474.664400169968, 4488.775561221959, 4491.214037543416, 4493.707908985905, 4516.41286632739, 2883.8413887236193, 2891.219370769901, 2897.492938735713, 2915.02346713849, 2917.081119447367, 953.2135987810016, 967.351874244258, 971.8590804333403, 985.4530735441826, 1000.9049140331657, 10124.54439550222, 10150.23873209505, 10151.187904967584, 10155.949220253851, 10179.592816287339, 3914.099757055893, 3924.0582260257333, 3935.9016024599614, 3962.425448309979, 4032.495938007749, 8625.611847466878, 8681.392302538761, 8701.086385929513, 8706.1729135732, 8739.169778870997, 4465.531119232499, 4509.346144808985, 4514.781009127517, 4525.796339164745, 4543.38664280318, 4008.679305655599, 4081.8571350002608, 4085.20338533983, 4115.691323150776, 4132.152908653718, 3342.147752323142, 3368.6294507604143, 3385.0860267727576, 3402.625711171769, 3424.931501369959, 985.0887928666099, 996.4170959988343, 1010.7068950004564, 1012.6202673997251, 1020.8162530744389, 1046.5447530324334, 1259.3640211693037, 1263.873612638747, 1273.3251376770327, 1292.2052937443405, 6975.511714179958, 6979.581225126509, 6994.160700715946, 7003.194632617314, 7017.61403122823, 479.0777752825866, 482.9879253018703, 500.9098362294749, 503.0517474560407, 504.66944151580776, 5129.640925135204, 5146.87132821675, 5192.5586325162785, 5210.166373380241, 5259.868503287448, 8516.148385161434, 8623.611937462829, 8685.261752751087, 8702.30381569473, 8800.075992020873, 8607.956960215159, 8635.093315201939, 8675.305975521944, 8693.652253909899, 8716.259117975043, 6807.319268073153, 6832.0435139081565, 6869.450443964471, 6878.965605171942, 6931.202911665122, 6786.8642627148165, 6829.146356705412, 6854.6229957352825, 6891.724331026903, 6892.896606550806, 7598.240175982579, 7813.648385822538, 7828.0, 7831.882521762064, 7972.0, 7884.4086693497065, 8033.236842499953, 8069.0, 8071.313938315309, 8073.233042860918, 5887.852803679943, 5983.521318294439, 6180.320164781961, 6293.213348331458, 6335.746570137143, 6833.3166683331265, 6852.725890964306, 6854.6229957352825, 6856.074429951893, 6884.208316043719, 6351.0, 6498.805035848932, 6520.967395162994, 6594.802155935329, 6604.0, 6182.752689892533, 6183.350748171377, 6198.535109866688, 6359.713812878339, 6394.360563943755, 6041.426064523863, 6063.636181829104, 6066.272047354346, 6095.238095238095, 6101.786437474667, 5627.52166065889, 5645.971770141123, 5661.037623604079, 5669.036263835075, 5676.2337084493065, 5916.378780228014, 5934.792282270272, 5956.731947062306, 5980.820575382745, 5983.37174596661], "unit": "score", "name": "mootools.html", "value": 4125.631541062693}, {"lowerIsBetter": false, "replicates": [323.5341108803323, 330.4547496630559, 336.55910756908435, 337.90707555422256, 340.27181830881904, 6166.53750968678, 6328.905066423996, 6335.208098987627, 6347.523935704823, 6354.7775827846035, 6170.907436388457, 6262.592931459452, 6274.623522588648, 6284.434400903918, 6339.587926784768, 4835.782389792459, 4848.587870031034, 4850.44219914709, 4853.344798452216, 4857.708537487744, 4814.590759785422, 4839.830605928793, 4849.296851956464, 4854.490278520758, 4860.05228980349, 4705.976470117645, 4806.0628177505405, 4813.470518242991, 4818.855434336975, 4819.7590120494015, 4772.90454190916, 4806.399200099988, 4807.326974223594, 4809.951900480985, 4820.927686084711, 4202.201581699467, 4202.642775364097, 4211.4946206455115, 4218.578142185787, 4224.5353011168745, 5955.285365756094, 5985.461308482258, 5987.281526216838, 5989.3711160327975, 5995.970020149915, 5441.347038355423, 5633.63381380209, 5643.943560564383, 5647.689377084259, 5664.348599911022, 6657.600543967377, 6660.633665148415, 6661.566998145154, 6662.833429164261, 6664.0, 4620.514845941161, 4640.443146822403, 4646.814127434898, 4654.0, 4659.720416775004, 6777.932220677829, 6930.792076237721, 6943.409810166091, 6963.582185068912, 6966.094407726963, 4738.147133515931, 4778.976105119522, 4781.2350023996, 4846.7818948147415, 4853.0, 4915.606751459874, 4916.311716359713, 4917.016596680678, 4917.385326834145, 4919.926201106986, 5665.263515742927, 5666.829995100154, 5671.035923892948, 5680.943190568124, 5683.715814209273, 6556.082148499214, 6713.865722685519, 6721.0, 6803.48973826965, 6803.897941530881, 1695.1100672146974, 1720.0195888343774, 1737.54823745827, 1740.2342969093559, 1754.8420642142269, 1148.3569201247328, 1167.3637867362308, 1173.284296579103, 1185.9407029648482, 1189.7382575833303, 6218.160548326008, 6283.842903927347, 6300.401461861115, 6305.527085468608, 6313.084602732578, 6848.486363522656, 6852.5203235774015, 6865.0732151159955, 6910.619915904674, 6910.827229319308, 6146.508279337642, 6253.749850005949, 6268.937310626927, 6273.215848018997, 6314.55798094129, 3798.867039653599, 3816.5229346331707, 3834.7699138051807, 3847.5575308839284, 3851.5556666250154, 7277.053982982285, 7323.633818309063, 7361.558306501627, 7362.4478164136835, 7403.185649578542, 7088.468364872655, 7210.170830354471, 7246.637668116573, 7250.492465527468, 7261.164966028869, 7351.448641351813, 7361.668724907392, 7373.188949215582, 7386.74146404884, 7390.778276651817, 6982.79051628452, 6986.0, 7033.542819716702, 7036.437085033082, 7050.330218629222, 6725.663716814238, 6916.170059592881, 6925.68834402443, 6961.79114626562, 6981.476389270723, 7361.705531778669, 7369.078865141857, 7385.446091543263, 7390.778276651709, 7402.037735094404, 4708.599769019672, 4758.5241475852135, 4759.571638552547, 4766.189747742961, 4772.164871147605, 6794.966025169842, 6845.418139458003, 7011.964940175267, 7065.434765218667, 7079.115110611174, 6815.693293801692, 6820.31796820314, 6849.794506164823, 6879.89680154788, 6903.896441553481, 6860.48546359035, 6862.0, 6863.347981941708, 6873.931260687329, 6874.312568743286, 6599.373059559334, 6723.159605049369, 6745.460363171032, 6749.831254218488, 6761.93238067613, 6880.759173428906, 6899.655017249218, 6928.1339832520935, 6943.166819981635, 6944.444444444332, 6694.631795251308, 6697.162854643169, 6734.494912881455, 6752.561083529751, 6753.2909044549615], "unit": "score", "name": "prototype.html", "value": 5090.475543322934}, {"lowerIsBetter": false, "replicates": [842.2083241752756, 851.0553584137521, 863.2921004776086, 865.900421451533, 886.83593535196, 13614.795778063324, 13732.382042808073, 13758.174509529435, 13778.517751878686, 13857.445702171914, 12574.937125314384, 12709.491620335199, 12799.232046077243, 12811.42348594313, 12839.42222599983, 804.8148925747082, 805.4804651000117, 818.0510607695074, 819.7294892685429, 820.9507429554246, 815.1400272712286, 815.2255357410454, 817.697451942782, 819.0908092017855, 822.1039067416515, 843.3716880923721, 844.2781421884292, 846.2848892685702, 847.5846835050843, 854.692310768123, 835.2733122183678, 842.2083241752763, 844.6705784743893, 845.2561745663808, 845.3786466946789, 625.5121005615628, 626.1328060636051, 626.1734510446213, 626.5207116555838, 627.7991042866284, 13713.382897769625, 13895.027348085638, 13896.652583685387, 13916.512922047781, 13952.720945581133, 11846.81531846817, 12101.757964840654, 12363.196392234477, 12476.8128478072, 12498.500059997588, 10446.529906154241, 10465.319754215952, 10679.83980240297, 11040.447977601088, 11071.833922491169, 3614.9277014459826, 3618.9276214475562, 3620.601733809279, 3647.1976165243605, 3751.981240093782, 44467.0, 44763.552364476265, 45091.0, 45170.09659806819, 45351.31973020407, 9957.850632240523, 9964.800703986024, 10013.79972400548, 10151.847722284172, 10291.485425728684, 16510.917445412695, 16514.091724955004, 16531.421400250932, 16670.416535421202, 17693.646127077387, 7427.740029098955, 7565.659545320474, 7656.693732250759, 7662.3487003604205, 7721.420893433015, 4538.11506756186, 4573.359729637853, 4619.792109355087, 4622.653301002439, 4711.81152753886, 3021.8942337018098, 3031.378567393679, 3034.5296479045783, 3054.511278195478, 3063.0657649416694, 554.9306336707912, 580.6719203649924, 585.5842351930092, 589.6609449566516, 592.9288485381695, 631.409631994087, 635.8664680417072, 654.8068319845657, 664.7208172567533, 713.5255055388212, 8568.228859402683, 8594.914050859412, 8644.178803013703, 8778.209961103532, 9237.815243695088, 497.56711660855285, 554.3154204557369, 632.4971647540125, 659.1365311442026, 665.4975493502375, 3809.4095415210686, 3809.8095095245126, 3820.1595648957186, 3880.4567360569545, 3983.5418926823786, 48823.0, 53458.46541534612, 54645.72677136589, 55244.0, 55535.722321388945, 46640.0, 48018.75990620025, 48071.5192848067, 48346.758266208446, 48567.0, 45496.54503454989, 45811.3128303069, 45829.54170458319, 45902.770486147354, 46068.078638427716, 7705.499142555716, 7874.1338452769005, 7966.721164759206, 7977.122516523294, 8041.673123934485, 33015.50476742899, 33125.83437082799, 33290.69252325703, 33652.3269534603, 34090.14774630654, 40734.38898416467, 43408.34887476627, 43513.129737404444, 43513.34729978989, 43993.78003109964, 10181.0, 10268.383896966207, 10367.844482332923, 10472.371657700562, 10684.198685098494, 11199.440027998404, 11215.943920280346, 11271.718207044889, 11433.0, 11878.168528203289, 9934.354266972623, 10019.148372388428, 10044.849327259952, 10315.27793054479, 11010.834837477605, 10113.797724045331, 10250.692479225636, 10472.790544189225, 10707.732306692395, 10951.83572246401, 9553.761155970878, 10348.678372369031, 10945.0, 11050.502727377127, 11431.142664300045, 8135.755927321953, 8182.140875208018, 8235.917640823514, 8345.457545259538, 8478.448900821428, 8270.172982701682, 8743.431676940978, 8803.29573634095, 8985.505797181218, 9128.863067053866], "unit": "score", "name": "yui.html", "value": 6152.233821560308}], "name": "dromaeo_css", "value": 6840.875343215852}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 110.0, 113.0, 122.0, 111.0, 111.0, 114.0, 117.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 152.0, 167.0, 130.0, 158.0, 153.0, 131.0, 166.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 161.0, 161.0, 162.0, 160.0, 160.0, 168.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 70.0, 74.0, 75.0, 150.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 96.0, 96.0, 148.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 99.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 62.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [66.0, 73.0, 66.0, 67.0, 70.0, 68.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 85.0, 89.0, 85.0, 86.0, 89.0, 86.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 131.0, 124.0, 134.0, 129.0, 120.0, 120.0, 119.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [155.0, 152.0, 152.0, 164.0, 148.0, 154.0, 154.0, 144.0, 157.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.1}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 70.0, 69.0, 68.0, 70.0, 70.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1524.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [190.7304978065993], "unit": "score", "name": "DeltaBlue", "value": 346.65667399999995}, {"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": [1053.740779768177], "unit": "score", "name": "RayTrace", "value": 702.2495610000001}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [704.2253521126761], "unit": "score", "name": "Splay", "value": 115.71722000000001}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21010.91018662991}]} 06:05:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21010.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1524.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6840.87"}}} 06:05:41 INFO - Return code: 0 06:05:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:05:41 INFO - # TBPL SUCCESS # 06:05:41 INFO - Running post-action listener: _resource_record_post_action 06:05:41 INFO - Running post-run listener: _resource_record_post_run 06:05:42 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 555708416; Read time: 36; Write time: 402656 06:05:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235077632; Read time: 0; Write time: 216800 06:05:42 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 24576; Write bytes: 320630784; Read time: 36; Write time: 185856 06:05:42 INFO - Running post-run listener: _upload_blobber_files 06:05:42 INFO - Blob upload gear active. 06:05:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:05:42 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:05:42 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:05:42 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:05:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:44 INFO - (blobuploader) - INFO - Done attempting. 06:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:44 INFO - (blobuploader) - INFO - Done attempting. 06:05:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:05:44 INFO - Return code: 0 06:05:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:05:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:05:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f62d400dd0546688de7c833291c7cff0c8dd8607fc626526b3884e671e9f15439497e7929d850560b049fcaf616253d2119447d06fc8594b1a6028fb5c869565", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4681260e2b9412f53a263e33d524dcc52c9ca165721795895361ffe4b1c54716cbbc9af24179439d7c6a54749c0864ab1cf5d6e0c1e962caf88ad9dd680ff0c9"} 06:05:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:05:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:05:44 INFO - Contents: 06:05:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f62d400dd0546688de7c833291c7cff0c8dd8607fc626526b3884e671e9f15439497e7929d850560b049fcaf616253d2119447d06fc8594b1a6028fb5c869565", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4681260e2b9412f53a263e33d524dcc52c9ca165721795895361ffe4b1c54716cbbc9af24179439d7c6a54749c0864ab1cf5d6e0c1e962caf88ad9dd680ff0c9"} 06:05:44 INFO - Copying logs to upload dir... 06:05:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.268344 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-26 06:05:44.081736) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 06:05:44.085583) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 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/f62d400dd0546688de7c833291c7cff0c8dd8607fc626526b3884e671e9f15439497e7929d850560b049fcaf616253d2119447d06fc8594b1a6028fb5c869565", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4681260e2b9412f53a263e33d524dcc52c9ca165721795895361ffe4b1c54716cbbc9af24179439d7c6a54749c0864ab1cf5d6e0c1e962caf88ad9dd680ff0c9"} build_url:https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/Pj4bN_IdSdCkZ5MUBBIT4g/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/f62d400dd0546688de7c833291c7cff0c8dd8607fc626526b3884e671e9f15439497e7929d850560b049fcaf616253d2119447d06fc8594b1a6028fb5c869565", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4681260e2b9412f53a263e33d524dcc52c9ca165721795895361ffe4b1c54716cbbc9af24179439d7c6a54749c0864ab1cf5d6e0c1e962caf88ad9dd680ff0c9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 06:05:44.110525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 06:05:44.110897) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451132438.754271-1413329615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 06:05:44.193849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 06:05:44.194166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 06:05:44.194458) ========= ========= Total master_lag: 0.26 =========