builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1450439313.67 results: success (0) buildid: 20151218013002 builduid: 5f078149d91e480fbd2d87e2d33b9368 revision: d47e90499b87c267ed261ea6762b85afde5b8a28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.670226) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.671031) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.671440) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.705165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.705470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.730840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.731106) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.786931) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.787216) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.787604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.787921) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 03:48:34-- 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% 223M=0s 2015-12-18 03:48:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128056 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.936127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.936433) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016068 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.990002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.990315) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d47e90499b87c267ed261ea6762b85afde5b8a28 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d47e90499b87c267ed261ea6762b85afde5b8a28 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 03:48:34,353 truncating revision to first 12 chars 2015-12-18 03:48:34,353 Setting DEBUG logging. 2015-12-18 03:48:34,353 attempt 1/10 2015-12-18 03:48:34,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d47e90499b87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 03:48:34,810 unpacking tar archive at: mozilla-inbound-d47e90499b87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.763963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.764340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.775000) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.775380) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.775848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-18 03:48:34.776156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:35 INFO - MultiFileLogger online at 20151218 03:48:35 in /builds/slave/test-pgo 03:48:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:48:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:48:35 INFO - {'append_to_log': False, 03:48:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:48:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:48:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:48:35 INFO - 'branch': 'Mozilla-Inbound', 03:48:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:35 INFO - 'config_files': ('talos/linux_config.py',), 03:48:35 INFO - 'default_actions': ('clobber', 03:48:35 INFO - 'read-buildbot-config', 03:48:35 INFO - 'download-and-extract', 03:48:35 INFO - 'populate-webroot', 03:48:35 INFO - 'create-virtualenv', 03:48:35 INFO - 'install', 03:48:35 INFO - 'run-tests'), 03:48:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:35 INFO - 'download_minidump_stackwalk': True, 03:48:35 INFO - 'download_symbols': 'ondemand', 03:48:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:35 INFO - 'installer_path': 'installer.exe', 03:48:35 INFO - 'log_level': 'info', 03:48:35 INFO - 'log_name': 'talos', 03:48:35 INFO - 'log_to_console': True, 03:48:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:35 INFO - 'opt_config_files': (), 03:48:35 INFO - 'pip_index': False, 03:48:35 INFO - 'sps_profile': False, 03:48:35 INFO - 'sps_profile_interval': 0, 03:48:35 INFO - 'suite': 'dromaeojs-e10s', 03:48:35 INFO - 'system_bits': '64', 03:48:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:35 INFO - 'title': 'talos-linux64-ix-037', 03:48:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:35 INFO - 'use_talos_json': True, 03:48:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:48:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:35 INFO - 'work_dir': 'build'} 03:48:35 INFO - ##### 03:48:35 INFO - ##### Running clobber step. 03:48:35 INFO - ##### 03:48:35 INFO - Running pre-action listener: _resource_record_pre_action 03:48:35 INFO - Running main action method: clobber 03:48:35 INFO - rmtree: /builds/slave/test-pgo/build 03:48:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:48:36 INFO - Running post-action listener: _resource_record_post_action 03:48:36 INFO - ##### 03:48:36 INFO - ##### Running read-buildbot-config step. 03:48:36 INFO - ##### 03:48:36 INFO - Running pre-action listener: _resource_record_pre_action 03:48:36 INFO - Running main action method: read_buildbot_config 03:48:36 INFO - Using buildbot properties: 03:48:36 INFO - { 03:48:36 INFO - "project": "", 03:48:36 INFO - "product": "firefox", 03:48:36 INFO - "script_repo_revision": "production", 03:48:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:48:36 INFO - "repository": "", 03:48:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:48:36 INFO - "buildid": "20151218013002", 03:48:36 INFO - "pgo_build": "True", 03:48:36 INFO - "basedir": "/builds/slave/test-pgo", 03:48:36 INFO - "buildnumber": 246, 03:48:36 INFO - "slavename": "talos-linux64-ix-037", 03:48:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:48:36 INFO - "platform": "ubuntu64_hw", 03:48:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:48:36 INFO - "branch": "mozilla-inbound", 03:48:36 INFO - "repo_path": "integration/mozilla-inbound", 03:48:36 INFO - "revision": "d47e90499b87c267ed261ea6762b85afde5b8a28", 03:48:36 INFO - "stage_platform": "linux64-pgo", 03:48:36 INFO - "builduid": "5f078149d91e480fbd2d87e2d33b9368", 03:48:36 INFO - "slavebuilddir": "test" 03:48:36 INFO - } 03:48:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:48:36 INFO - Running post-action listener: _resource_record_post_action 03:48:36 INFO - ##### 03:48:36 INFO - ##### Running download-and-extract step. 03:48:36 INFO - ##### 03:48:36 INFO - Running pre-action listener: _resource_record_pre_action 03:48:36 INFO - Running main action method: download_and_extract 03:48:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:36 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json 03:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json 03:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:48:45 INFO - Downloaded 1302 bytes. 03:48:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:48:45 INFO - Using the following test package requirements: 03:48:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'jsshell-linux-x86_64.zip'], 03:48:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48: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')]} 03:48:45 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:52 INFO - Downloaded 23121183 bytes. 03:48:52 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 03:48:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:52 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 03:48:53 INFO - Return code: 0 03:48:53 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 03:48: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')]} 03:48:53 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:54 INFO - Downloaded 23121183 bytes. 03:48:54 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 03:48:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:54 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 03:48:56 INFO - Return code: 0 03:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:56 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:48:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:56 INFO - Downloaded 11132185 bytes. 03:48:56 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 03:48:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:56 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 03:48:57 INFO - Return code: 0 03:48:57 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')]} 03:48:57 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:48:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:49:01 INFO - Downloaded 54647430 bytes. 03:49:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:49:01 INFO - mkdir: /builds/slave/test-pgo/properties 03:49:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:49:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:49:01 INFO - Contents: 03:49:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:49:01 INFO - Running post-action listener: _resource_record_post_action 03:49:01 INFO - Running post-action listener: set_extra_try_arguments 03:49:01 INFO - ##### 03:49:01 INFO - ##### Running populate-webroot step. 03:49:01 INFO - ##### 03:49:01 INFO - Running pre-action listener: _resource_record_pre_action 03:49:01 INFO - Running main action method: populate_webroot 03:49:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:49:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:49:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:49:01 INFO - '--tppagecycles', 03:49:01 INFO - '7'], 03:49:01 INFO - 'tests': ['tsvgm']}}, 03:49:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:49:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:49:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:49:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:49:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'tests': ['damp', 'tps']}, 03:49:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['damp', 'tps']}, 03:49:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:49:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:01 INFO - 'other': {'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore']}, 03:49:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore']}, 03:49:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore']}, 03:49:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore']}, 03:49:01 INFO - 'other_l64': {'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore']}, 03:49:01 INFO - 'other_nol64': {'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore']}, 03:49:01 INFO - 'svgr': {'tests': ['tsvgx', 03:49:01 INFO - 'tsvgr_opacity', 03:49:01 INFO - 'tart', 03:49:01 INFO - 'tscrollx', 03:49:01 INFO - 'cart']}, 03:49:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['tsvgx', 03:49:01 INFO - 'tsvgr_opacity', 03:49:01 INFO - 'tart', 03:49:01 INFO - 'tscrollx', 03:49:01 INFO - 'cart']}, 03:49:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'tests': ['tp5o']}, 03:49:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--e10s'], 03:49:01 INFO - 'tests': ['tp5o']}, 03:49:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--xperf_path', 03:49:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:01 INFO - 'tests': ['tp5n']}, 03:49:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--e10s', 03:49:01 INFO - '--xperf_path', 03:49:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:01 INFO - 'tests': ['tp5n']}}, 03:49:01 INFO - 'talos.zip': {'path': '', 03:49:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:49:01 INFO - Running post-action listener: _resource_record_post_action 03:49:01 INFO - ##### 03:49:01 INFO - ##### Running create-virtualenv step. 03:49:01 INFO - ##### 03:49:01 INFO - Running pre-action listener: _resource_record_pre_action 03:49:01 INFO - Running main action method: create_virtualenv 03:49:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:49:01 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 03:49:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:49:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:01 INFO - Using real prefix '/usr' 03:49:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:49:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:04 INFO - Installing pip.................done. 03:49:04 INFO - Return code: 0 03:49:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:49: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')]} 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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', '--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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:04 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 03:49:04 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 03:49:04 INFO - Using env: {'DISPLAY': ':0', 03:49:04 INFO - 'HOME': '/home/cltbld', 03:49:04 INFO - 'LANG': 'en_US.UTF-8', 03:49:04 INFO - 'LANGUAGE': 'en_US:en', 03:49:04 INFO - 'LOGNAME': 'cltbld', 03:49:04 INFO - 'MAIL': '/var/mail/cltbld', 03:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:04 INFO - 'MOZ_NO_REMOTE': '1', 03:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:04 INFO - 'NO_EM_RESTART': '1', 03:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:04 INFO - 'SHELL': '/bin/bash', 03:49:04 INFO - 'SHLVL': '1', 03:49:04 INFO - 'TERM': 'linux', 03:49:04 INFO - 'TMOUT': '86400', 03:49:04 INFO - 'USER': 'cltbld', 03:49:04 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:04 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 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 03:49:04 INFO - Cleaning up... 03:49:04 INFO - Return code: 0 03:49:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:49: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')]} 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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', '--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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:04 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 03:49:04 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 03:49:04 INFO - Using env: {'DISPLAY': ':0', 03:49:04 INFO - 'HOME': '/home/cltbld', 03:49:04 INFO - 'LANG': 'en_US.UTF-8', 03:49:04 INFO - 'LANGUAGE': 'en_US:en', 03:49:04 INFO - 'LOGNAME': 'cltbld', 03:49:04 INFO - 'MAIL': '/var/mail/cltbld', 03:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:04 INFO - 'MOZ_NO_REMOTE': '1', 03:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:04 INFO - 'NO_EM_RESTART': '1', 03:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:04 INFO - 'SHELL': '/bin/bash', 03:49:04 INFO - 'SHLVL': '1', 03:49:04 INFO - 'TERM': 'linux', 03:49:04 INFO - 'TMOUT': '86400', 03:49:04 INFO - 'USER': 'cltbld', 03:49:04 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:04 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 INFO - Downloading/unpacking psutil>=0.7.1 03:49:04 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 03:49:04 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 03:49:04 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 03:49:04 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 03:49:04 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 03:49:04 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 03:49:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:49:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:06 INFO - Installing collected packages: psutil 03:49:06 INFO - Running setup.py install for psutil 03:49:06 INFO - building 'psutil._psutil_linux' extension 03:49:06 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 03:49:06 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 03:49:06 INFO - building 'psutil._psutil_posix' extension 03:49:06 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 03:49:06 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 03:49:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:06 INFO - Successfully installed psutil 03:49:06 INFO - Cleaning up... 03:49:06 INFO - Return code: 0 03:49:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:06 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 03:49:06 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 03:49:06 INFO - Using env: {'DISPLAY': ':0', 03:49:06 INFO - 'HOME': '/home/cltbld', 03:49:06 INFO - 'LANG': 'en_US.UTF-8', 03:49:06 INFO - 'LANGUAGE': 'en_US:en', 03:49:06 INFO - 'LOGNAME': 'cltbld', 03:49:06 INFO - 'MAIL': '/var/mail/cltbld', 03:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:06 INFO - 'MOZ_NO_REMOTE': '1', 03:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:06 INFO - 'NO_EM_RESTART': '1', 03:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:06 INFO - 'SHELL': '/bin/bash', 03:49:06 INFO - 'SHLVL': '1', 03:49:06 INFO - 'TERM': 'linux', 03:49:06 INFO - 'TMOUT': '86400', 03:49:06 INFO - 'USER': 'cltbld', 03:49:06 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:06 INFO - '_': '/tools/buildbot/bin/python'} 03:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:49:07 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 03:49:07 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 03:49:07 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 03:49:07 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 03:49:07 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 03:49:07 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 03:49:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:49:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:49:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:49:08 INFO - Installing collected packages: mozsystemmonitor 03:49:08 INFO - Running setup.py install for mozsystemmonitor 03:49:09 INFO - Successfully installed mozsystemmonitor 03:49:09 INFO - Cleaning up... 03:49:09 INFO - Return code: 0 03:49:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:49:09 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')]} 03:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:09 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')]} 03:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:09 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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:09 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 03:49:09 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 03:49:09 INFO - Using env: {'DISPLAY': ':0', 03:49:09 INFO - 'HOME': '/home/cltbld', 03:49:09 INFO - 'LANG': 'en_US.UTF-8', 03:49:09 INFO - 'LANGUAGE': 'en_US:en', 03:49:09 INFO - 'LOGNAME': 'cltbld', 03:49:09 INFO - 'MAIL': '/var/mail/cltbld', 03:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:09 INFO - 'MOZ_NO_REMOTE': '1', 03:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:09 INFO - 'NO_EM_RESTART': '1', 03:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:09 INFO - 'SHELL': '/bin/bash', 03:49:09 INFO - 'SHLVL': '1', 03:49:09 INFO - 'TERM': 'linux', 03:49:09 INFO - 'TMOUT': '86400', 03:49:09 INFO - 'USER': 'cltbld', 03:49:09 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:09 INFO - '_': '/tools/buildbot/bin/python'} 03:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:49:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:11 INFO - Downloading docopt-0.6.1.tar.gz 03:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:11 INFO - Running setup.py install for blobuploader 03:49:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:49:11 INFO - Running setup.py install for requests 03:49:12 INFO - Running setup.py install for docopt 03:49:12 INFO - Successfully installed blobuploader requests docopt 03:49:12 INFO - Cleaning up... 03:49:12 INFO - Return code: 0 03:49:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:12 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')]} 03:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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')]} 03:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:12 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 03:49:12 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 03:49:12 INFO - Using env: {'DISPLAY': ':0', 03:49:12 INFO - 'HOME': '/home/cltbld', 03:49:12 INFO - 'LANG': 'en_US.UTF-8', 03:49:12 INFO - 'LANGUAGE': 'en_US:en', 03:49:12 INFO - 'LOGNAME': 'cltbld', 03:49:12 INFO - 'MAIL': '/var/mail/cltbld', 03:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:12 INFO - 'MOZ_NO_REMOTE': '1', 03:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:12 INFO - 'NO_EM_RESTART': '1', 03:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:12 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:12 INFO - 'SHELL': '/bin/bash', 03:49:12 INFO - 'SHLVL': '1', 03:49:12 INFO - 'TERM': 'linux', 03:49:12 INFO - 'TMOUT': '86400', 03:49:12 INFO - 'USER': 'cltbld', 03:49:12 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:12 INFO - '_': '/tools/buildbot/bin/python'} 03:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:12 INFO - Running setup.py (path:/tmp/pip-NwuneL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:12 INFO - Running setup.py (path:/tmp/pip-tx7RUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:12 INFO - Running setup.py (path:/tmp/pip-9rddpD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:12 INFO - Running setup.py (path:/tmp/pip-461WjE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:12 INFO - Running setup.py (path:/tmp/pip-GGJyDO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:12 INFO - Running setup.py (path:/tmp/pip-589fl_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:12 INFO - Running setup.py (path:/tmp/pip-DQc9zg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:13 INFO - Running setup.py (path:/tmp/pip-Igo6vN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:13 INFO - Running setup.py (path:/tmp/pip-chZDHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:13 INFO - Running setup.py (path:/tmp/pip-Jx0mPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:13 INFO - Running setup.py (path:/tmp/pip-dMqyjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:13 INFO - Running setup.py (path:/tmp/pip-bV7qQt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:13 INFO - Running setup.py (path:/tmp/pip-6XxZ3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:13 INFO - Running setup.py (path:/tmp/pip-7jB6iI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:13 INFO - Running setup.py (path:/tmp/pip-p30k0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:13 INFO - Running setup.py (path:/tmp/pip-aHF45e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:13 INFO - Running setup.py (path:/tmp/pip-j6olWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:13 INFO - Running setup.py install for manifestparser 03:49:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozcrash 03:49:13 INFO - Running setup.py install for mozdebug 03:49:14 INFO - Running setup.py install for mozdevice 03:49:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Running setup.py install for mozfile 03:49:14 INFO - Running setup.py install for mozhttpd 03:49:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Running setup.py install for mozinfo 03:49:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Running setup.py install for mozInstall 03:49:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Running setup.py install for mozleak 03:49:14 INFO - Running setup.py install for mozlog 03:49:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Running setup.py install for moznetwork 03:49:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Running setup.py install for mozprocess 03:49:15 INFO - Running setup.py install for mozprofile 03:49:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:49:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:49:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:49:15 INFO - Running setup.py install for mozrunner 03:49:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:49:15 INFO - Running setup.py install for mozscreenshot 03:49:15 INFO - Running setup.py install for moztest 03:49:15 INFO - Running setup.py install for mozversion 03:49:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:49:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:15 INFO - Cleaning up... 03:49:15 INFO - Return code: 0 03:49:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:15 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')]} 03:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:15 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')]} 03:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:15 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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:15 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 03:49:15 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 03:49:15 INFO - Using env: {'DISPLAY': ':0', 03:49:15 INFO - 'HOME': '/home/cltbld', 03:49:15 INFO - 'LANG': 'en_US.UTF-8', 03:49:15 INFO - 'LANGUAGE': 'en_US:en', 03:49:15 INFO - 'LOGNAME': 'cltbld', 03:49:15 INFO - 'MAIL': '/var/mail/cltbld', 03:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:15 INFO - 'MOZ_NO_REMOTE': '1', 03:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:15 INFO - 'NO_EM_RESTART': '1', 03:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:15 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:15 INFO - 'SHELL': '/bin/bash', 03:49:15 INFO - 'SHLVL': '1', 03:49:15 INFO - 'TERM': 'linux', 03:49:15 INFO - 'TMOUT': '86400', 03:49:15 INFO - 'USER': 'cltbld', 03:49:15 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:15 INFO - '_': '/tools/buildbot/bin/python'} 03:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:15 INFO - Running setup.py (path:/tmp/pip-POod54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:15 INFO - Running setup.py (path:/tmp/pip-EzwbLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:15 INFO - Running setup.py (path:/tmp/pip-pujeaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:16 INFO - Running setup.py (path:/tmp/pip-wdP_Ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:16 INFO - Running setup.py (path:/tmp/pip-jsDp3t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:16 INFO - Running setup.py (path:/tmp/pip-YQJO3Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:16 INFO - Running setup.py (path:/tmp/pip-rgg8Mf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:16 INFO - Running setup.py (path:/tmp/pip-5ddPh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:16 INFO - Running setup.py (path:/tmp/pip-ifzSwt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:16 INFO - Running setup.py (path:/tmp/pip-ApQFIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:16 INFO - Running setup.py (path:/tmp/pip-IP5BsO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:16 INFO - Running setup.py (path:/tmp/pip-b_EePz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:16 INFO - Running setup.py (path:/tmp/pip-h5jaaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:16 INFO - Running setup.py (path:/tmp/pip-WVGW7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:16 INFO - Running setup.py (path:/tmp/pip-bL5FnJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:16 INFO - Running setup.py (path:/tmp/pip-UKBxlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:16 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)) 03:49:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:16 INFO - Running setup.py (path:/tmp/pip-oQEjZA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:16 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)) 03:49:16 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)) 03:49:16 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)) 03:49:16 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)) 03:49:16 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)) 03:49:16 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)) 03:49:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:17 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 03:49:17 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 03:49:17 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 03:49:17 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 03:49:17 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 03:49:17 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 03:49:18 INFO - Downloading blessings-1.5.1.tar.gz 03:49:18 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 03:49:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:18 INFO - Installing collected packages: blessings 03:49:18 INFO - Running setup.py install for blessings 03:49:19 INFO - Successfully installed blessings 03:49:19 INFO - Cleaning up... 03:49:19 INFO - Return code: 0 03:49:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:49:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:19 INFO - Reading from file tmpfile_stdout 03:49:19 INFO - Current package versions: 03:49:19 INFO - argparse == 1.2.1 03:49:19 INFO - blessings == 1.5.1 03:49:19 INFO - blobuploader == 1.2.4 03:49:19 INFO - docopt == 0.6.1 03:49:19 INFO - manifestparser == 1.1 03:49:19 INFO - mozInstall == 1.12 03:49:19 INFO - mozcrash == 0.16 03:49:19 INFO - mozdebug == 0.1 03:49:19 INFO - mozdevice == 0.47 03:49:19 INFO - mozfile == 1.2 03:49:19 INFO - mozhttpd == 0.7 03:49:19 INFO - mozinfo == 0.9 03:49:19 INFO - mozleak == 0.1 03:49:19 INFO - mozlog == 3.1 03:49:19 INFO - moznetwork == 0.27 03:49:19 INFO - mozprocess == 0.22 03:49:19 INFO - mozprofile == 0.27 03:49:19 INFO - mozrunner == 6.11 03:49:19 INFO - mozscreenshot == 0.1 03:49:19 INFO - mozsystemmonitor == 0.0 03:49:19 INFO - moztest == 0.7 03:49:19 INFO - mozversion == 1.4 03:49:19 INFO - psutil == 3.1.1 03:49:19 INFO - requests == 1.2.3 03:49:19 INFO - wsgiref == 0.1.2 03:49:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:19 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')]} 03:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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')]} 03:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:19 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 03:49:19 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 03:49:19 INFO - Using env: {'DISPLAY': ':0', 03:49:19 INFO - 'HOME': '/home/cltbld', 03:49:19 INFO - 'LANG': 'en_US.UTF-8', 03:49:19 INFO - 'LANGUAGE': 'en_US:en', 03:49:19 INFO - 'LOGNAME': 'cltbld', 03:49:19 INFO - 'MAIL': '/var/mail/cltbld', 03:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:19 INFO - 'MOZ_NO_REMOTE': '1', 03:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:19 INFO - 'NO_EM_RESTART': '1', 03:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:19 INFO - 'SHELL': '/bin/bash', 03:49:19 INFO - 'SHLVL': '1', 03:49:19 INFO - 'TERM': 'linux', 03:49:19 INFO - 'TMOUT': '86400', 03:49:19 INFO - 'USER': 'cltbld', 03:49:19 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:19 INFO - '_': '/tools/buildbot/bin/python'} 03:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 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)) 03:49:19 INFO - Cleaning up... 03:49:19 INFO - Return code: 0 03:49:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:49:19 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')]} 03:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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')]} 03:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:19 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 03:49:19 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 03:49:19 INFO - Using env: {'DISPLAY': ':0', 03:49:19 INFO - 'HOME': '/home/cltbld', 03:49:19 INFO - 'LANG': 'en_US.UTF-8', 03:49:19 INFO - 'LANGUAGE': 'en_US:en', 03:49:19 INFO - 'LOGNAME': 'cltbld', 03:49:19 INFO - 'MAIL': '/var/mail/cltbld', 03:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:19 INFO - 'MOZ_NO_REMOTE': '1', 03:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:19 INFO - 'NO_EM_RESTART': '1', 03:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:19 INFO - 'SHELL': '/bin/bash', 03:49:19 INFO - 'SHLVL': '1', 03:49:19 INFO - 'TERM': 'linux', 03:49:19 INFO - 'TMOUT': '86400', 03:49:19 INFO - 'USER': 'cltbld', 03:49:19 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:19 INFO - '_': '/tools/buildbot/bin/python'} 03:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:19 INFO - Downloading/unpacking jsonschema 03:49:19 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 03:49:19 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 03:49:19 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 03:49:19 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 03:49:19 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 03:49:19 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 03:49:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:21 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 03:49:21 INFO - Downloading/unpacking functools32 (from jsonschema) 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:49:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:21 INFO - warning: no files found matching '*.txt' 03:49:21 INFO - no previously-included directories found matching 'build' 03:49:21 INFO - no previously-included directories found matching 'dist' 03:49:21 INFO - no previously-included directories found matching '.git*' 03:49:21 INFO - Installing collected packages: jsonschema, functools32 03:49:21 INFO - Running setup.py install for functools32 03:49:21 INFO - warning: no files found matching '*.txt' 03:49:21 INFO - no previously-included directories found matching 'build' 03:49:21 INFO - no previously-included directories found matching 'dist' 03:49:21 INFO - no previously-included directories found matching '.git*' 03:49:21 INFO - Successfully installed jsonschema functools32 03:49:21 INFO - Cleaning up... 03:49:21 INFO - Return code: 0 03:49:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:49:21 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')]} 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:21 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')]} 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:21 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 0x7f1d84a18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2038230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', '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 03:49:21 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 03:49:21 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 03:49:21 INFO - Using env: {'DISPLAY': ':0', 03:49:21 INFO - 'HOME': '/home/cltbld', 03:49:21 INFO - 'LANG': 'en_US.UTF-8', 03:49:21 INFO - 'LANGUAGE': 'en_US:en', 03:49:21 INFO - 'LOGNAME': 'cltbld', 03:49:21 INFO - 'MAIL': '/var/mail/cltbld', 03:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:21 INFO - 'MOZ_NO_REMOTE': '1', 03:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:21 INFO - 'NO_EM_RESTART': '1', 03:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:21 INFO - 'SHELL': '/bin/bash', 03:49:21 INFO - 'SHLVL': '1', 03:49:21 INFO - 'TERM': 'linux', 03:49:21 INFO - 'TMOUT': '86400', 03:49:21 INFO - 'USER': 'cltbld', 03:49:21 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:21 INFO - '_': '/tools/buildbot/bin/python'} 03:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:22 INFO - Downloading/unpacking flake8 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 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 03:49:22 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 03:49:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:49:23 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 03:49:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:49:23 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 03:49:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 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 03:49:23 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 03:49:24 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 03:49:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:49:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:49:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:24 INFO - no previously-included directories found matching 'docs/_build' 03:49:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:49:24 INFO - Running setup.py install for pep8 03:49:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:24 INFO - no previously-included directories found matching 'docs/_build' 03:49:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:49:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:49:24 INFO - Cleaning up... 03:49:24 INFO - Return code: 0 03:49:24 INFO - Running post-action listener: _resource_record_post_action 03:49:24 INFO - Running post-action listener: _start_resource_monitoring 03:49:24 INFO - Starting resource monitoring. 03:49:24 INFO - ##### 03:49:24 INFO - ##### Running install step. 03:49:24 INFO - ##### 03:49:24 INFO - Running pre-action listener: _resource_record_pre_action 03:49:24 INFO - Running main action method: install 03:49:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:24 INFO - Reading from file tmpfile_stdout 03:49:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:49:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:49:24 INFO - Reading from file tmpfile_stdout 03:49:24 INFO - Output received: 03:49:24 INFO - Usage: mozinstall [options] installer 03:49:24 INFO - Options: 03:49:24 INFO - -h, --help show this help message and exit 03:49:24 INFO - -d DEST, --destination=DEST 03:49:24 INFO - Directory to install application into. [default: 03:49:24 INFO - "/builds/slave/test-pgo"] 03:49:24 INFO - --app=APP Application being installed. [default: firefox] 03:49:24 INFO - mkdir: /builds/slave/test-pgo/build/application 03:49:24 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'] 03:49:24 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 03:49:40 INFO - Reading from file tmpfile_stdout 03:49:40 INFO - Output received: 03:49:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:49:40 INFO - Running post-action listener: _resource_record_post_action 03:49:40 INFO - ##### 03:49:40 INFO - ##### Running run-tests step. 03:49:40 INFO - ##### 03:49:40 INFO - Running pre-action listener: _resource_record_pre_action 03:49:40 INFO - Running main action method: run_tests 03:49:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:49:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:49:40 INFO - Python 2.7.3 03:49:40 INFO - Return code: 0 03:49:40 INFO - grabbing minidump binary from tooltool 03:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:40 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 0x20ca7f0>, '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 0x20362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2036760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:49:40 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 03:49:40 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 03:49:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:40 INFO - Return code: 0 03:49:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:49:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:49:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:49:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:49:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:49:41 INFO - Return code: 0 03:49:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 03:49:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 03:49:41 INFO - Using env: {'DISPLAY': ':0', 03:49:41 INFO - 'HOME': '/home/cltbld', 03:49:41 INFO - 'LANG': 'en_US.UTF-8', 03:49:41 INFO - 'LANGUAGE': 'en_US:en', 03:49:41 INFO - 'LOGNAME': 'cltbld', 03:49:41 INFO - 'MAIL': '/var/mail/cltbld', 03:49:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:41 INFO - 'MOZ_NO_REMOTE': '1', 03:49:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:41 INFO - 'NO_EM_RESTART': '1', 03:49:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:41 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:49:41 INFO - 'SHELL': '/bin/bash', 03:49:41 INFO - 'SHLVL': '1', 03:49:41 INFO - 'TERM': 'linux', 03:49:41 INFO - 'TMOUT': '86400', 03:49:41 INFO - 'USER': 'cltbld', 03:49:41 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049', 03:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:41 INFO - '_': '/tools/buildbot/bin/python'} 03:49:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 03:49:41 INFO - mozversion application_buildid: 20151218013002 03:49:41 INFO - mozversion application_changeset: d47e90499b87c267ed261ea6762b85afde5b8a28 03:49:41 INFO - mozversion application_display_name: Nightly 03:49:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:41 INFO - mozversion application_name: Firefox 03:49:41 INFO - mozversion application_remotingname: firefox 03:49:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:49:41 INFO - mozversion application_vendor: Mozilla 03:49:41 INFO - mozversion application_version: 46.0a1 03:49:41 INFO - mozversion platform_buildid: 20151218013002 03:49:41 INFO - mozversion platform_changeset: d47e90499b87c267ed261ea6762b85afde5b8a28 03:49:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:49:41 INFO - mozversion platform_version: 46.0a1 03:49:41 INFO - using testdate: 1450439381 03:49:41 INFO - actual date: 1450439381 03:49:41 INFO - starting webserver on 'localhost:58600' 03:49:41 INFO - SUITE-START | Running 3 tests 03:49:41 INFO - TEST-START | dromaeo_css 03:49:41 INFO - operating with platform_type : linux_ 03:49:41 INFO - Initialising browser for dromaeo_css test... 03:49:42 INFO - TEST-INFO | started process 18994 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm0fMqx/profile http://localhost:58600/getInfo.html) 03:49:46 INFO - PROCESS | 18994 | __metrics Screen width/height:1600/1200 03:49:46 INFO - PROCESS | 18994 | colorDepth:24 03:49:46 INFO - PROCESS | 18994 | Browser inner width/height: 1024/697 03:49:46 INFO - PROCESS | 18994 | __metrics 03:49:46 INFO - PROCESS | 18994 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:49:47 INFO - TEST-INFO | 18994: exit 0 03:49:47 INFO - Browser initialized. 03:49:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:47 INFO - TEST-INFO | started process 19129 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm0fMqx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:59 INFO - PROCESS | 19129 | RSS: Main: 150855680 03:49:59 INFO - PROCESS | 19129 | 03:50:48 INFO - PROCESS | 19129 | 1450439448936 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] 03:52:57 INFO - PROCESS | 19129 | Cycle 1(1): loaded http://localhost:58600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58600/tests/dromaeo/cssquery-ext.html) 03:52:58 INFO - PROCESS | 19129 | RSS: Main: 157761536 03:52:58 INFO - PROCESS | 19129 | 03:56:00 INFO - PROCESS | 19129 | Cycle 1(1): loaded http://localhost:58600/tests/dromaeo/cssquery-ext.html (next: http://localhost:58600/tests/dromaeo/cssquery-jquery.html) 03:56:01 INFO - PROCESS | 19129 | RSS: Main: 152686592 03:56:01 INFO - PROCESS | 19129 | 03:59:03 INFO - PROCESS | 19129 | Cycle 1(1): loaded http://localhost:58600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58600/tests/dromaeo/cssquery-mootools.html) 03:59:03 INFO - PROCESS | 19129 | RSS: Main: 153952256 03:59:03 INFO - PROCESS | 19129 | 04:02:05 INFO - PROCESS | 19129 | Cycle 1(1): loaded http://localhost:58600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58600/tests/dromaeo/cssquery-prototype.html) 04:02:06 INFO - PROCESS | 19129 | RSS: Main: 152600576 04:02:06 INFO - PROCESS | 19129 | 04:05:08 INFO - PROCESS | 19129 | Cycle 1(1): loaded http://localhost:58600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58600/tests/dromaeo/cssquery-yui.html) 04:05:09 INFO - PROCESS | 19129 | RSS: Main: 151588864 04:05:09 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | Cycle 1(1): loaded http://localhost:58600/tests/dromaeo/cssquery-yui.html (next: http://localhost:58600/tests/dromaeo/cssquery-dojo.html) 04:08:11 INFO - PROCESS | 19129 | RSS: Main: 155836416 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | __start_tp_report 04:08:11 INFO - PROCESS | 19129 | _x_x_mozilla_page_load 04:08:11 INFO - PROCESS | 19129 | _x_x_mozilla_page_load_details 04:08:11 INFO - PROCESS | 19129 | |i|pagename|runs| 04:08:11 INFO - PROCESS | 19129 | |0;dojo.html;3220.4364236258657;3280.4095262852675;3309.751768617354;3317.5521304623885;3321.0368992992035;5250.133727934895;5536.916946245805;5547.916781248279;5549.02891993901;5560.443955604448;5331.920021199685;5383.031054410205;5387.730613469321;5441.5102640762325;5450.5367043801325;5038.82364117255;5056.266841308008;5116.232565115244;5119;5123.615728820335;4736.786844591985;5116.283720279164;5186.351706036746;5199.402068762103;5202.167653175493;4893.926591101119;4920.876978075541;5001.7999280028935;5026.798928042874;5036.899262014776;5033.597312215014;5049.293098966147;5053.873653158664;5074.035933172685;5099.209622508517;4858.222684370519;5000.149974504307;5015.0972824891505;5019.52314530119;5029.647924645276;5240.161574148118;5248.580113590903;5254.737263136828;5271.367435907678;5278.736063196825;5954.7915822946425;5973.223480947492;5987.700614969278;5988.7604495820115;6005.639661620273;5717.428257174291;5833.591648584601;5996.940030599681;6016.96991515044;6030.969845150747;5336.759845806909;5422.783088676409;5428.484293992104;5428.891422171534;5447.128459446509;5966.403359663999;5966.76132954677;5974.40255974399;5988.131720900445;6026.849328766816;5559.11054231321;5698.974184646803;5741.827745167651;5790.363060063474;5832.825015249549;5913.083472061838;6000.759969601167;6007.459328660441;6016.398360164036;6016.789412370634;5833.620814647034;5888.440598143169;5898.351181370046;5905.940940590625;5922.792702255487;5671.489565939085;5767.8558036049435;5806.361300256968;5931.703414829328;5954.285485741739;4508.774561271924;4517.887052823706;4520.864374068783;4521.864344069618;4553.203189441834;4017.5982401760175;4021.7184797063924;4040.777757223381;4059.3505039193587;4088.366303223005;5408.621396502286;5450.91823622646;5503.449655034545;5513.2005859151;5527.751251193626;5800.158976948319;5907.2911250650195;5912.970435147797;5923.111533269957;5923.17075609415;5461.42655021225;5479.890402191933;5480;5493.450654934474;5530.004599172187;4992.126377883856;5033.899322013539;5084.949150508522;5117.8464646060675;5153.896922061613;6102.9694851525455;6157.815265542041;6182.876342473125;6192.907106393498;6192.938070619326;5622.100463925753;6070.362611925684;6094.695265236632;6094.75620975156;6098.908516372169;5882.205902203148;5917.733701983507;5968.791092311748;5981.102834574848;5999.880002400015;5792.478676919098;5916.053431450947;5936.406359364202;5949.167116603766;5959.344472108151;5789.2763404574425;5886.293644762656;6025.6083354581815;6049.637021778707;6051.031834906394;5783.074708046693;5864.618799778001;5877.471027607536;5880.50015748649;5931.13998470228;5885.823425297248;5903.498202652822;5905.852353691193;5906.586538942232;5909.438603332676;5485.725713714219;5548.140038294071;5599.160125981135;5801.506871915765;5833.883322333445;5733.3406658234835;5829.59192856496;5839.416058394127;5875.089361149029;5895.67573783446;5743.827685169452;5761.683107428964;5765.365809760839;5765.8270251890835;5775.7400916957995 04:08:11 INFO - PROCESS | 19129 | |1;ext.html;583.594401890686;592.5881512348919;593.8070127208658;624.7875722254432;630.501903496238;37606.43590346144;38624.42063369048;38625.227495450075;38631;38646.420303695464;39293;39460.210795784136;39768.60231397685;39861.20277594446;39867;8585.656573737044;8708.608112634915;8732.432391894537;8734.650613975433;8740.606672699743;8477.321814254845;8548.61531231093;8628.007779105388;8649.437786543886;8663.740087797376;8595.054544000155;8669.566521673923;8671.479711217316;8671.739847804576;8681.826363472726;8628.870566941501;8659.653613855438;8670.696525621574;8702.216800487986;8731.083236260196;8464.44981076228;8571.657133714643;8587.055423903366;8606.78483037929;8613.741587752378;36363.4545481818;36626.81686591577;36728.449073263924;36730.63269367299;36758.08104797375;2950.7786915981173;2999;3076.707782731236;3176.4758814795764;3527.0829584308008;29549.70450295491;29732.256693582833;29780.106596802132;29973.850130749426;30027.849860750775;3652.726045546568;3830;3847.7883716395586;3885.514310711161;3919.9216015679813;254107;256204;258996;259059;259963;51334.22998655023;52362.476375236525;57492.13761793576;57564.42435575591;58855.7029867314;53994;54394.72802635962;54664;54695.72652136714;54725.72637136789;14052.508162214273;14142.151470911778;14170.149791012365;14172.291385430688;14293.714125717428;10789;10830.079443247412;10833.78332433347;10893.782124357469;10894.291871028357;19148.521286967658;19617.289173115627;20229.595408091755;20409.591808163754;20471.181152753725;7602.80992975169;7827.491213071132;7850.175731548219;7852.528848269122;7971.1303930584945;879.9736007919772;1028.3264461777549;1036.2487196782272;1051.9316244444087;1075.956961721538;27879.721202788118;27899.442011159663;28185.43629127447;28836.42327153445;30512.542311865338;1040.5005597313332;1080.206048554312;1131.7000994736402;1169.0881112732084;1189.6193218170104;14035.43858245679;14249.278175902407;14384.568462946128;14438.927805360907;14510.201938893462;346961;347568;349765;350268;351588;49720;49815.75092124589;49880;49919.75040124776;50065;1371.8765311121847;1383.266868559665;1386.5978866128912;1392.1716578635696;1395.1907893421792;26301.60547591826;27117.186484405498;27185.72814271832;27263.318417039733;27344.589831152945;45079.54920450754;45531;45565;45613.08773824571;45726.54273457223;311135;312341;314506;314843;314936;30202.2449438757;31203.219919502193;31557.36885262236;31625.36749265048;31774.36451271008;36907.26185476329;37336.81331593324;37553.81223093867;37849.24301514009;37917.81041094777;32856.178595534344;34505.654943450245;35458.822705886305;35777.82111089428;35835.46246806248;34462.827685862416;35004.64995350014;35150.648493515764;35652.28695426129;35710.4643430354;31947.520787188674;32085.839570801996;32236.516452253705;32362.190945226557;35315.646843531234;27736.167914962585;27989.580156297263;29684.257893552833;29834.254143646584;29913.551296731002;22276.888615556818;22528.32415027552;23353.76646233516;24017;24359.634605481286 04:08:11 INFO - PROCESS | 19129 | |2;jquery.html;358.346018516208;358.75963104719835;363.75628329019554;364.1569765991729;366.4484950150024;16597.502074937755;17226.138693065343;17522;17759.822401775993;18283.17725702343;16177.676446471092;16286.267117979689;16492.42276520322;16536.255868485918;16795.83204167958;4860.781264843082;4943.579795717368;4947.653664243504;4948.901021979558;4952.3561936948145;4899.848535594133;4951.851444456672;4954.826581069663;4957.231629097496;5039.899202015958;4968.35411396518;5102.107131252034;5125.3080834087295;5144.43411224765;5167.224916262553;5120.897582048338;5121.897562048738;5148.974255128719;5151.587872970172;5151.613628977823;4911.45973942866;5091.338126043628;5102.846914592568;5143.8456846294675;5149.871253218699;19503.219871205278;19657.508562286057;19973.700394494095;20798.16807327705;20813.791862081336;2114.9365519034454;2140.871547707127;2247.9591027978113;2309.0532881518498;2326.581215381231;9476.052394760538;9550.522473876279;9568.234541236685;9795.90204097957;12359.134860559765;1786.3033416967394;1826.9768929399445;1884.2463014794055;1894.0529735132434;1899.9265415040459;56786.1482077765;58929.41070589282;59037.70481147567;60071.69964150195;60429.395706042815;9545.809083818285;9690.418574885389;9807.754806129904;9834.950825245827;10029.224428624953;12938.741225175443;13025.47898084085;13048.673783155307;13054.869451305556;13065.412056457482;7305.123385193704;7316.524425912298;7386.556806591621;7415.555066696015;7426.851462970711;7060.329268719566;7079.716811327592;7084.964575177194;7099.82250443743;7137.179224389261;4222.472190976128;4261.147770445923;4284.357346398066;4284.935725964113;4334.0248444099825;1798.2267624921149;1844.2162081115473;1849.5745978425039;1852.1757817771231;1859.544411619162;433.4386968875314;793.262266092528;869.7086476030601;983.4246965525248;1004.9949750251349;9968.950155249177;10340.810806757168;10380.896191037993;16575.41986030483;17736.379226727004;870.2124577257592;912.8721978922956;939.4081728510994;989.6091044037565;991.9752006199902;7924.722634707758;9657.130858222654;9747;9752.561134748812;9787;505568;506879;514676;527248;533561;79970.6001469989;80501.19498804936;82720.58639706763;82877;83233;1083.160550573312;1085.918556108295;1093.814051611228;1110.2949626986922;1137.4597066393562;15412.46056388021;15474.5357639271;15478.458253961056;15553.455629052929;15648.217589120271;35239.647603523634;35519.46720799242;36053.27893442169;36412.27175456529;36561.81719091388;47432.525674742814;47672;47877;48494.757526212146;50433;9263.53682315868;9533.809323813624;9629.951850240985;9693.660721874701;9723.951380243336;9189.86215206759;11699.122565807429;12377;17680.82319176843;17791.19939602695;14655.85344146545;14788.482403115839;14804.333804979016;14897.627559310671;14905.701885962437;13901.86098139046;14137.222452765196;14513.097380524148;14639.853601463848;14739.041962272418;9257.518796992717;14330.211838348574;14621.70756584841;14877.553673389815;15166.924165379543;9651.131398174199;9707.757306067122;9733.124018838056;9811.460369679451;9865.408075515492;10256.230782691178;10328.638497652546;12302.569410070604;14754.852451475348;15304.234788260319 04:08:11 INFO - PROCESS | 19129 | |3;mootools.html;1463.9121652700846;1690.771745814315;1722.164750096203;1736.7568540404354;1765.5762616971926;7419.629018549072;7512;7691.115521715004;7714.49855759376;7727.9613601931915;7329.523580967247;7345.7428989985365;7354.301341372575;7421.591812450313;7435.144958329794;2236.1055577768902;2272.9659055114184;2274.431392151962;2275.0444813178506;2282.9771702283015;2180.738311402634;2209.0611490116717;2232.799048085672;2233.8883055847223;2240.0591751464344;2195.6706494025943;2196.494806194576;2201.317591546626;2208.182972300251;2246.3485589179118;2235.865848049114;2251.628481300592;2251.763564825686;2255.323402979116;2259.3899647095272;2232.5758105959817;2280.407094155515;2281.4638559938403;2290.0954123121273;2295.8163346932374;7279.053723016027;7289.052423185005;7316.5975871327055;7321.1580668223305;7326.864336027871;4591.357209990604;4672.252439609646;4687.22660760974;4698.412698412699;4701.976490117528;3025.8184508929535;3112.797668151563;3150.3069324748517;3189.1389324882152;3196.6164060312913;961.4135377419768;977.3793641037921;990.1583653894204;1016.3393794033864;1044.81715699753;10066.446345450997;10127.999999999925;10132.240081993807;10132.493375331203;10251.282410231286;3866;3874.5156855393075;3908.882733517999;3912.4131380293184;4016.5380981187536;8440.873386899202;8483.490990540588;8490.575471226537;8522;8525.531095789791;4500;4506.188886000551;4513.81944722214;4524;4548.681592288574;4179.373094035919;4185.309423945015;4188.539260681323;4189.790510474464;4194.622483976456;3414.812185329781;3415.777974431654;3424.5890493140982;3469.2887957968555;3474.774139680913;1133.9433028348549;1142.714321419645;1150.7065698246893;1155.6590805712335;1158.7856246594406;904.2810965282616;904.380499357942;1025.9846102308472;1081.9829360401197;1243.1795015290047;6968.547044442095;7118.039064726299;7123;7147.89278160828;7151.392131668867;617.4072890025536;626.8965620672537;629.1255155334089;639.4372951802384;781.8233558494543;5397.460253974571;5587.608867379326;5590.776368945197;5594.888102237933;5601.243832082617;8730.607122679494;9070.956839963357;9278.675246366345;9296.256299496024;9330.720078397659;8732.301415886714;8733.650653973897;8761.518116503654;8843.513606751561;8859.512726800089;7200.783976480609;7205.92794072063;7251.093613298338;7264.237255088246;7286.781396558112;7306.305900939402;7372.336489715952;7374.668139933823;7375.926240737524;7387.889181662387;8098.190180981855;8248.711295104642;8302.169783021649;8423.031351394424;8436.282915952213;8387.580620969049;8409.2431681149;8542.530160841214;8627.352948529011;8652.351073669373;6635.23694775107;6642.468602511691;6683.064370987969;6709.496787741036;6770.796876093725;7296;7303.196648368781;7307.451941104332;7319.341259286477;7350.7427240046345;6688.565243259172;6731.697073631796;6779.72881084751;6833.89749153773;6879.140107486564;6249.218847644044;6660.800175994728;6739.59562426256;6749.898751518633;6861.656917154222;6791.72833086671;6950.721971121301;6990.056342393712;7003.719851205895;7034.5427547209265;6451.741930322734;6470.158879345655;6475.546711730133;6484.643344615903;6488.286288508166;6318.336574659778;6342.968285158545;6412.519061070531;6437.452816510649;6437.549371543947 04:08:11 INFO - PROCESS | 19129 | |4;prototype.html;313.7678118192537;323.93035497368066;331.1010606204158;331.4613752651941;336.52213856324016;6281.654509002009;6314.589551679143;6327.5570710050315;6413.8075857724225;6464.288928217892;6325.367463253672;6329.430351268396;6350.745970161188;6356.110144579751;6373.171487706603;4805.3032310315075;4810.254410566367;4813.518648135194;4816.325714399987;4819.44576373718;4804.975975120137;4805.279208118775;4808.879778005543;4817.373741413611;4822.083804077231;4669.626429885601;4750.501197374278;4764.833230836922;4765.451973023095;4783.904321913559;4752.239641657353;4756.571908528232;4757;4761.119192949315;4780.139574876521;4098.610631989956;4108.075682971337;4110.362893751473;4114.835406583763;4118.711690181688;6032.939670603281;6035.004224302985;6039.607425517327;6043.758249670008;6046.27444706638;5411.296531450926;5511.834644960658;5526.530244929186;5536.557075433996;5563.304586926634;6690.397864192246;6694.83262918426;6702.329767023308;6706.966465167692;6708.597484150967;4524.45706515217;4524.547545245482;4529.954700452986;4537.614302784267;4539.72761634303;6723.529352945296;6835.863282734367;6895.413889819371;6925.445964322842;6934.965325173393;4696.342512048316;4737.692050016738;4750.287456881426;4771.809127634925;4786.664933454625;4821.831235906797;4827.517248275144;4831.057943700945;4838.782254798542;4852.539008794159;5577.609567330248;5580.414056524088;5595.104783234663;5598.720063996784;5600.943990560124;6582.144321238208;6814.522983391214;6815;6817.454603631698;6834.760783372558;1684.873634477419;1696.5419336779;1713.8286171382763;1721.7761690980092;1726.3526177683368;1127.1658972360394;1142.5772464188303;1148.1561052626314;1148.7070796946891;1164.7495788405533;6321.431071203614;6323.715432805535;6358.395952384516;6372.522060845363;6373.936260637427;6869.484788640872;6878.449724022166;6887.004153193277;6895.34494223048;6927.930720692729;6213.65824879627;6344.984802431589;6361.554691171574;6364.363563643691;6371.203599550056;3774.698024158061;3832.080300727805;3837.175007373428;3842.3852183650483;3844.8462061517785;7154.39187669054;7162.4628152888745;7184.389326907271;7202.7118915243855;7216.7370710125515;6973.4072603829245;7199.820004499929;7210.062691850026;7257.600831954293;7266.346028857428;7174.246704096099;7174.282571742889;7179.425645948416;7179.748708795167;7193.964030179815;6988.056612357267;7043;7047.1895731989425;7058.788236352918;7059.5764254144915;6795.286494917962;6974.267701891431;6976.895346569907;6985.231624521197;6989.126359205099;7161.820954475971;7163.6060016699585;7164.283571642794;7169.749058782918;7182.497225194186;4680.017196388796;4712.882177945578;4734.05318936221;4736.550027747358;4746.572808447257;6717.865642687217;6854.828629284308;6864.485163612849;7034.085568876013;7041.260667629826;6644.368784965421;6808.9659551701925;6852.965735171292;6858.451323893977;6875.862482750417;6791.93208067913;6817.795466136024;6817.829554261183;6819.977003449522;6851.760188393382;6519.250286217146;6688.933110668831;6692.531522793358;6709.161354830646;6721.395074443323;6847.897281540681;6860.2453730088655;6860.6912688930115;6866.038754574463;6872.278410766798;6701.765438209834;6710.83222919431;6717.193936727624;6722.361375669304;6728.966355168192 04:08:11 INFO - PROCESS | 19129 | |5;yui.html;743.1899229839474;746.3432179681876;759.6467642546215;832.9292010179134;838.643576479996;11904.642860714172;11943.34311612861;11949.701257468567;11970.521179152824;12033.939830300847;11878.406079696002;12005.879941200585;12030.578929737461;12032.699182520442;12042.337671428068;808.5068108453838;821.4783612406135;838.5849004742661;838.8028813228917;839.8404303182376;834.1241696218946;835.1606635331514;838.9077201507829;839.5844057191699;842.3555979675554;864.6066039951806;869.148234729965;870.6256309786789;870.6909047288217;873.3929918706501;857.8284343131398;861.5519929636554;865.3942240431722;865.5715420866649;865.8744482050099;636;638.7476946606112;639.076534407781;639.3829954094322;641.4932203559183;12814.359282035954;12873.163244389178;12893.419796109198;13023.47906083765;13056.804147937788;10847.51186196623;11566.53733850645;11589.826152607717;11802.527898884035;11947.342896140708;10253.487325633763;10298.485075746183;10433.843492347622;10451.68644940653;10507.684769456928;3550.094725844893;3566.197605538759;3568.3933731265747;3599.5320608321013;3694.11341278094;47491.28763068557;47683.04633907337;47684.52315476836;47797.28304075442;47841.5215847844;9325.067493250757;9443.386179898285;9493.288003399774;9506.334556580972;9782.364146330467;17367.91585009807;17484;17506.824931750773;17530.64938701219;17559.912200438917;6637.9668101660145;6736.1916570010935;6786.117804685359;6898.586084834926;6967.965160174167;4084.4690190275073;4093.5087789465456;4228.386883901817;4294.742315461082;4466.151431228056;2826.138027901469;2834.3906060197155;2835.9858200709277;2842.0621195005597;2858.771298296131;525.2200482283805;528.3580449753567;529.1559961860826;530.7691154347793;535.9196120581944;579.9130130480378;600.0347127519808;605.5276884030463;628.6416742456755;666.2571233075087;8498.405111642125;8549.914500854911;8791.824163516694;8831.072737362612;9159.221466175317;643.7650257655922;662.5954953395878;667.4193451697055;711.1324184495011;715.7208688611446;3847.3844184930836;4024.094578719823;4080.8571699990953;4088.8160032798;4171.520275168395;54864;57655.71172144196;60840.39159608347;61609;61627;50102;50210.246846297334;50257.24614130791;50347.74826125919;50922;46268.768656156506;46317.7684111584;46492.535074649495;46711.766441168256;46848.29727554089;8225.5475948821;8448.66205351779;8594.527300998505;8616;8641.56792160402;33749.83125084359;34060.489092663134;35254;35935.46096808602;36241.818790905876;41417;41503.58496414997;42463.150736985706;42690.35964460474;42735.358969614856;10493.842592361274;10592.417417042137;10736.624218152327;10807.405592692163;10992.17558683086;11540.134489913458;11766.88233117658;11828.23116497425;12042.036637068839;12199.75600488003;11339;11404.885951140383;11540.076793856639;11595.304281743123;11952.103592230791;10759.946200268949;10940.945295273472;11022.614208502664;11272.098232141572;11310.264832785842;11059.577958392236;11097.500612472297;11137.777244455228;11213.102951763676;11466;9276.582553784961;9335.439873607605;9379.296552758435;9431.339806213773;9661.806763864543;8952.491805072585;9146.817063658822;9168;9718.222542196749;9730.513474326397 04:08:11 INFO - PROCESS | 19129 | __end_tp_report 04:08:11 INFO - PROCESS | 19129 | __start_cc_report 04:08:11 INFO - PROCESS | 19129 | _x_x_mozilla_cycle_collect,310 04:08:11 INFO - PROCESS | 19129 | __end_cc_report 04:08:11 INFO - PROCESS | 19129 | __startTimestamp1450440491708__endTimestamp 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | ------- Summary: start ------- 04:08:11 INFO - PROCESS | 19129 | Number of tests: 6 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | [#0] dojo.html Cycles:165 Average:5481.25 Median:5717.43 stddev:619.11 (10.8%) stddev-sans-first:595.06 04:08:11 INFO - PROCESS | 19129 | Values: 3220.4 3280.4 3309.8 3317.6 3321.0 5250.1 5536.9 5547.9 5549.0 5560.4 5331.9 5383.0 5387.7 5441.5 5450.5 5038.8 5056.3 5116.2 5119.0 5123.6 4736.8 5116.3 5186.4 5199.4 5202.2 4893.9 4920.9 5001.8 5026.8 5036.9 5033.6 5049.3 5053.9 5074.0 5099.2 4858.2 5000.1 5015.1 5019.5 5029.6 5240.2 5248.6 5254.7 5271.4 5278.7 5954.8 5973.2 5987.7 5988.8 6005.6 5717.4 5833.6 5996.9 6017.0 6031.0 5336.8 5422.8 5428.5 5428.9 5447.1 5966.4 5966.8 5974.4 5988.1 6026.8 5559.1 5699.0 5741.8 5790.4 5832.8 5913.1 6000.8 6007.5 6016.4 6016.8 5833.6 5888.4 5898.4 5905.9 5922.8 5671.5 5767.9 5806.4 5931.7 5954.3 4508.8 4517.9 4520.9 4521.9 4553.2 4017.6 4021.7 4040.8 4059.4 4088.4 5408.6 5450.9 5503.4 5513.2 5527.8 5800.2 5907.3 5913.0 5923.1 5923.2 5461.4 5479.9 5480.0 5493.5 5530.0 4992.1 5033.9 5084.9 5117.8 5153.9 6103.0 6157.8 6182.9 6192.9 6192.9 5622.1 6070.4 6094.7 6094.8 6098.9 5882.2 5917.7 5968.8 5981.1 5999.9 5792.5 5916.1 5936.4 5949.2 5959.3 5789.3 5886.3 6025.6 6049.6 6051.0 5783.1 5864.6 5877.5 5880.5 5931.1 5885.8 5903.5 5905.9 5906.6 5909.4 5485.7 5548.1 5599.2 5801.5 5833.9 5733.3 5829.6 5839.4 5875.1 5895.7 5743.8 5761.7 5765.4 5765.8 5775.7 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | [#1] ext.html Cycles:180 Average:46430.96 Median:193369.32 stddev:81057.41 (41.9%) stddev-sans-first:81211.71 04:08:11 INFO - PROCESS | 19129 | Values: 583.6 592.6 593.8 624.8 630.5 37606.4 38624.4 38625.2 38631.0 38646.4 39293.0 39460.2 39768.6 39861.2 39867.0 8585.7 8708.6 8732.4 8734.7 8740.6 8477.3 8548.6 8628.0 8649.4 8663.7 8595.1 8669.6 8671.5 8671.7 8681.8 8628.9 8659.7 8670.7 8702.2 8731.1 8464.4 8571.7 8587.1 8606.8 8613.7 36363.5 36626.8 36728.4 36730.6 36758.1 2950.8 2999.0 3076.7 3176.5 3527.1 29549.7 29732.3 29780.1 29973.9 30027.8 3652.7 3830.0 3847.8 3885.5 3919.9 254107.0 256204.0 258996.0 259059.0 259963.0 51334.2 52362.5 57492.1 57564.4 58855.7 53994.0 54394.7 54664.0 54695.7 54725.7 14052.5 14142.2 14170.1 14172.3 14293.7 10789.0 10830.1 10833.8 10893.8 10894.3 19148.5 19617.3 20229.6 20409.6 20471.2 7602.8 7827.5 7850.2 7852.5 7971.1 880.0 1028.3 1036.2 1051.9 1076.0 27879.7 27899.4 28185.4 28836.4 30512.5 1040.5 1080.2 1131.7 1169.1 1189.6 14035.4 14249.3 14384.6 14438.9 14510.2 346961.0 347568.0 349765.0 350268.0 351588.0 49720.0 49815.8 49880.0 49919.8 50065.0 1371.9 1383.3 1386.6 1392.2 1395.2 26301.6 27117.2 27185.7 27263.3 27344.6 45079.5 45531.0 45565.0 45613.1 45726.5 311135.0 312341.0 314506.0 314843.0 314936.0 30202.2 31203.2 31557.4 31625.4 31774.4 36907.3 37336.8 37553.8 37849.2 37917.8 32856.2 34505.7 35458.8 35777.8 35835.5 34462.8 35004.6 35150.6 35652.3 35710.5 31947.5 32085.8 32236.5 32362.2 35315.6 27736.2 27989.6 29684.3 29834.3 29913.6 22276.9 22528.3 23353.8 24017.0 24359.6 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | [#2] jquery.html Cycles:180 Average:28038.20 Median:25883.28 stddev:84701.25 (327.2%) stddev-sans-first:84913.35 04:08:11 INFO - PROCESS | 19129 | Values: 358.3 358.8 363.8 364.2 366.4 16597.5 17226.1 17522.0 17759.8 18283.2 16177.7 16286.3 16492.4 16536.3 16795.8 4860.8 4943.6 4947.7 4948.9 4952.4 4899.8 4951.9 4954.8 4957.2 5039.9 4968.4 5102.1 5125.3 5144.4 5167.2 5120.9 5121.9 5149.0 5151.6 5151.6 4911.5 5091.3 5102.8 5143.8 5149.9 19503.2 19657.5 19973.7 20798.2 20813.8 2114.9 2140.9 2248.0 2309.1 2326.6 9476.1 9550.5 9568.2 9795.9 12359.1 1786.3 1827.0 1884.2 1894.1 1899.9 56786.1 58929.4 59037.7 60071.7 60429.4 9545.8 9690.4 9807.8 9835.0 10029.2 12938.7 13025.5 13048.7 13054.9 13065.4 7305.1 7316.5 7386.6 7415.6 7426.9 7060.3 7079.7 7085.0 7099.8 7137.2 4222.5 4261.1 4284.4 4284.9 4334.0 1798.2 1844.2 1849.6 1852.2 1859.5 433.4 793.3 869.7 983.4 1005.0 9969.0 10340.8 10380.9 16575.4 17736.4 870.2 912.9 939.4 989.6 992.0 7924.7 9657.1 9747.0 9752.6 9787.0 505568.0 506879.0 514676.0 527248.0 533561.0 79970.6 80501.2 82720.6 82877.0 83233.0 1083.2 1085.9 1093.8 1110.3 1137.5 15412.5 15474.5 15478.5 15553.5 15648.2 35239.6 35519.5 36053.3 36412.3 36561.8 47432.5 47672.0 47877.0 48494.8 50433.0 9263.5 9533.8 9630.0 9693.7 9724.0 9189.9 11699.1 12377.0 17680.8 17791.2 14655.9 14788.5 14804.3 14897.6 14905.7 13901.9 14137.2 14513.1 14639.9 14739.0 9257.5 14330.2 14621.7 14877.6 15166.9 9651.1 9707.8 9733.1 9811.5 9865.4 10256.2 10328.6 12302.6 14754.9 15304.2 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | [#3] mootools.html Cycles:180 Average:5300.17 Median:6460.95 stddev:2736.76 (42.4%) stddev-sans-first:2729.25 04:08:11 INFO - PROCESS | 19129 | Values: 1463.9 1690.8 1722.2 1736.8 1765.6 7419.6 7512.0 7691.1 7714.5 7728.0 7329.5 7345.7 7354.3 7421.6 7435.1 2236.1 2273.0 2274.4 2275.0 2283.0 2180.7 2209.1 2232.8 2233.9 2240.1 2195.7 2196.5 2201.3 2208.2 2246.3 2235.9 2251.6 2251.8 2255.3 2259.4 2232.6 2280.4 2281.5 2290.1 2295.8 7279.1 7289.1 7316.6 7321.2 7326.9 4591.4 4672.3 4687.2 4698.4 4702.0 3025.8 3112.8 3150.3 3189.1 3196.6 961.4 977.4 990.2 1016.3 1044.8 10066.4 10128.0 10132.2 10132.5 10251.3 3866.0 3874.5 3908.9 3912.4 4016.5 8440.9 8483.5 8490.6 8522.0 8525.5 4500.0 4506.2 4513.8 4524.0 4548.7 4179.4 4185.3 4188.5 4189.8 4194.6 3414.8 3415.8 3424.6 3469.3 3474.8 1133.9 1142.7 1150.7 1155.7 1158.8 904.3 904.4 1026.0 1082.0 1243.2 6968.5 7118.0 7123.0 7147.9 7151.4 617.4 626.9 629.1 639.4 781.8 5397.5 5587.6 5590.8 5594.9 5601.2 8730.6 9071.0 9278.7 9296.3 9330.7 8732.3 8733.7 8761.5 8843.5 8859.5 7200.8 7205.9 7251.1 7264.2 7286.8 7306.3 7372.3 7374.7 7375.9 7387.9 8098.2 8248.7 8302.2 8423.0 8436.3 8387.6 8409.2 8542.5 8627.4 8652.4 6635.2 6642.5 6683.1 6709.5 6770.8 7296.0 7303.2 7307.5 7319.3 7350.7 6688.6 6731.7 6779.7 6833.9 6879.1 6249.2 6660.8 6739.6 6749.9 6861.7 6791.7 6950.7 6990.1 7003.7 7034.5 6451.7 6470.2 6475.5 6484.6 6488.3 6318.3 6343.0 6412.5 6437.5 6437.5 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | [#4] prototype.html Cycles:180 Average:5619.90 Median:6357.25 stddev:1711.40 (26.9%) stddev-sans-first:1669.22 04:08:11 INFO - PROCESS | 19129 | Values: 313.8 323.9 331.1 331.5 336.5 6281.7 6314.6 6327.6 6413.8 6464.3 6325.4 6329.4 6350.7 6356.1 6373.2 4805.3 4810.3 4813.5 4816.3 4819.4 4805.0 4805.3 4808.9 4817.4 4822.1 4669.6 4750.5 4764.8 4765.5 4783.9 4752.2 4756.6 4757.0 4761.1 4780.1 4098.6 4108.1 4110.4 4114.8 4118.7 6032.9 6035.0 6039.6 6043.8 6046.3 5411.3 5511.8 5526.5 5536.6 5563.3 6690.4 6694.8 6702.3 6707.0 6708.6 4524.5 4524.5 4530.0 4537.6 4539.7 6723.5 6835.9 6895.4 6925.4 6935.0 4696.3 4737.7 4750.3 4771.8 4786.7 4821.8 4827.5 4831.1 4838.8 4852.5 5577.6 5580.4 5595.1 5598.7 5600.9 6582.1 6814.5 6815.0 6817.5 6834.8 1684.9 1696.5 1713.8 1721.8 1726.4 1127.2 1142.6 1148.2 1148.7 1164.7 6321.4 6323.7 6358.4 6372.5 6373.9 6869.5 6878.4 6887.0 6895.3 6927.9 6213.7 6345.0 6361.6 6364.4 6371.2 3774.7 3832.1 3837.2 3842.4 3844.8 7154.4 7162.5 7184.4 7202.7 7216.7 6973.4 7199.8 7210.1 7257.6 7266.3 7174.2 7174.3 7179.4 7179.7 7194.0 6988.1 7043.0 7047.2 7058.8 7059.6 6795.3 6974.3 6976.9 6985.2 6989.1 7161.8 7163.6 7164.3 7169.7 7182.5 4680.0 4712.9 4734.1 4736.6 4746.6 6717.9 6854.8 6864.5 7034.1 7041.3 6644.4 6809.0 6853.0 6858.5 6875.9 6791.9 6817.8 6817.8 6820.0 6851.8 6519.3 6688.9 6692.5 6709.2 6721.4 6847.9 6860.2 6860.7 6866.0 6872.3 6701.8 6710.8 6717.2 6722.4 6729.0 04:08:11 INFO - PROCESS | 19129 | 04:08:11 INFO - PROCESS | 19129 | [#5] yui.html Cycles:180 Average:13543.74 Median:47587.17 stddev:15915.80 (33.4%) stddev-sans-first:15931.42 04:08:11 INFO - PROCESS | 19129 | Values: 743.2 746.3 759.6 832.9 838.6 11904.6 11943.3 11949.7 11970.5 12033.9 11878.4 12005.9 12030.6 12032.7 12042.3 808.5 821.5 838.6 838.8 839.8 834.1 835.2 838.9 839.6 842.4 864.6 869.1 870.6 870.7 873.4 857.8 861.6 865.4 865.6 865.9 636.0 638.7 639.1 639.4 641.5 12814.4 12873.2 12893.4 13023.5 13056.8 10847.5 11566.5 11589.8 11802.5 11947.3 10253.5 10298.5 10433.8 10451.7 10507.7 3550.1 3566.2 3568.4 3599.5 3694.1 47491.3 47683.0 47684.5 47797.3 47841.5 9325.1 9443.4 9493.3 9506.3 9782.4 17367.9 17484.0 17506.8 17530.6 17559.9 6638.0 6736.2 6786.1 6898.6 6968.0 4084.5 4093.5 4228.4 4294.7 4466.2 2826.1 2834.4 2836.0 2842.1 2858.8 525.2 528.4 529.2 530.8 535.9 579.9 600.0 605.5 628.6 666.3 8498.4 8549.9 8791.8 8831.1 9159.2 643.8 662.6 667.4 711.1 715.7 3847.4 4024.1 4080.9 4088.8 4171.5 54864.0 57655.7 60840.4 61609.0 61627.0 50102.0 50210.2 50257.2 50347.7 50922.0 46268.8 46317.8 46492.5 46711.8 46848.3 8225.5 8448.7 8594.5 8616.0 8641.6 33749.8 34060.5 35254.0 35935.5 36241.8 41417.0 41503.6 42463.2 42690.4 42735.4 10493.8 10592.4 10736.6 10807.4 10992.2 11540.1 11766.9 11828.2 12042.0 12199.8 11339.0 11404.9 11540.1 11595.3 11952.1 10759.9 10940.9 11022.6 11272.1 11310.3 11059.6 11097.5 11137.8 11213.1 11466.0 9276.6 9335.4 9379.3 9431.3 9661.8 8952.5 9146.8 9168.0 9718.2 9730.5 04:08:11 INFO - PROCESS | 19129 | -------- Summary: end -------- 04:08:11 INFO - PROCESS | 19129 | 04:08:12 INFO - TEST-INFO | 19129: exit 0 04:08:12 INFO - TEST-OK | dromaeo_css | took 1110429ms 04:08:12 INFO - TEST-START | kraken 04:08:12 INFO - operating with platform_type : linux_ 04:08:12 INFO - Initialising browser for kraken test... 04:08:12 INFO - TEST-INFO | started process 19369 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgdBH0U/profile http://localhost:58600/getInfo.html) 04:08:16 INFO - PROCESS | 19369 | __metrics Screen width/height:1600/1200 04:08:16 INFO - PROCESS | 19369 | colorDepth:24 04:08:16 INFO - PROCESS | 19369 | Browser inner width/height: 1024/697 04:08:16 INFO - PROCESS | 19369 | __metrics 04:08:17 INFO - PROCESS | 19369 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:08:17 INFO - TEST-INFO | 19369: exit 0 04:08:17 INFO - Browser initialized. 04:08:17 INFO - Running cycle 1/1 for kraken test... 04:08:17 INFO - TEST-INFO | started process 19489 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgdBH0U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:29 INFO - PROCESS | 19489 | RSS: Main: 150507520 04:08:29 INFO - PROCESS | 19489 | 04:08:32 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58600/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:32 INFO - PROCESS | 19489 | RSS: Main: 151293952 04:08:32 INFO - PROCESS | 19489 | 04:08:35 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58600/tests/kraken/driver.html?testName=audio-dft) 04:08:36 INFO - PROCESS | 19489 | RSS: Main: 151539712 04:08:36 INFO - PROCESS | 19489 | 04:08:38 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58600/tests/kraken/driver.html?testName=audio-fft) 04:08:39 INFO - PROCESS | 19489 | RSS: Main: 145379328 04:08:39 INFO - PROCESS | 19489 | 04:08:41 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58600/tests/kraken/driver.html?testName=audio-oscillator) 04:08:42 INFO - PROCESS | 19489 | RSS: Main: 145715200 04:08:42 INFO - PROCESS | 19489 | 04:08:44 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:44 INFO - PROCESS | 19489 | RSS: Main: 146509824 04:08:44 INFO - PROCESS | 19489 | 04:08:47 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58600/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:48 INFO - PROCESS | 19489 | RSS: Main: 145362944 04:08:48 INFO - PROCESS | 19489 | 04:08:51 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58600/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:52 INFO - PROCESS | 19489 | RSS: Main: 148340736 04:08:52 INFO - PROCESS | 19489 | 04:08:55 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58600/tests/kraken/driver.html?testName=json-parse-financial) 04:08:55 INFO - PROCESS | 19489 | RSS: Main: 147005440 04:08:55 INFO - PROCESS | 19489 | 04:08:57 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:58 INFO - PROCESS | 19489 | RSS: Main: 148574208 04:08:58 INFO - PROCESS | 19489 | 04:08:59 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:00 INFO - PROCESS | 19489 | RSS: Main: 147513344 04:09:00 INFO - PROCESS | 19489 | 04:09:02 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:03 INFO - PROCESS | 19489 | RSS: Main: 148455424 04:09:03 INFO - PROCESS | 19489 | 04:09:05 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:06 INFO - PROCESS | 19489 | RSS: Main: 148733952 04:09:06 INFO - PROCESS | 19489 | 04:09:08 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:09 INFO - PROCESS | 19489 | RSS: Main: 148340736 04:09:09 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | Cycle 1(1): loaded http://localhost:58600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58600/tests/kraken/driver.html?testName=ai-astar) 04:09:11 INFO - PROCESS | 19489 | RSS: Main: 148652032 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | __start_tp_report 04:09:11 INFO - PROCESS | 19489 | _x_x_mozilla_page_load 04:09:11 INFO - PROCESS | 19489 | _x_x_mozilla_page_load_details 04:09:11 INFO - PROCESS | 19489 | |i|pagename|runs| 04:09:11 INFO - PROCESS | 19489 | |0;ai-astar;111;106;112;109;111;123;110;110;111;110 04:09:11 INFO - PROCESS | 19489 | |1;audio-beat-detection;152;125;148;159;125;151;155;126;165;124 04:09:11 INFO - PROCESS | 19489 | |2;audio-dft;160;170;162;161;167;160;160;165;170;162 04:09:11 INFO - PROCESS | 19489 | |3;audio-fft;72;71;73;72;74;72;150;71;72;73 04:09:11 INFO - PROCESS | 19489 | |4;audio-oscillator;92;94;135;93;96;93;138;94;94;132 04:09:11 INFO - PROCESS | 19489 | |5;imaging-gaussian-blur;109;110;109;109;110;110;109;110;109;110 04:09:11 INFO - PROCESS | 19489 | |6;imaging-darkroom;146;146;147;147;146;147;147;147;147;147 04:09:11 INFO - PROCESS | 19489 | |7;imaging-desaturate;96;96;97;97;96;98;96;96;96;96 04:09:11 INFO - PROCESS | 19489 | |8;json-parse-financial;60;60;60;59;61;61;60;61;58;62 04:09:11 INFO - PROCESS | 19489 | |9;json-stringify-tinderbox;66;69;66;67;67;67;67;66;67;66 04:09:11 INFO - PROCESS | 19489 | |10;stanford-crypto-aes;86;84;84;84;84;84;84;91;85;84 04:09:11 INFO - PROCESS | 19489 | |11;stanford-crypto-ccm;118;117;124;120;130;126;117;119;120;118 04:09:11 INFO - PROCESS | 19489 | |12;stanford-crypto-pbkdf2;141;144;156;168;154;156;151;151;155;140 04:09:11 INFO - PROCESS | 19489 | |13;stanford-crypto-sha256-iterative;69;68;69;67;67;69;67;71;68;66 04:09:11 INFO - PROCESS | 19489 | __end_tp_report 04:09:11 INFO - PROCESS | 19489 | __start_cc_report 04:09:11 INFO - PROCESS | 19489 | _x_x_mozilla_cycle_collect,748 04:09:11 INFO - PROCESS | 19489 | __end_cc_report 04:09:11 INFO - PROCESS | 19489 | __startTimestamp1450440551268__endTimestamp 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | ------- Summary: start ------- 04:09:11 INFO - PROCESS | 19489 | Number of tests: 14 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.42 (4.0%) stddev-sans-first:4.69 04:09:11 INFO - PROCESS | 19489 | Values: 111.0 106.0 112.0 109.0 111.0 123.0 110.0 110.0 111.0 110.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:151.50 stddev:16.17 (10.7%) stddev-sans-first:16.82 04:09:11 INFO - PROCESS | 19489 | Values: 152.0 125.0 148.0 159.0 125.0 151.0 155.0 126.0 165.0 124.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:4.03 (2.5%) stddev-sans-first:4.04 04:09:11 INFO - PROCESS | 19489 | Values: 160.0 170.0 162.0 161.0 167.0 160.0 160.0 165.0 170.0 162.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#3] audio-fft Cycles:10 Average:80.00 Median:72.00 stddev:24.61 (34.2%) stddev-sans-first:25.93 04:09:11 INFO - PROCESS | 19489 | Values: 72.0 71.0 73.0 72.0 74.0 72.0 150.0 71.0 72.0 73.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.50 stddev:20.02 (21.4%) stddev-sans-first:20.57 04:09:11 INFO - PROCESS | 19489 | Values: 92.0 94.0 135.0 93.0 96.0 93.0 138.0 94.0 94.0 132.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:09:11 INFO - PROCESS | 19489 | Values: 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:09:11 INFO - PROCESS | 19489 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:09:11 INFO - PROCESS | 19489 | Values: 96.0 96.0 97.0 97.0 96.0 98.0 96.0 96.0 96.0 96.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.50 stddev:1.14 (1.9%) stddev-sans-first:1.20 04:09:11 INFO - PROCESS | 19489 | Values: 60.0 60.0 60.0 59.0 61.0 61.0 60.0 61.0 58.0 62.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 04:09:11 INFO - PROCESS | 19489 | Values: 66.0 69.0 66.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:2.21 (2.6%) stddev-sans-first:2.32 04:09:11 INFO - PROCESS | 19489 | Values: 86.0 84.0 84.0 84.0 84.0 84.0 84.0 91.0 85.0 84.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:120.00 stddev:4.36 (3.6%) stddev-sans-first:4.49 04:09:11 INFO - PROCESS | 19489 | Values: 118.0 117.0 124.0 120.0 130.0 126.0 117.0 119.0 120.0 118.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:154.50 stddev:8.37 (5.4%) stddev-sans-first:7.95 04:09:11 INFO - PROCESS | 19489 | Values: 141.0 144.0 156.0 168.0 154.0 156.0 151.0 151.0 155.0 140.0 04:09:11 INFO - PROCESS | 19489 | 04:09:11 INFO - PROCESS | 19489 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.45 (2.1%) stddev-sans-first:1.50 04:09:11 INFO - PROCESS | 19489 | Values: 69.0 68.0 69.0 67.0 67.0 69.0 67.0 71.0 68.0 66.0 04:09:11 INFO - PROCESS | 19489 | -------- Summary: end -------- 04:09:11 INFO - PROCESS | 19489 | 04:09:12 INFO - TEST-INFO | 19489: exit 0 04:09:12 INFO - TEST-OK | kraken | took 59973ms 04:09:12 INFO - TEST-START | v8_7 04:09:12 INFO - operating with platform_type : linux_ 04:09:12 INFO - Initialising browser for v8_7 test... 04:09:12 INFO - TEST-INFO | started process 19774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiA2e1P/profile http://localhost:58600/getInfo.html) 04:09:16 INFO - PROCESS | 19774 | __metrics Screen width/height:1600/1200 04:09:16 INFO - PROCESS | 19774 | colorDepth:24 04:09:16 INFO - PROCESS | 19774 | Browser inner width/height: 1024/697 04:09:16 INFO - PROCESS | 19774 | __metrics 04:09:17 INFO - PROCESS | 19774 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:09:18 INFO - TEST-INFO | 19774: exit 0 04:09:18 INFO - Browser initialized. 04:09:18 INFO - Running cycle 1/1 for v8_7 test... 04:09:18 INFO - TEST-INFO | started process 19896 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiA2e1P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:29 INFO - PROCESS | 19896 | RSS: Main: 150638592 04:09:29 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | Cycle 1(1): loaded http://localhost:58600/tests/v8_7/run.html (next: http://localhost:58600/tests/v8_7/run.html) 04:09:51 INFO - PROCESS | 19896 | RSS: Main: 147374080 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | __start_tp_report 04:09:51 INFO - PROCESS | 19896 | _x_x_mozilla_page_load 04:09:51 INFO - PROCESS | 19896 | _x_x_mozilla_page_load_details 04:09:51 INFO - PROCESS | 19896 | |i|pagename|runs| 04:09:51 INFO - PROCESS | 19896 | |0;Richards;167.39203213927016 04:09:51 INFO - PROCESS | 19896 | |1;DeltaBlue;188.43037497644622 04:09:51 INFO - PROCESS | 19896 | |2;Encrypt;278.9400278940028 04:09:51 INFO - PROCESS | 19896 | |3;Decrypt;5191.709844559586 04:09:51 INFO - PROCESS | 19896 | |4;RayTrace;1076.4262648008612 04:09:51 INFO - PROCESS | 19896 | |5;Earley;754.7169811320755 04:09:51 INFO - PROCESS | 19896 | |6;Boyer;12395.061728395061 04:09:51 INFO - PROCESS | 19896 | |7;RegExp;25000 04:09:51 INFO - PROCESS | 19896 | |8;Splay;706.6666666666666 04:09:51 INFO - PROCESS | 19896 | |9;NavierStokes;4826.923076923077 04:09:51 INFO - PROCESS | 19896 | __end_tp_report 04:09:51 INFO - PROCESS | 19896 | __startTimestamp1450440591323__endTimestamp 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | ------- Summary: start ------- 04:09:51 INFO - PROCESS | 19896 | Number of tests: 10 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#0] Richards Cycles:1 Average:167.39 Median:167.39 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 167.4 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 188.4 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 278.9 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 5191.7 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 1076.4 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#5] Earley Cycles:1 Average:754.72 Median:754.72 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 754.7 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 12395.1 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#7] RegExp Cycles:1 Average:25000.00 Median:25000.00 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 25000.0 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#8] Splay Cycles:1 Average:706.67 Median:706.67 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 706.7 04:09:51 INFO - PROCESS | 19896 | 04:09:51 INFO - PROCESS | 19896 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:09:51 INFO - PROCESS | 19896 | Values: 4826.9 04:09:51 INFO - PROCESS | 19896 | -------- Summary: end -------- 04:09:51 INFO - PROCESS | 19896 | 04:09:52 INFO - TEST-INFO | 19896: exit 0 04:09:52 INFO - TEST-OK | v8_7 | took 39839ms 04:09:52 INFO - SUITE-END | took 1210s 04:09:52 INFO - Completed test suite (00:20:10) 04:09:52 INFO - Working with test: dromaeo_css 04:09:52 INFO - Generating results file: dromaeo_css 04:09:52 INFO - Working with test: kraken 04:09:52 INFO - Generating results file: kraken 04:09:52 INFO - javascript benchmark 04:09:52 INFO - Working with test: v8_7 04:09:52 INFO - Generating results file: v8_7 04:09:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 04:09:52 INFO - process_Request line: dromaeo_css 6963.65 graph.html#tests=[[72,63,43]] 04:09:52 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:52 INFO - process_Request line: kraken 1509.30 graph.html#tests=[[232,63,43]] 04:09:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:52 INFO - process_Request line: v8_7 20898.75 graph.html#tests=[[230,63,43]] 04:09:52 INFO - RETURN: dromaeo_css: 6963.65 04:09:52 INFO - RETURN: kraken: 1509.30 04:09:52 INFO - RETURN: v8_7: 20898.75 04:09:52 INFO - javascript benchmark 04:09:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3220.4364236258657, 3280.4095262852675, 3309.751768617354, 3317.5521304623885, 3321.0368992992035, 5250.133727934895, 5536.916946245805, 5547.916781248279, 5549.02891993901, 5560.443955604448, 5331.920021199685, 5383.031054410205, 5387.730613469321, 5441.5102640762325, 5450.5367043801325, 5038.82364117255, 5056.266841308008, 5116.232565115244, 5119.0, 5123.615728820335, 4736.786844591985, 5116.283720279164, 5186.351706036746, 5199.402068762103, 5202.167653175493, 4893.926591101119, 4920.876978075541, 5001.7999280028935, 5026.798928042874, 5036.899262014776, 5033.597312215014, 5049.293098966147, 5053.873653158664, 5074.035933172685, 5099.209622508517, 4858.222684370519, 5000.149974504307, 5015.0972824891505, 5019.52314530119, 5029.647924645276, 5240.161574148118, 5248.580113590903, 5254.737263136828, 5271.367435907678, 5278.736063196825, 5954.7915822946425, 5973.223480947492, 5987.700614969278, 5988.7604495820115, 6005.639661620273, 5717.428257174291, 5833.591648584601, 5996.940030599681, 6016.96991515044, 6030.969845150747, 5336.759845806909, 5422.783088676409, 5428.484293992104, 5428.891422171534, 5447.128459446509, 5966.403359663999, 5966.76132954677, 5974.40255974399, 5988.131720900445, 6026.849328766816, 5559.11054231321, 5698.974184646803, 5741.827745167651, 5790.363060063474, 5832.825015249549, 5913.083472061838, 6000.759969601167, 6007.459328660441, 6016.398360164036, 6016.789412370634, 5833.620814647034, 5888.440598143169, 5898.351181370046, 5905.940940590625, 5922.792702255487, 5671.489565939085, 5767.8558036049435, 5806.361300256968, 5931.703414829328, 5954.285485741739, 4508.774561271924, 4517.887052823706, 4520.864374068783, 4521.864344069618, 4553.203189441834, 4017.5982401760175, 4021.7184797063924, 4040.777757223381, 4059.3505039193587, 4088.366303223005, 5408.621396502286, 5450.91823622646, 5503.449655034545, 5513.2005859151, 5527.751251193626, 5800.158976948319, 5907.2911250650195, 5912.970435147797, 5923.111533269957, 5923.17075609415, 5461.42655021225, 5479.890402191933, 5480.0, 5493.450654934474, 5530.004599172187, 4992.126377883856, 5033.899322013539, 5084.949150508522, 5117.8464646060675, 5153.896922061613, 6102.9694851525455, 6157.815265542041, 6182.876342473125, 6192.907106393498, 6192.938070619326, 5622.100463925753, 6070.362611925684, 6094.695265236632, 6094.75620975156, 6098.908516372169, 5882.205902203148, 5917.733701983507, 5968.791092311748, 5981.102834574848, 5999.880002400015, 5792.478676919098, 5916.053431450947, 5936.406359364202, 5949.167116603766, 5959.344472108151, 5789.2763404574425, 5886.293644762656, 6025.6083354581815, 6049.637021778707, 6051.031834906394, 5783.074708046693, 5864.618799778001, 5877.471027607536, 5880.50015748649, 5931.13998470228, 5885.823425297248, 5903.498202652822, 5905.852353691193, 5906.586538942232, 5909.438603332676, 5485.725713714219, 5548.140038294071, 5599.160125981135, 5801.506871915765, 5833.883322333445, 5733.3406658234835, 5829.59192856496, 5839.416058394127, 5875.089361149029, 5895.67573783446, 5743.827685169452, 5761.683107428964, 5765.365809760839, 5765.8270251890835, 5775.7400916957995], "unit": "score", "name": "dojo.html", "value": 5440.800347914628}, {"lowerIsBetter": false, "replicates": [583.594401890686, 592.5881512348919, 593.8070127208658, 624.7875722254432, 630.501903496238, 37606.43590346144, 38624.42063369048, 38625.227495450075, 38631.0, 38646.420303695464, 39293.0, 39460.210795784136, 39768.60231397685, 39861.20277594446, 39867.0, 8585.656573737044, 8708.608112634915, 8732.432391894537, 8734.650613975433, 8740.606672699743, 8477.321814254845, 8548.61531231093, 8628.007779105388, 8649.437786543886, 8663.740087797376, 8595.054544000155, 8669.566521673923, 8671.479711217316, 8671.739847804576, 8681.826363472726, 8628.870566941501, 8659.653613855438, 8670.696525621574, 8702.216800487986, 8731.083236260196, 8464.44981076228, 8571.657133714643, 8587.055423903366, 8606.78483037929, 8613.741587752378, 36363.4545481818, 36626.81686591577, 36728.449073263924, 36730.63269367299, 36758.08104797375, 2950.7786915981173, 2999.0, 3076.707782731236, 3176.4758814795764, 3527.0829584308008, 29549.70450295491, 29732.256693582833, 29780.106596802132, 29973.850130749426, 30027.849860750775, 3652.726045546568, 3830.0, 3847.7883716395586, 3885.514310711161, 3919.9216015679813, 254107.0, 256204.0, 258996.0, 259059.0, 259963.0, 51334.22998655023, 52362.476375236525, 57492.13761793576, 57564.42435575591, 58855.7029867314, 53994.0, 54394.72802635962, 54664.0, 54695.72652136714, 54725.72637136789, 14052.508162214273, 14142.151470911778, 14170.149791012365, 14172.291385430688, 14293.714125717428, 10789.0, 10830.079443247412, 10833.78332433347, 10893.782124357469, 10894.291871028357, 19148.521286967658, 19617.289173115627, 20229.595408091755, 20409.591808163754, 20471.181152753725, 7602.80992975169, 7827.491213071132, 7850.175731548219, 7852.528848269122, 7971.1303930584945, 879.9736007919772, 1028.3264461777549, 1036.2487196782272, 1051.9316244444087, 1075.956961721538, 27879.721202788118, 27899.442011159663, 28185.43629127447, 28836.42327153445, 30512.542311865338, 1040.5005597313332, 1080.206048554312, 1131.7000994736402, 1169.0881112732084, 1189.6193218170104, 14035.43858245679, 14249.278175902407, 14384.568462946128, 14438.927805360907, 14510.201938893462, 346961.0, 347568.0, 349765.0, 350268.0, 351588.0, 49720.0, 49815.75092124589, 49880.0, 49919.75040124776, 50065.0, 1371.8765311121847, 1383.266868559665, 1386.5978866128912, 1392.1716578635696, 1395.1907893421792, 26301.60547591826, 27117.186484405498, 27185.72814271832, 27263.318417039733, 27344.589831152945, 45079.54920450754, 45531.0, 45565.0, 45613.08773824571, 45726.54273457223, 311135.0, 312341.0, 314506.0, 314843.0, 314936.0, 30202.2449438757, 31203.219919502193, 31557.36885262236, 31625.36749265048, 31774.36451271008, 36907.26185476329, 37336.81331593324, 37553.81223093867, 37849.24301514009, 37917.81041094777, 32856.178595534344, 34505.654943450245, 35458.822705886305, 35777.82111089428, 35835.46246806248, 34462.827685862416, 35004.64995350014, 35150.648493515764, 35652.28695426129, 35710.4643430354, 31947.520787188674, 32085.839570801996, 32236.516452253705, 32362.190945226557, 35315.646843531234, 27736.167914962585, 27989.580156297263, 29684.257893552833, 29834.254143646584, 29913.551296731002, 22276.888615556818, 22528.32415027552, 23353.76646233516, 24017.0, 24359.634605481286], "unit": "score", "name": "ext.html", "value": 17992.973816436996}, {"lowerIsBetter": false, "replicates": [358.346018516208, 358.75963104719835, 363.75628329019554, 364.1569765991729, 366.4484950150024, 16597.502074937755, 17226.138693065343, 17522.0, 17759.822401775993, 18283.17725702343, 16177.676446471092, 16286.267117979689, 16492.42276520322, 16536.255868485918, 16795.83204167958, 4860.781264843082, 4943.579795717368, 4947.653664243504, 4948.901021979558, 4952.3561936948145, 4899.848535594133, 4951.851444456672, 4954.826581069663, 4957.231629097496, 5039.899202015958, 4968.35411396518, 5102.107131252034, 5125.3080834087295, 5144.43411224765, 5167.224916262553, 5120.897582048338, 5121.897562048738, 5148.974255128719, 5151.587872970172, 5151.613628977823, 4911.45973942866, 5091.338126043628, 5102.846914592568, 5143.8456846294675, 5149.871253218699, 19503.219871205278, 19657.508562286057, 19973.700394494095, 20798.16807327705, 20813.791862081336, 2114.9365519034454, 2140.871547707127, 2247.9591027978113, 2309.0532881518498, 2326.581215381231, 9476.052394760538, 9550.522473876279, 9568.234541236685, 9795.90204097957, 12359.134860559765, 1786.3033416967394, 1826.9768929399445, 1884.2463014794055, 1894.0529735132434, 1899.9265415040459, 56786.1482077765, 58929.41070589282, 59037.70481147567, 60071.69964150195, 60429.395706042815, 9545.809083818285, 9690.418574885389, 9807.754806129904, 9834.950825245827, 10029.224428624953, 12938.741225175443, 13025.47898084085, 13048.673783155307, 13054.869451305556, 13065.412056457482, 7305.123385193704, 7316.524425912298, 7386.556806591621, 7415.555066696015, 7426.851462970711, 7060.329268719566, 7079.716811327592, 7084.964575177194, 7099.82250443743, 7137.179224389261, 4222.472190976128, 4261.147770445923, 4284.357346398066, 4284.935725964113, 4334.0248444099825, 1798.2267624921149, 1844.2162081115473, 1849.5745978425039, 1852.1757817771231, 1859.544411619162, 433.4386968875314, 793.262266092528, 869.7086476030601, 983.4246965525248, 1004.9949750251349, 9968.950155249177, 10340.810806757168, 10380.896191037993, 16575.41986030483, 17736.379226727004, 870.2124577257592, 912.8721978922956, 939.4081728510994, 989.6091044037565, 991.9752006199902, 7924.722634707758, 9657.130858222654, 9747.0, 9752.561134748812, 9787.0, 505568.0, 506879.0, 514676.0, 527248.0, 533561.0, 79970.6001469989, 80501.19498804936, 82720.58639706763, 82877.0, 83233.0, 1083.160550573312, 1085.918556108295, 1093.814051611228, 1110.2949626986922, 1137.4597066393562, 15412.46056388021, 15474.5357639271, 15478.458253961056, 15553.455629052929, 15648.217589120271, 35239.647603523634, 35519.46720799242, 36053.27893442169, 36412.27175456529, 36561.81719091388, 47432.525674742814, 47672.0, 47877.0, 48494.757526212146, 50433.0, 9263.53682315868, 9533.809323813624, 9629.951850240985, 9693.660721874701, 9723.951380243336, 9189.86215206759, 11699.122565807429, 12377.0, 17680.82319176843, 17791.19939602695, 14655.85344146545, 14788.482403115839, 14804.333804979016, 14897.627559310671, 14905.701885962437, 13901.86098139046, 14137.222452765196, 14513.097380524148, 14639.853601463848, 14739.041962272418, 9257.518796992717, 14330.211838348574, 14621.70756584841, 14877.553673389815, 15166.924165379543, 9651.131398174199, 9707.757306067122, 9733.124018838056, 9811.460369679451, 9865.408075515492, 10256.230782691178, 10328.638497652546, 12302.569410070604, 14754.852451475348, 15304.234788260319], "unit": "score", "name": "jquery.html", "value": 8629.83540743137}, {"lowerIsBetter": false, "replicates": [1463.9121652700846, 1690.771745814315, 1722.164750096203, 1736.7568540404354, 1765.5762616971926, 7419.629018549072, 7512.0, 7691.115521715004, 7714.49855759376, 7727.9613601931915, 7329.523580967247, 7345.7428989985365, 7354.301341372575, 7421.591812450313, 7435.144958329794, 2236.1055577768902, 2272.9659055114184, 2274.431392151962, 2275.0444813178506, 2282.9771702283015, 2180.738311402634, 2209.0611490116717, 2232.799048085672, 2233.8883055847223, 2240.0591751464344, 2195.6706494025943, 2196.494806194576, 2201.317591546626, 2208.182972300251, 2246.3485589179118, 2235.865848049114, 2251.628481300592, 2251.763564825686, 2255.323402979116, 2259.3899647095272, 2232.5758105959817, 2280.407094155515, 2281.4638559938403, 2290.0954123121273, 2295.8163346932374, 7279.053723016027, 7289.052423185005, 7316.5975871327055, 7321.1580668223305, 7326.864336027871, 4591.357209990604, 4672.252439609646, 4687.22660760974, 4698.412698412699, 4701.976490117528, 3025.8184508929535, 3112.797668151563, 3150.3069324748517, 3189.1389324882152, 3196.6164060312913, 961.4135377419768, 977.3793641037921, 990.1583653894204, 1016.3393794033864, 1044.81715699753, 10066.446345450997, 10127.999999999925, 10132.240081993807, 10132.493375331203, 10251.282410231286, 3866.0, 3874.5156855393075, 3908.882733517999, 3912.4131380293184, 4016.5380981187536, 8440.873386899202, 8483.490990540588, 8490.575471226537, 8522.0, 8525.531095789791, 4500.0, 4506.188886000551, 4513.81944722214, 4524.0, 4548.681592288574, 4179.373094035919, 4185.309423945015, 4188.539260681323, 4189.790510474464, 4194.622483976456, 3414.812185329781, 3415.777974431654, 3424.5890493140982, 3469.2887957968555, 3474.774139680913, 1133.9433028348549, 1142.714321419645, 1150.7065698246893, 1155.6590805712335, 1158.7856246594406, 904.2810965282616, 904.380499357942, 1025.9846102308472, 1081.9829360401197, 1243.1795015290047, 6968.547044442095, 7118.039064726299, 7123.0, 7147.89278160828, 7151.392131668867, 617.4072890025536, 626.8965620672537, 629.1255155334089, 639.4372951802384, 781.8233558494543, 5397.460253974571, 5587.608867379326, 5590.776368945197, 5594.888102237933, 5601.243832082617, 8730.607122679494, 9070.956839963357, 9278.675246366345, 9296.256299496024, 9330.720078397659, 8732.301415886714, 8733.650653973897, 8761.518116503654, 8843.513606751561, 8859.512726800089, 7200.783976480609, 7205.92794072063, 7251.093613298338, 7264.237255088246, 7286.781396558112, 7306.305900939402, 7372.336489715952, 7374.668139933823, 7375.926240737524, 7387.889181662387, 8098.190180981855, 8248.711295104642, 8302.169783021649, 8423.031351394424, 8436.282915952213, 8387.580620969049, 8409.2431681149, 8542.530160841214, 8627.352948529011, 8652.351073669373, 6635.23694775107, 6642.468602511691, 6683.064370987969, 6709.496787741036, 6770.796876093725, 7296.0, 7303.196648368781, 7307.451941104332, 7319.341259286477, 7350.7427240046345, 6688.565243259172, 6731.697073631796, 6779.72881084751, 6833.89749153773, 6879.140107486564, 6249.218847644044, 6660.800175994728, 6739.59562426256, 6749.898751518633, 6861.656917154222, 6791.72833086671, 6950.721971121301, 6990.056342393712, 7003.719851205895, 7034.5427547209265, 6451.741930322734, 6470.158879345655, 6475.546711730133, 6484.643344615903, 6488.286288508166, 6318.336574659778, 6342.968285158545, 6412.519061070531, 6437.452816510649, 6437.549371543947], "unit": "score", "name": "mootools.html", "value": 4318.9492956079075}, {"lowerIsBetter": false, "replicates": [313.7678118192537, 323.93035497368066, 331.1010606204158, 331.4613752651941, 336.52213856324016, 6281.654509002009, 6314.589551679143, 6327.5570710050315, 6413.8075857724225, 6464.288928217892, 6325.367463253672, 6329.430351268396, 6350.745970161188, 6356.110144579751, 6373.171487706603, 4805.3032310315075, 4810.254410566367, 4813.518648135194, 4816.325714399987, 4819.44576373718, 4804.975975120137, 4805.279208118775, 4808.879778005543, 4817.373741413611, 4822.083804077231, 4669.626429885601, 4750.501197374278, 4764.833230836922, 4765.451973023095, 4783.904321913559, 4752.239641657353, 4756.571908528232, 4757.0, 4761.119192949315, 4780.139574876521, 4098.610631989956, 4108.075682971337, 4110.362893751473, 4114.835406583763, 4118.711690181688, 6032.939670603281, 6035.004224302985, 6039.607425517327, 6043.758249670008, 6046.27444706638, 5411.296531450926, 5511.834644960658, 5526.530244929186, 5536.557075433996, 5563.304586926634, 6690.397864192246, 6694.83262918426, 6702.329767023308, 6706.966465167692, 6708.597484150967, 4524.45706515217, 4524.547545245482, 4529.954700452986, 4537.614302784267, 4539.72761634303, 6723.529352945296, 6835.863282734367, 6895.413889819371, 6925.445964322842, 6934.965325173393, 4696.342512048316, 4737.692050016738, 4750.287456881426, 4771.809127634925, 4786.664933454625, 4821.831235906797, 4827.517248275144, 4831.057943700945, 4838.782254798542, 4852.539008794159, 5577.609567330248, 5580.414056524088, 5595.104783234663, 5598.720063996784, 5600.943990560124, 6582.144321238208, 6814.522983391214, 6815.0, 6817.454603631698, 6834.760783372558, 1684.873634477419, 1696.5419336779, 1713.8286171382763, 1721.7761690980092, 1726.3526177683368, 1127.1658972360394, 1142.5772464188303, 1148.1561052626314, 1148.7070796946891, 1164.7495788405533, 6321.431071203614, 6323.715432805535, 6358.395952384516, 6372.522060845363, 6373.936260637427, 6869.484788640872, 6878.449724022166, 6887.004153193277, 6895.34494223048, 6927.930720692729, 6213.65824879627, 6344.984802431589, 6361.554691171574, 6364.363563643691, 6371.203599550056, 3774.698024158061, 3832.080300727805, 3837.175007373428, 3842.3852183650483, 3844.8462061517785, 7154.39187669054, 7162.4628152888745, 7184.389326907271, 7202.7118915243855, 7216.7370710125515, 6973.4072603829245, 7199.820004499929, 7210.062691850026, 7257.600831954293, 7266.346028857428, 7174.246704096099, 7174.282571742889, 7179.425645948416, 7179.748708795167, 7193.964030179815, 6988.056612357267, 7043.0, 7047.1895731989425, 7058.788236352918, 7059.5764254144915, 6795.286494917962, 6974.267701891431, 6976.895346569907, 6985.231624521197, 6989.126359205099, 7161.820954475971, 7163.6060016699585, 7164.283571642794, 7169.749058782918, 7182.497225194186, 4680.017196388796, 4712.882177945578, 4734.05318936221, 4736.550027747358, 4746.572808447257, 6717.865642687217, 6854.828629284308, 6864.485163612849, 7034.085568876013, 7041.260667629826, 6644.368784965421, 6808.9659551701925, 6852.965735171292, 6858.451323893977, 6875.862482750417, 6791.93208067913, 6817.795466136024, 6817.829554261183, 6819.977003449522, 6851.760188393382, 6519.250286217146, 6688.933110668831, 6692.531522793358, 6709.161354830646, 6721.395074443323, 6847.897281540681, 6860.2453730088655, 6860.6912688930115, 6866.038754574463, 6872.278410766798, 6701.765438209834, 6710.83222919431, 6717.193936727624, 6722.361375669304, 6728.966355168192], "unit": "score", "name": "prototype.html", "value": 5054.748091918745}, {"lowerIsBetter": false, "replicates": [743.1899229839474, 746.3432179681876, 759.6467642546215, 832.9292010179134, 838.643576479996, 11904.642860714172, 11943.34311612861, 11949.701257468567, 11970.521179152824, 12033.939830300847, 11878.406079696002, 12005.879941200585, 12030.578929737461, 12032.699182520442, 12042.337671428068, 808.5068108453838, 821.4783612406135, 838.5849004742661, 838.8028813228917, 839.8404303182376, 834.1241696218946, 835.1606635331514, 838.9077201507829, 839.5844057191699, 842.3555979675554, 864.6066039951806, 869.148234729965, 870.6256309786789, 870.6909047288217, 873.3929918706501, 857.8284343131398, 861.5519929636554, 865.3942240431722, 865.5715420866649, 865.8744482050099, 636.0, 638.7476946606112, 639.076534407781, 639.3829954094322, 641.4932203559183, 12814.359282035954, 12873.163244389178, 12893.419796109198, 13023.47906083765, 13056.804147937788, 10847.51186196623, 11566.53733850645, 11589.826152607717, 11802.527898884035, 11947.342896140708, 10253.487325633763, 10298.485075746183, 10433.843492347622, 10451.68644940653, 10507.684769456928, 3550.094725844893, 3566.197605538759, 3568.3933731265747, 3599.5320608321013, 3694.11341278094, 47491.28763068557, 47683.04633907337, 47684.52315476836, 47797.28304075442, 47841.5215847844, 9325.067493250757, 9443.386179898285, 9493.288003399774, 9506.334556580972, 9782.364146330467, 17367.91585009807, 17484.0, 17506.824931750773, 17530.64938701219, 17559.912200438917, 6637.9668101660145, 6736.1916570010935, 6786.117804685359, 6898.586084834926, 6967.965160174167, 4084.4690190275073, 4093.5087789465456, 4228.386883901817, 4294.742315461082, 4466.151431228056, 2826.138027901469, 2834.3906060197155, 2835.9858200709277, 2842.0621195005597, 2858.771298296131, 525.2200482283805, 528.3580449753567, 529.1559961860826, 530.7691154347793, 535.9196120581944, 579.9130130480378, 600.0347127519808, 605.5276884030463, 628.6416742456755, 666.2571233075087, 8498.405111642125, 8549.914500854911, 8791.824163516694, 8831.072737362612, 9159.221466175317, 643.7650257655922, 662.5954953395878, 667.4193451697055, 711.1324184495011, 715.7208688611446, 3847.3844184930836, 4024.094578719823, 4080.8571699990953, 4088.8160032798, 4171.520275168395, 54864.0, 57655.71172144196, 60840.39159608347, 61609.0, 61627.0, 50102.0, 50210.246846297334, 50257.24614130791, 50347.74826125919, 50922.0, 46268.768656156506, 46317.7684111584, 46492.535074649495, 46711.766441168256, 46848.29727554089, 8225.5475948821, 8448.66205351779, 8594.527300998505, 8616.0, 8641.56792160402, 33749.83125084359, 34060.489092663134, 35254.0, 35935.46096808602, 36241.818790905876, 41417.0, 41503.58496414997, 42463.150736985706, 42690.35964460474, 42735.358969614856, 10493.842592361274, 10592.417417042137, 10736.624218152327, 10807.405592692163, 10992.17558683086, 11540.134489913458, 11766.88233117658, 11828.23116497425, 12042.036637068839, 12199.75600488003, 11339.0, 11404.885951140383, 11540.076793856639, 11595.304281743123, 11952.103592230791, 10759.946200268949, 10940.945295273472, 11022.614208502664, 11272.098232141572, 11310.264832785842, 11059.577958392236, 11097.500612472297, 11137.777244455228, 11213.102951763676, 11466.0, 9276.582553784961, 9335.439873607605, 9379.296552758435, 9431.339806213773, 9661.806763864543, 8952.491805072585, 9146.817063658822, 9168.0, 9718.222542196749, 9730.513474326397], "unit": "score", "name": "yui.html", "value": 6182.125024982807}], "name": "dromaeo_css", "value": 6963.6469231880155}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 109.0, 111.0, 123.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 148.0, 159.0, 125.0, 151.0, 155.0, 126.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [160.0, 170.0, 162.0, 161.0, 167.0, 160.0, 160.0, 165.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 72.0, 74.0, 72.0, 150.0, 71.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 135.0, 93.0, 96.0, 93.0, 138.0, 94.0, 94.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 61.0, 60.0, 61.0, 58.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 91.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 124.0, 120.0, 130.0, 126.0, 117.0, 119.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 156.0, 168.0, 154.0, 156.0, 151.0, 151.0, 155.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 67.0, 67.0, 69.0, 67.0, 71.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1509.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.39203213927016], "unit": "score", "name": "Richards", "value": 210.89414799999994}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [754.7169811320755], "unit": "score", "name": "Earley", "value": 883.0634750000003}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [25000.0], "unit": "score", "name": "RegExp", "value": 36.43939999999999}, {"lowerIsBetter": false, "replicates": [706.6666666666666], "unit": "score", "name": "Splay", "value": 115.3174528301887}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20898.748605433288}]} 04:09:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20898.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1509.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6963.65"}}} 04:09:52 INFO - Return code: 0 04:09:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:09:52 INFO - # TBPL SUCCESS # 04:09:52 INFO - Running post-action listener: _resource_record_post_action 04:09:52 INFO - Running post-run listener: _resource_record_post_run 04:09:53 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557154304; Read time: 12; Write time: 488820 04:09:53 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234692608; Read time: 0; Write time: 268888 04:09:53 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322461696; Read time: 12; Write time: 219932 04:09:53 INFO - Running post-run listener: _upload_blobber_files 04:09:53 INFO - Blob upload gear active. 04:09:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:09:53 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 04:09:53 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:09:53 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:09:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:54 INFO - (blobuploader) - INFO - Done attempting. 04:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:55 INFO - (blobuploader) - INFO - Done attempting. 04:09:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:55 INFO - Return code: 0 04:09:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:09:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00491cb66a785cc430ae5385d8052fad9c616fc68f0497f5d827d1006fc346ec88547b9f9fb4590be23e01c994fecefba2694cbd20511b623342ad4d54ef155c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae443cb3b143f0c71b4712164baffe181a10aa19d4eafcde3ec59bacd8333b240d13cff026ad944fefe555ede270c2bd668b9d725ffe1e2f2ae0e9ffcf3b783"} 04:09:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:09:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:09:55 INFO - Contents: 04:09:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00491cb66a785cc430ae5385d8052fad9c616fc68f0497f5d827d1006fc346ec88547b9f9fb4590be23e01c994fecefba2694cbd20511b623342ad4d54ef155c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae443cb3b143f0c71b4712164baffe181a10aa19d4eafcde3ec59bacd8333b240d13cff026ad944fefe555ede270c2bd668b9d725ffe1e2f2ae0e9ffcf3b783"} 04:09:55 INFO - Copying logs to upload dir... 04:09:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.794527 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-18 04:09:55.608821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:55.613140) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 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/Mozilla-Inbound/sha512/00491cb66a785cc430ae5385d8052fad9c616fc68f0497f5d827d1006fc346ec88547b9f9fb4590be23e01c994fecefba2694cbd20511b623342ad4d54ef155c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae443cb3b143f0c71b4712164baffe181a10aa19d4eafcde3ec59bacd8333b240d13cff026ad944fefe555ede270c2bd668b9d725ffe1e2f2ae0e9ffcf3b783"} build_url:https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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/Mozilla-Inbound/sha512/00491cb66a785cc430ae5385d8052fad9c616fc68f0497f5d827d1006fc346ec88547b9f9fb4590be23e01c994fecefba2694cbd20511b623342ad4d54ef155c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae443cb3b143f0c71b4712164baffe181a10aa19d4eafcde3ec59bacd8333b240d13cff026ad944fefe555ede270c2bd668b9d725ffe1e2f2ae0e9ffcf3b783"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:55.645679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:55.646318) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450438488.508634-912252049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:55.728584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 04:09:55.728926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 04:09:55.729270) ========= ========= Total master_lag: 0.29 =========