builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1452005546.85 results: success (0) buildid: 20160105043029 builduid: f2d2059745364f2e87bfdaebdad4fbf6 revision: 224c502eb6c6a3fcb874deccabdce73500e86f3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.852167) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.852624) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.852914) ========= 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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006343 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.910459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.910805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.958768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:26.959225) ========= 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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.010307) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.010611) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.010993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.011274) ========= 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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 06:52:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2016-01-05 06:52:27 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.174538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.174936) ========= 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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018400 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.225004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:27.225369) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 224c502eb6c6a3fcb874deccabdce73500e86f3b --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 224c502eb6c6a3fcb874deccabdce73500e86f3b --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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 06:52:27,732 truncating revision to first 12 chars 2016-01-05 06:52:27,732 Setting DEBUG logging. 2016-01-05 06:52:27,732 attempt 1/10 2016-01-05 06:52:27,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/224c502eb6c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 06:52:28,341 unpacking tar archive at: mozilla-inbound-224c502eb6c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901688 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:28.142058) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:28.142688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:28.153934) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:28.154324) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 06:52:28.154709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-05 06:52:28.155002) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --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', '--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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:28 INFO - MultiFileLogger online at 20160105 06:52:28 in /builds/slave/test-pgo 06:52:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:52:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:52:28 INFO - {'append_to_log': False, 06:52:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:52:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:52:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:52:28 INFO - 'branch': 'Mozilla-Inbound', 06:52:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:28 INFO - 'config_files': ('talos/linux_config.py',), 06:52:28 INFO - 'default_actions': ('clobber', 06:52:28 INFO - 'read-buildbot-config', 06:52:28 INFO - 'download-and-extract', 06:52:28 INFO - 'populate-webroot', 06:52:28 INFO - 'create-virtualenv', 06:52:28 INFO - 'install', 06:52:28 INFO - 'run-tests'), 06:52:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:28 INFO - 'download_minidump_stackwalk': True, 06:52:28 INFO - 'download_symbols': 'ondemand', 06:52:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:28 INFO - 'installer_path': 'installer.exe', 06:52:28 INFO - 'log_level': 'info', 06:52:28 INFO - 'log_name': 'talos', 06:52:28 INFO - 'log_to_console': True, 06:52:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:28 INFO - 'opt_config_files': (), 06:52:28 INFO - 'pip_index': False, 06:52:28 INFO - 'sps_profile': False, 06:52:28 INFO - 'sps_profile_interval': 0, 06:52:28 INFO - 'suite': 'dromaeojs-e10s', 06:52:28 INFO - 'system_bits': '32', 06:52:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:28 INFO - 'title': 'talos-linux64-ix-045', 06:52:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:28 INFO - 'use_talos_json': True, 06:52:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:52:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:28 INFO - 'work_dir': 'build'} 06:52:28 INFO - ##### 06:52:28 INFO - ##### Running clobber step. 06:52:28 INFO - ##### 06:52:28 INFO - Running pre-action listener: _resource_record_pre_action 06:52:28 INFO - Running main action method: clobber 06:52:28 INFO - rmtree: /builds/slave/test-pgo/build 06:52:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:52:29 INFO - Running post-action listener: _resource_record_post_action 06:52:29 INFO - ##### 06:52:29 INFO - ##### Running read-buildbot-config step. 06:52:29 INFO - ##### 06:52:29 INFO - Running pre-action listener: _resource_record_pre_action 06:52:29 INFO - Running main action method: read_buildbot_config 06:52:29 INFO - Using buildbot properties: 06:52:29 INFO - { 06:52:29 INFO - "project": "", 06:52:29 INFO - "product": "firefox", 06:52:29 INFO - "script_repo_revision": "production", 06:52:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 06:52:29 INFO - "repository": "", 06:52:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 06:52:29 INFO - "buildid": "20160105043029", 06:52:29 INFO - "pgo_build": "True", 06:52:29 INFO - "basedir": "/builds/slave/test-pgo", 06:52:29 INFO - "buildnumber": 586, 06:52:29 INFO - "slavename": "talos-linux64-ix-045", 06:52:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:52:29 INFO - "platform": "ubuntu64_hw", 06:52:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:52:29 INFO - "branch": "mozilla-inbound", 06:52:29 INFO - "repo_path": "integration/mozilla-inbound", 06:52:29 INFO - "revision": "224c502eb6c6a3fcb874deccabdce73500e86f3b", 06:52:29 INFO - "stage_platform": "linux64-pgo", 06:52:29 INFO - "builduid": "f2d2059745364f2e87bfdaebdad4fbf6", 06:52:29 INFO - "slavebuilddir": "test" 06:52:29 INFO - } 06:52:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:52:29 INFO - Running post-action listener: _resource_record_post_action 06:52:29 INFO - ##### 06:52:29 INFO - ##### Running download-and-extract step. 06:52:29 INFO - ##### 06:52:29 INFO - Running pre-action listener: _resource_record_pre_action 06:52:29 INFO - Running main action method: download_and_extract 06:52:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:29 INFO - https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:52:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/test_packages.json 06:52:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/test_packages.json 06:52:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:52:30 INFO - Downloaded 1302 bytes. 06:52:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:52:30 INFO - Using the following test package requirements: 06:52:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:52:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'jsshell-linux-x86_64.zip'], 06:52:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:52:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:52:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:52:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:52:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:52:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:52:30 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')]} 06:52:30 INFO - https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:31 INFO - Downloaded 24051359 bytes. 06:52:31 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 06:52:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:31 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 06:52:33 INFO - Return code: 0 06:52:33 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 06:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:33 INFO - https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:34 INFO - Downloaded 24051359 bytes. 06:52:34 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 06:52:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:34 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 06:52:35 INFO - Return code: 0 06:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:35 INFO - https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:36 INFO - Downloaded 11132285 bytes. 06:52:36 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 06:52:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:36 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 06:52:36 INFO - Return code: 0 06:52: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')]} 06:52:36 INFO - https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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 06:52:39 INFO - Downloaded 55031301 bytes. 06:52:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:39 INFO - mkdir: /builds/slave/test-pgo/properties 06:52:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:52:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:52:39 INFO - Contents: 06:52:39 INFO - build_url:https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:39 INFO - Running post-action listener: _resource_record_post_action 06:52:39 INFO - Running post-action listener: set_extra_try_arguments 06:52:39 INFO - ##### 06:52:39 INFO - ##### Running populate-webroot step. 06:52:39 INFO - ##### 06:52:39 INFO - Running pre-action listener: _resource_record_pre_action 06:52:39 INFO - Running main action method: populate_webroot 06:52:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:39 INFO - '--tppagecycles', 06:52:39 INFO - '7'], 06:52:39 INFO - 'tests': ['tsvgm']}}, 06:52:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:52:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'tests': ['damp', 'tps']}, 06:52:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['damp', 'tps']}, 06:52:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:52:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:39 INFO - 'other': {'tests': ['a11yr', 06:52:39 INFO - 'ts_paint', 06:52:39 INFO - 'tpaint', 06:52:39 INFO - 'sessionrestore', 06:52:39 INFO - 'sessionrestore_no_auto_restore']}, 06:52:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['a11yr', 06:52:39 INFO - 'ts_paint', 06:52:39 INFO - 'tpaint', 06:52:39 INFO - 'sessionrestore', 06:52:39 INFO - 'sessionrestore_no_auto_restore']}, 06:52:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['a11yr', 06:52:39 INFO - 'ts_paint', 06:52:39 INFO - 'tpaint', 06:52:39 INFO - 'sessionrestore', 06:52:39 INFO - 'sessionrestore_no_auto_restore']}, 06:52:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['a11yr', 06:52:39 INFO - 'ts_paint', 06:52:39 INFO - 'tpaint', 06:52:39 INFO - 'sessionrestore', 06:52:39 INFO - 'sessionrestore_no_auto_restore']}, 06:52:39 INFO - 'other_l64': {'tests': ['a11yr', 06:52:39 INFO - 'ts_paint', 06:52:39 INFO - 'tpaint', 06:52:39 INFO - 'sessionrestore', 06:52:39 INFO - 'sessionrestore_no_auto_restore']}, 06:52:39 INFO - 'other_nol64': {'tests': ['a11yr', 06:52:39 INFO - 'ts_paint', 06:52:39 INFO - 'tpaint', 06:52:39 INFO - 'sessionrestore', 06:52:39 INFO - 'sessionrestore_no_auto_restore']}, 06:52:39 INFO - 'svgr': {'tests': ['tsvgx', 06:52:39 INFO - 'tsvgr_opacity', 06:52:39 INFO - 'tart', 06:52:39 INFO - 'tscrollx', 06:52:39 INFO - 'cart']}, 06:52:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['tsvgx', 06:52:39 INFO - 'tsvgr_opacity', 06:52:39 INFO - 'tart', 06:52:39 INFO - 'tscrollx', 06:52:39 INFO - 'cart']}, 06:52:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'tests': ['tp5o']}, 06:52:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'talos_options': ['--e10s'], 06:52:39 INFO - 'tests': ['tp5o']}, 06:52:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'talos_options': ['--xperf_path', 06:52:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:39 INFO - 'tests': ['tp5n']}, 06:52:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:39 INFO - 'talos_options': ['--e10s', 06:52:39 INFO - '--xperf_path', 06:52:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:39 INFO - 'tests': ['tp5n']}}, 06:52:39 INFO - 'talos.zip': {'path': '', 06:52:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:39 INFO - Running post-action listener: _resource_record_post_action 06:52:39 INFO - ##### 06:52:39 INFO - ##### Running create-virtualenv step. 06:52:39 INFO - ##### 06:52:39 INFO - Running pre-action listener: _resource_record_pre_action 06:52:39 INFO - Running main action method: create_virtualenv 06:52:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:52:39 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 06:52:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:52:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:39 INFO - Using real prefix '/usr' 06:52:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:52:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:41 INFO - Installing pip.................done. 06:52:41 INFO - Return code: 0 06:52:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:52:41 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')]} 06:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:41 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')]} 06:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:41 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:41 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 06:52:41 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 06:52:41 INFO - Using env: {'DISPLAY': ':0', 06:52:41 INFO - 'HOME': '/home/cltbld', 06:52:41 INFO - 'LANG': 'en_US.UTF-8', 06:52:41 INFO - 'LANGUAGE': 'en_US:en', 06:52:41 INFO - 'LOGNAME': 'cltbld', 06:52:41 INFO - 'MAIL': '/var/mail/cltbld', 06:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:41 INFO - 'MOZ_NO_REMOTE': '1', 06:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:41 INFO - 'NO_EM_RESTART': '1', 06:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:41 INFO - 'SHELL': '/bin/bash', 06:52:41 INFO - 'SHLVL': '1', 06:52:41 INFO - 'TERM': 'linux', 06:52:41 INFO - 'TMOUT': '86400', 06:52:41 INFO - 'USER': 'cltbld', 06:52:41 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:41 INFO - '_': '/tools/buildbot/bin/python'} 06:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:42 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 06:52:42 INFO - Cleaning up... 06:52:42 INFO - Return code: 0 06:52:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:52:42 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')]} 06:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:42 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')]} 06:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:42 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:42 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 06:52:42 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 06:52:42 INFO - Using env: {'DISPLAY': ':0', 06:52:42 INFO - 'HOME': '/home/cltbld', 06:52:42 INFO - 'LANG': 'en_US.UTF-8', 06:52:42 INFO - 'LANGUAGE': 'en_US:en', 06:52:42 INFO - 'LOGNAME': 'cltbld', 06:52:42 INFO - 'MAIL': '/var/mail/cltbld', 06:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:42 INFO - 'MOZ_NO_REMOTE': '1', 06:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:42 INFO - 'NO_EM_RESTART': '1', 06:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:42 INFO - 'SHELL': '/bin/bash', 06:52:42 INFO - 'SHLVL': '1', 06:52:42 INFO - 'TERM': 'linux', 06:52:42 INFO - 'TMOUT': '86400', 06:52:42 INFO - 'USER': 'cltbld', 06:52:42 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:42 INFO - '_': '/tools/buildbot/bin/python'} 06:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:42 INFO - Downloading/unpacking psutil>=0.7.1 06:52:42 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 06:52:42 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 06:52:42 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 06:52:42 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 06:52:42 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 06:52:42 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 06:52:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:52:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:52:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:44 INFO - Installing collected packages: psutil 06:52:44 INFO - Running setup.py install for psutil 06:52:44 INFO - building 'psutil._psutil_linux' extension 06:52:44 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 06:52:44 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 06:52:44 INFO - building 'psutil._psutil_posix' extension 06:52:44 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 06:52:44 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 06:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:44 INFO - Successfully installed psutil 06:52:44 INFO - Cleaning up... 06:52:44 INFO - Return code: 0 06:52:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:52:44 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')]} 06:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 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')]} 06:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:44 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 06:52:44 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 06:52:44 INFO - Using env: {'DISPLAY': ':0', 06:52:44 INFO - 'HOME': '/home/cltbld', 06:52:44 INFO - 'LANG': 'en_US.UTF-8', 06:52:44 INFO - 'LANGUAGE': 'en_US:en', 06:52:44 INFO - 'LOGNAME': 'cltbld', 06:52:44 INFO - 'MAIL': '/var/mail/cltbld', 06:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:44 INFO - 'MOZ_NO_REMOTE': '1', 06:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:44 INFO - 'NO_EM_RESTART': '1', 06:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:44 INFO - 'SHELL': '/bin/bash', 06:52:44 INFO - 'SHLVL': '1', 06:52:44 INFO - 'TERM': 'linux', 06:52:44 INFO - 'TMOUT': '86400', 06:52:44 INFO - 'USER': 'cltbld', 06:52:44 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:44 INFO - '_': '/tools/buildbot/bin/python'} 06:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:52:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:52:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:52:46 INFO - Installing collected packages: mozsystemmonitor 06:52:46 INFO - Running setup.py install for mozsystemmonitor 06:52:46 INFO - Successfully installed mozsystemmonitor 06:52:46 INFO - Cleaning up... 06:52:46 INFO - Return code: 0 06:52:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:46 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 06:52:46 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 06:52:46 INFO - Using env: {'DISPLAY': ':0', 06:52:46 INFO - 'HOME': '/home/cltbld', 06:52:46 INFO - 'LANG': 'en_US.UTF-8', 06:52:46 INFO - 'LANGUAGE': 'en_US:en', 06:52:46 INFO - 'LOGNAME': 'cltbld', 06:52:46 INFO - 'MAIL': '/var/mail/cltbld', 06:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:46 INFO - 'MOZ_NO_REMOTE': '1', 06:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:46 INFO - 'NO_EM_RESTART': '1', 06:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:46 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:46 INFO - 'SHELL': '/bin/bash', 06:52:46 INFO - 'SHLVL': '1', 06:52:46 INFO - 'TERM': 'linux', 06:52:46 INFO - 'TMOUT': '86400', 06:52:46 INFO - 'USER': 'cltbld', 06:52:46 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:46 INFO - '_': '/tools/buildbot/bin/python'} 06:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:52:46 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 06:52:46 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 06:52:46 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 06:52:46 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 06:52:46 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 06:52:46 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 06:52:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:52:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:48 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 06:52:48 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 06:52:48 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 06:52:48 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 06:52:48 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 06:52:48 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 06:52:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:52:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:52:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:49 INFO - Downloading docopt-0.6.1.tar.gz 06:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:49 INFO - Running setup.py install for blobuploader 06:52:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:52:49 INFO - Running setup.py install for requests 06:52:49 INFO - Running setup.py install for docopt 06:52:49 INFO - Successfully installed blobuploader requests docopt 06:52:49 INFO - Cleaning up... 06:52:49 INFO - Return code: 0 06:52:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:49 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:49 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 06:52:49 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 06:52:49 INFO - Using env: {'DISPLAY': ':0', 06:52:49 INFO - 'HOME': '/home/cltbld', 06:52:49 INFO - 'LANG': 'en_US.UTF-8', 06:52:49 INFO - 'LANGUAGE': 'en_US:en', 06:52:49 INFO - 'LOGNAME': 'cltbld', 06:52:49 INFO - 'MAIL': '/var/mail/cltbld', 06:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:49 INFO - 'MOZ_NO_REMOTE': '1', 06:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:49 INFO - 'NO_EM_RESTART': '1', 06:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:49 INFO - 'SHELL': '/bin/bash', 06:52:49 INFO - 'SHLVL': '1', 06:52:49 INFO - 'TERM': 'linux', 06:52:49 INFO - 'TMOUT': '86400', 06:52:49 INFO - 'USER': 'cltbld', 06:52:49 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:49 INFO - '_': '/tools/buildbot/bin/python'} 06:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:50 INFO - Running setup.py (path:/tmp/pip-PXxxPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:50 INFO - Running setup.py (path:/tmp/pip-HcDpqY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:50 INFO - Running setup.py (path:/tmp/pip-m4fRTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:50 INFO - Running setup.py (path:/tmp/pip-rQ1sMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:50 INFO - Running setup.py (path:/tmp/pip-o9Lai1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:50 INFO - Running setup.py (path:/tmp/pip-8tddAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:50 INFO - Running setup.py (path:/tmp/pip-OW5MHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:50 INFO - Running setup.py (path:/tmp/pip-7NFiMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:50 INFO - Running setup.py (path:/tmp/pip-Sg_RQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:50 INFO - Running setup.py (path:/tmp/pip-rGz_cZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:50 INFO - Running setup.py (path:/tmp/pip-y4LbDA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:50 INFO - Running setup.py (path:/tmp/pip-Q_yj6a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:50 INFO - Running setup.py (path:/tmp/pip-tcCCwS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:51 INFO - Running setup.py (path:/tmp/pip-sYtThH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:51 INFO - Running setup.py (path:/tmp/pip-UFx7Yc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:51 INFO - Running setup.py (path:/tmp/pip-NJH_ba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:51 INFO - Running setup.py (path:/tmp/pip-3HeaPK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:51 INFO - Running setup.py install for manifestparser 06:52:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:52:51 INFO - Running setup.py install for mozcrash 06:52:51 INFO - Running setup.py install for mozdebug 06:52:51 INFO - Running setup.py install for mozdevice 06:52:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:52:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:52:51 INFO - Running setup.py install for mozfile 06:52:51 INFO - Running setup.py install for mozhttpd 06:52:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:52:51 INFO - Running setup.py install for mozinfo 06:52:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Running setup.py install for mozInstall 06:52:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Running setup.py install for mozleak 06:52:52 INFO - Running setup.py install for mozlog 06:52:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Running setup.py install for moznetwork 06:52:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Running setup.py install for mozprocess 06:52:52 INFO - Running setup.py install for mozprofile 06:52:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Running setup.py install for mozrunner 06:52:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:52:52 INFO - Running setup.py install for mozscreenshot 06:52:52 INFO - Running setup.py install for moztest 06:52:52 INFO - Running setup.py install for mozversion 06:52:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:52:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:53 INFO - Cleaning up... 06:52:53 INFO - Return code: 0 06:52:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:53 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 06:52:53 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 06:52:53 INFO - Using env: {'DISPLAY': ':0', 06:52:53 INFO - 'HOME': '/home/cltbld', 06:52:53 INFO - 'LANG': 'en_US.UTF-8', 06:52:53 INFO - 'LANGUAGE': 'en_US:en', 06:52:53 INFO - 'LOGNAME': 'cltbld', 06:52:53 INFO - 'MAIL': '/var/mail/cltbld', 06:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:53 INFO - 'MOZ_NO_REMOTE': '1', 06:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:53 INFO - 'NO_EM_RESTART': '1', 06:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:53 INFO - 'SHELL': '/bin/bash', 06:52:53 INFO - 'SHLVL': '1', 06:52:53 INFO - 'TERM': 'linux', 06:52:53 INFO - 'TMOUT': '86400', 06:52:53 INFO - 'USER': 'cltbld', 06:52:53 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:53 INFO - '_': '/tools/buildbot/bin/python'} 06:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:53 INFO - Running setup.py (path:/tmp/pip-34tbuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:53 INFO - Running setup.py (path:/tmp/pip-bEpyZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:53 INFO - Running setup.py (path:/tmp/pip-DiFPON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:53 INFO - Running setup.py (path:/tmp/pip-YBffib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:53 INFO - Running setup.py (path:/tmp/pip-JeHcf7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:53 INFO - Running setup.py (path:/tmp/pip-yaraxG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:53 INFO - Running setup.py (path:/tmp/pip-bRkmo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:53 INFO - Running setup.py (path:/tmp/pip-TNNAEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:53 INFO - Running setup.py (path:/tmp/pip-CzKzuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:53 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)) 06:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:53 INFO - Running setup.py (path:/tmp/pip-2VIteK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:54 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)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:54 INFO - Running setup.py (path:/tmp/pip-Mcnxm3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:54 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)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:54 INFO - Running setup.py (path:/tmp/pip-kAhfy2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:54 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)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:54 INFO - Running setup.py (path:/tmp/pip-JSjtN9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:54 INFO - Running setup.py (path:/tmp/pip-ppOdHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:54 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)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:54 INFO - Running setup.py (path:/tmp/pip-Uk2Xod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:54 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)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:54 INFO - Running setup.py (path:/tmp/pip-qhglsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:54 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)) 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:54 INFO - Running setup.py (path:/tmp/pip-j4LO81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:54 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)) 06:52:54 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)) 06:52:54 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)) 06:52:54 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)) 06:52:54 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)) 06:52:54 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)) 06:52:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:54 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 06:52:54 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 06:52:54 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 06:52:54 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 06:52:54 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 06:52:54 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 06:52:56 INFO - Downloading blessings-1.5.1.tar.gz 06:52:56 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 06:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:56 INFO - Installing collected packages: blessings 06:52:56 INFO - Running setup.py install for blessings 06:52:56 INFO - Successfully installed blessings 06:52:56 INFO - Cleaning up... 06:52:56 INFO - Return code: 0 06:52:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:52:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:56 INFO - Reading from file tmpfile_stdout 06:52:56 INFO - Current package versions: 06:52:56 INFO - argparse == 1.2.1 06:52:56 INFO - blessings == 1.5.1 06:52:56 INFO - blobuploader == 1.2.4 06:52:56 INFO - docopt == 0.6.1 06:52:56 INFO - manifestparser == 1.1 06:52:56 INFO - mozInstall == 1.12 06:52:56 INFO - mozcrash == 0.16 06:52:56 INFO - mozdebug == 0.1 06:52:56 INFO - mozdevice == 0.47 06:52:56 INFO - mozfile == 1.2 06:52:56 INFO - mozhttpd == 0.7 06:52:56 INFO - mozinfo == 0.9 06:52:56 INFO - mozleak == 0.1 06:52:56 INFO - mozlog == 3.1 06:52:56 INFO - moznetwork == 0.27 06:52:56 INFO - mozprocess == 0.22 06:52:56 INFO - mozprofile == 0.28 06:52:56 INFO - mozrunner == 6.11 06:52:56 INFO - mozscreenshot == 0.1 06:52:56 INFO - mozsystemmonitor == 0.0 06:52:56 INFO - moztest == 0.7 06:52:56 INFO - mozversion == 1.4 06:52:56 INFO - psutil == 3.1.1 06:52:56 INFO - requests == 1.2.3 06:52:56 INFO - wsgiref == 0.1.2 06:52:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:56 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:56 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 06:52:56 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 06:52:56 INFO - Using env: {'DISPLAY': ':0', 06:52:56 INFO - 'HOME': '/home/cltbld', 06:52:56 INFO - 'LANG': 'en_US.UTF-8', 06:52:56 INFO - 'LANGUAGE': 'en_US:en', 06:52:56 INFO - 'LOGNAME': 'cltbld', 06:52:56 INFO - 'MAIL': '/var/mail/cltbld', 06:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:56 INFO - 'MOZ_NO_REMOTE': '1', 06:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:56 INFO - 'NO_EM_RESTART': '1', 06:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:56 INFO - 'SHELL': '/bin/bash', 06:52:56 INFO - 'SHLVL': '1', 06:52:56 INFO - 'TERM': 'linux', 06:52:56 INFO - 'TMOUT': '86400', 06:52:56 INFO - 'USER': 'cltbld', 06:52:56 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:56 INFO - '_': '/tools/buildbot/bin/python'} 06:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 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)) 06:52:56 INFO - Cleaning up... 06:52:56 INFO - Return code: 0 06:52:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:56 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:56 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 06:52:56 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 06:52:56 INFO - Using env: {'DISPLAY': ':0', 06:52:56 INFO - 'HOME': '/home/cltbld', 06:52:56 INFO - 'LANG': 'en_US.UTF-8', 06:52:56 INFO - 'LANGUAGE': 'en_US:en', 06:52:56 INFO - 'LOGNAME': 'cltbld', 06:52:56 INFO - 'MAIL': '/var/mail/cltbld', 06:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:56 INFO - 'MOZ_NO_REMOTE': '1', 06:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:56 INFO - 'NO_EM_RESTART': '1', 06:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:56 INFO - 'SHELL': '/bin/bash', 06:52:56 INFO - 'SHLVL': '1', 06:52:56 INFO - 'TERM': 'linux', 06:52:56 INFO - 'TMOUT': '86400', 06:52:56 INFO - 'USER': 'cltbld', 06:52:56 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:56 INFO - '_': '/tools/buildbot/bin/python'} 06:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:57 INFO - Downloading/unpacking jsonschema 06:52:57 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 06:52:57 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 06:52:57 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 06:52:57 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 06:52:57 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 06:52:57 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 06:52:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:52:58 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 06:52:58 INFO - Downloading/unpacking functools32 (from jsonschema) 06:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:52:59 INFO - warning: no files found matching '*.txt' 06:52:59 INFO - no previously-included directories found matching 'build' 06:52:59 INFO - no previously-included directories found matching 'dist' 06:52:59 INFO - no previously-included directories found matching '.git*' 06:52:59 INFO - Installing collected packages: jsonschema, functools32 06:52:59 INFO - Running setup.py install for functools32 06:52:59 INFO - warning: no files found matching '*.txt' 06:52:59 INFO - no previously-included directories found matching 'build' 06:52:59 INFO - no previously-included directories found matching 'dist' 06:52:59 INFO - no previously-included directories found matching '.git*' 06:52:59 INFO - Successfully installed jsonschema functools32 06:52:59 INFO - Cleaning up... 06:52:59 INFO - Return code: 0 06:52:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:52:59 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')]} 06:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:59 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')]} 06:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:59 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 0x7f4b541f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, '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': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', '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 06:52:59 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 06:52:59 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 06:52:59 INFO - Using env: {'DISPLAY': ':0', 06:52:59 INFO - 'HOME': '/home/cltbld', 06:52:59 INFO - 'LANG': 'en_US.UTF-8', 06:52:59 INFO - 'LANGUAGE': 'en_US:en', 06:52:59 INFO - 'LOGNAME': 'cltbld', 06:52:59 INFO - 'MAIL': '/var/mail/cltbld', 06:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:59 INFO - 'MOZ_NO_REMOTE': '1', 06:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:59 INFO - 'NO_EM_RESTART': '1', 06:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:59 INFO - 'SHELL': '/bin/bash', 06:52:59 INFO - 'SHLVL': '1', 06:52:59 INFO - 'TERM': 'linux', 06:52:59 INFO - 'TMOUT': '86400', 06:52:59 INFO - 'USER': 'cltbld', 06:52:59 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:59 INFO - '_': '/tools/buildbot/bin/python'} 06:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:59 INFO - Downloading/unpacking flake8 06:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:53:01 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 06:53:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:53:01 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 06:53:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:01 INFO - no previously-included directories found matching 'docs/_build' 06:53:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:53:01 INFO - Running setup.py install for pep8 06:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:01 INFO - no previously-included directories found matching 'docs/_build' 06:53:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:53:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:53:01 INFO - Cleaning up... 06:53:02 INFO - Return code: 0 06:53:02 INFO - Running post-action listener: _resource_record_post_action 06:53:02 INFO - Running post-action listener: _start_resource_monitoring 06:53:02 INFO - Starting resource monitoring. 06:53:02 INFO - ##### 06:53:02 INFO - ##### Running install step. 06:53:02 INFO - ##### 06:53:02 INFO - Running pre-action listener: _resource_record_pre_action 06:53:02 INFO - Running main action method: install 06:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:02 INFO - Reading from file tmpfile_stdout 06:53:02 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:53:02 INFO - Reading from file tmpfile_stdout 06:53:02 INFO - Output received: 06:53:02 INFO - Usage: mozinstall [options] installer 06:53:02 INFO - Options: 06:53:02 INFO - -h, --help show this help message and exit 06:53:02 INFO - -d DEST, --destination=DEST 06:53:02 INFO - Directory to install application into. [default: 06:53:02 INFO - "/builds/slave/test-pgo"] 06:53:02 INFO - --app=APP Application being installed. [default: firefox] 06:53:02 INFO - mkdir: /builds/slave/test-pgo/build/application 06:53:02 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'] 06:53:02 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 06:53:18 INFO - Reading from file tmpfile_stdout 06:53:18 INFO - Output received: 06:53:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:53:18 INFO - Running post-action listener: _resource_record_post_action 06:53:18 INFO - ##### 06:53:18 INFO - ##### Running run-tests step. 06:53:18 INFO - ##### 06:53:18 INFO - Running pre-action listener: _resource_record_pre_action 06:53:18 INFO - Running main action method: run_tests 06:53:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:53:18 INFO - Python 2.7.3 06:53:18 INFO - Return code: 0 06:53:18 INFO - grabbing minidump binary from tooltool 06:53:18 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')]} 06:53:18 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 0x24df7f0>, '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 0x244b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:53:18 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 06:53:18 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 06:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:18 INFO - Return code: 0 06:53:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:53:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:53:19 INFO - Return code: 0 06:53:19 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/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 06:53:19 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/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 06:53:19 INFO - Using env: {'DISPLAY': ':0', 06:53:19 INFO - 'HOME': '/home/cltbld', 06:53:19 INFO - 'LANG': 'en_US.UTF-8', 06:53:19 INFO - 'LANGUAGE': 'en_US:en', 06:53:19 INFO - 'LOGNAME': 'cltbld', 06:53:19 INFO - 'MAIL': '/var/mail/cltbld', 06:53:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:19 INFO - 'MOZ_NO_REMOTE': '1', 06:53:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:19 INFO - 'NO_EM_RESTART': '1', 06:53:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:53:19 INFO - 'SHELL': '/bin/bash', 06:53:19 INFO - 'SHLVL': '1', 06:53:19 INFO - 'TERM': 'linux', 06:53:19 INFO - 'TMOUT': '86400', 06:53:19 INFO - 'USER': 'cltbld', 06:53:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783', 06:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:19 INFO - '_': '/tools/buildbot/bin/python'} 06:53:19 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/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 06:53:19 INFO - mozversion application_buildid: 20160105043029 06:53:19 INFO - mozversion application_changeset: 224c502eb6c6a3fcb874deccabdce73500e86f3b 06:53:19 INFO - mozversion application_display_name: Nightly 06:53:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:19 INFO - mozversion application_name: Firefox 06:53:19 INFO - mozversion application_remotingname: firefox 06:53:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:53:19 INFO - mozversion application_vendor: Mozilla 06:53:19 INFO - mozversion application_version: 46.0a1 06:53:19 INFO - mozversion platform_buildid: 20160105043029 06:53:19 INFO - mozversion platform_changeset: 224c502eb6c6a3fcb874deccabdce73500e86f3b 06:53:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:53:19 INFO - mozversion platform_version: 46.0a1 06:53:19 INFO - using testdate: 1452005599 06:53:19 INFO - actual date: 1452005599 06:53:19 INFO - starting webserver on 'localhost:57359' 06:53:19 INFO - SUITE-START | Running 3 tests 06:53:19 INFO - TEST-START | dromaeo_css 06:53:19 INFO - operating with platform_type : linux_ 06:53:19 INFO - Initialising browser for dromaeo_css test... 06:53:19 INFO - TEST-INFO | started process 4565 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsRk3Rm/profile http://localhost:57359/getInfo.html) 06:53:23 INFO - PROCESS | 4565 | __metrics Screen width/height:1600/1200 06:53:23 INFO - PROCESS | 4565 | colorDepth:24 06:53:23 INFO - PROCESS | 4565 | Browser inner width/height: 1024/697 06:53:23 INFO - PROCESS | 4565 | __metrics 06:53:23 INFO - PROCESS | 4565 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:53:24 INFO - TEST-INFO | 4565: exit 0 06:53:24 INFO - Browser initialized. 06:53:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:24 INFO - TEST-INFO | started process 4697 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsRk3Rm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:36 INFO - PROCESS | 4697 | RSS: Main: 150409216 06:53:36 INFO - PROCESS | 4697 | 06:54:26 INFO - PROCESS | 4697 | 1452005666149 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] 06:56:35 INFO - PROCESS | 4697 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57359/tests/dromaeo/cssquery-ext.html) 06:56:36 INFO - PROCESS | 4697 | RSS: Main: 158466048 06:56:36 INFO - PROCESS | 4697 | 06:59:37 INFO - PROCESS | 4697 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-ext.html (next: http://localhost:57359/tests/dromaeo/cssquery-jquery.html) 06:59:38 INFO - PROCESS | 4697 | RSS: Main: 151781376 06:59:38 INFO - PROCESS | 4697 | 07:02:40 INFO - PROCESS | 4697 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57359/tests/dromaeo/cssquery-mootools.html) 07:02:40 INFO - PROCESS | 4697 | RSS: Main: 153042944 07:02:40 INFO - PROCESS | 4697 | 07:05:42 INFO - PROCESS | 4697 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57359/tests/dromaeo/cssquery-prototype.html) 07:05:43 INFO - PROCESS | 4697 | RSS: Main: 150913024 07:05:43 INFO - PROCESS | 4697 | 07:08:45 INFO - PROCESS | 4697 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57359/tests/dromaeo/cssquery-yui.html) 07:08:46 INFO - PROCESS | 4697 | RSS: Main: 152825856 07:08:46 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-yui.html (next: http://localhost:57359/tests/dromaeo/cssquery-dojo.html) 07:11:48 INFO - PROCESS | 4697 | RSS: Main: 154890240 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | __start_tp_report 07:11:48 INFO - PROCESS | 4697 | _x_x_mozilla_page_load 07:11:48 INFO - PROCESS | 4697 | _x_x_mozilla_page_load_details 07:11:48 INFO - PROCESS | 4697 | |i|pagename|runs| 07:11:48 INFO - PROCESS | 4697 | |0;dojo.html;3207.550942867999;3235.9676403235976;3258.4786434170537;3283.4254005549024;3288.293017001345;5297.496737809912;5377.247185394048;5377.865553361163;5419;5420.5392541633955;5304.655197412166;5315.176147697113;5347.385050719168;5361.490658387456;5416.404195538487;4525.162844873693;4834.613230941525;4987.451380348159;4995.725235112068;5034.496550344973;4817.735024573647;4910.459849416561;4964.677295975768;4982.451930287665;4995.425526064495;4845.588125009378;4855.198892182768;4896.4124305083615;4953.777080031407;4983.202687569971;4891.804327826918;4902.166631672589;4904.705717656952;4908.337374454439;4952.083864485082;4840.661153719241;4875.853724388238;4899.657024008321;4934.432540257881;5011.072951503984;5160.019596276696;5161.845144645667;5224.085784987612;5230.843074707765;5241.161414173752;5776.711164441803;5800.651960882361;5801.854953626151;5810.389909059572;5811.912821307684;5740.052891272935;5809.6804675742815;5842.444967728059;5844.561657875676;5857.941420585782;5343.09167441532;5426.647267927611;5427.565794736451;5433.809816656398;5465.836024919259;5978.103284507359;6012.849678758066;6013.879722405527;6036.185115009417;6041.275046994301;5654.038813401731;5744.368119506851;5776.884462310731;5779.913301300484;5790.913136302959;5885.087811389241;5899.852503687443;5901.970490147522;5912.142739302777;5914.940850591525;5736.512396446349;5792.247007888947;5827.708614569255;5831.62094463867;5841.474267315962;5698.629589076697;5734.913976290359;5780.566457515619;5808.39011903744;5840.88318233633;4412.448443944507;4429.512753597101;4434.955650443519;4472.798724057425;4485.147821913826;3964.980175099106;3977.3835055566433;3984.963909383523;3990.8004599770475;4014.578469260744;5320.600954928396;5372.91940620891;5387.218853266333;5420.512153906167;5421.5391691706645;5824.446677565625;5826.1552074948895;5859.384764599741;5867.237259156283;5877.823665290048;5428.240046393508;5458.645188062763;5463.726813659301;5469.425710300441;5469.562435005269;4846.079244943449;4850.296706977469;4918.6556941014505;4946.3817022872145;4963.255511673206;6032.155498230251;6055.485283750931;6075.787347442907;6077.24034495688;6087.1173679816175;5682.659040457585;5872.29532456108;5879.647221166743;5890.087036509348;5896.705164741831;5945.881082378415;6011.218541589566;6091.496397955189;6108.7670647404;6128.233970753656;5767.452092051249;5793.971030144822;5817.621854579608;5831.4168583141345;5849.181114643869;5780.653160810365;5928.170056192051;5940.108983652487;5944.524438044859;5963.344032156372;5576.10782274834;5655.462731040545;5665.915011274917;5685.516731077904;5699.458551437607;5676.574256930664;5680.7443665036;5722.5135863450405;5732.799352022659;5737.8565535861935;5401.270828438111;5524.806631767869;5569.554435645057;5569.777208911598;5579.051561234519;5691.117876729114;5758.596898217253;5768.423157684198;5785.942140578541;5791.623544469596;5591.077472217201;5604.075327570905;5625.46558076982;5626.465485778845;5643.238162847963 07:11:48 INFO - PROCESS | 4697 | |1;ext.html;502.6054547180464;533.5544820075237;549.0227395236478;559.7621011070296;564.5906717629719;27012.459750804974;35870.82064589677;36287;36305.636943630554;36350.27299454013;38582.22835543295;38879.22241555174;38949.22101557967;38960.22079558407;39036.60963390365;8423.536705481181;8620.439671421338;8627.266682332009;8631.43895646784;8649.308055355556;8258.876116858222;8378.371622128334;8432.789180270482;8434.53610051447;8444.746657600283;8397.496150231005;8456.704015359464;8493.915060849406;8502.06477287498;8532.402731808745;8410.201030902084;8485.490870547786;8491.193336633041;8491.320694344438;8496.150384961516;8247.21651443112;8347.081820999685;8362.247397734232;8364.539950302731;8378.958105209496;36101.63898361009;36456.088597785005;36649.63350366516;36675.26649466996;36755.264894701955;3238.2713889374936;3413.2149605590603;3526.7354948378975;3626.4560315952554;3952.932708168807;27253.727462725317;27377.178684639493;27688.861555692292;27759.583606245924;27809.582856257173;3373.460246360595;3383.3064221834466;3474.617792042873;3507.175813683782;3563.732720045981;184545;184820;185270;185624.99999999866;186727;49611.751941240065;51281.48718512767;55643.44356556464;55693;60229;52456.47543524592;52878;53055;53108;53136.468635313926;14945.925270373578;15104.244787760568;15146.621334466507;15147.166905820286;15156.393744250106;11163.106951443864;11226.831597526043;11343.262687925258;11358.432078396212;11364.147688923198;18992.620147596972;19035.238590456505;19037.14332855025;19194.712079318822;19261.614767704847;7126.2161162272105;7297.233790451926;7350.485466017328;7386.96306518464;7429.108506979197;935.1256575102301;942.7313215733483;1041.7656027393928;1073.8281874899978;1113.6547670222258;28086.71913280882;28515.857420712764;28612.713872861423;28623;28820.567691484644;996.3922007575374;1002.8044531316323;1059.041567381521;1089.4661615808197;1126.4030064065894;14316.355763990645;14333.283335833166;14438.422463101568;14445.06107103035;14510.12939223629;364478;367037;367373;368750;370270;44837.551624483334;45000.54999450029;45165;45172;45176;1334.9933250333686;1364.5224171539883;1369.664432214094;1375.3879523611897;1377.4627895120911;27817.860910695315;28813;29053;29097.563536546546;29220.123396298146;47217.76391118023;48245.75877120592;48264;48721;48736.75631621819;277265;280899;281682;282207;282892;41604.79197603992;43158.35262471002;43349.13301734011;43785;44129.55870441254;39721.60278397294;40153.59846401498;40510.39234411427;40710.389344159266;40890.1821963565;35825;36181;36219.818900905324;36885.26229475342;37092.443613345284;35420.29159416746;35877.46183807297;36052.639473604926;36335.81832090928;36422.453663194545;35259;35396.29207415889;35459.82270088633;35658.82170589131;35684;29895.252618684706;33057.66942330546;33346.16634584155;33347.666523334454;33389.32717401133;24924.37689057788;25268.873655631603;25418.364540886625;25551.872240638677;25689 07:11:48 INFO - PROCESS | 4697 | |2;jquery.html;356.79127710289464;357.7406380374231;367.0768018433639;368.4399712437096;371.3316031143941;11403.828942565868;11764.7647047059;16194.514164575066;16521.83478165218;17079.82920170798;17388.65222695545;17550.297988080492;17674.64650706985;17922.462326130237;17931.462056138305;5979.491743201833;6122.081687746829;6127.938720612804;6162.9383706163035;6164.537659675542;5055.988802239548;6115.3884611538715;6157.784477543287;6169.29053158888;6194.225721784777;6135.754569817202;6181.59819611726;6188.690565471731;6189.16446279751;6189.81430557084;6031.457168854802;6077.6353418795015;6086.995645718451;6094.725737341831;6177.073438984144;5781.71091445426;5852.239208902815;5859.589828711992;5863.149843272701;5880.617759845596;22894.31317060491;22998;23355.766442335527;23425.88287058571;23793.787838641907;2241.7758224177614;2361.7638236176244;2381.7141942966955;2452.460458699083;2453.4970331082086;13923.512677056255;14127.223002734845;14449.711005779931;14493.637659058502;14725.410983560645;1943.2032866524657;1975.980240197594;1992.501874531367;2020.9292674756314;2022.4438279473115;63018.68490657563;66400.3359966399;67821.66089169572;68761.3123868765;69842.95235571521;15232.314545845464;15315.315315315307;15335.463258786112;15425;15531.145786981824;12914.547990820276;13128.277944712941;13213.603591892259;23965.400864978168;24137.15519956793;6886.51794374399;7026.92973070273;7660.80847978805;7706.535449165731;7913.525188488709;7710.961445192738;7748.806279842936;7751.92248077512;7773.416993725493;7799.45403821727;4467.106578684211;4481.148581769454;4505.864824055284;4551.271796512542;4556.749378784132;1854.1100271869577;1855.879367841086;1887.9433616991512;1919.04047976012;1928.2768961639385;410.9260333140004;417.8934371735188;435.7603318174991;847.6228078505129;850.3027517435767;9747.805043899083;10251.231157663056;10360.844587331196;10427.635032773816;10589.470526473646;438.7323732523158;441.6047637364605;441.8895276180955;443.66724956282786;445.25197667918206;5782.653040817564;5798.478136967693;5799.5070419014855;5839.2992840858515;5908.822735317947;547985;558138;565914.193003243;570823;577887;77915.22084779193;79251;79493;80351.19648803437;81563.59218203872;469.4413647759156;476.29746124466135;476.70206121174266;477.1697246790629;478.1011698007723;9944.552495137881;10189.032041956003;14815.40738370453;15000.624984375041;15503.612409689847;25498.235052948443;27732.30669233285;31322.843385782926;34083.65916340805;34382.58351225825;43729.344059839765;44269.335959961274;45606.771966141285;45767.31349029834;46196.538034619225;9455.290853185901;9479.28905332089;9678.56446459925;9748.220142388735;9812.803743924938;11667.416629168338;11719.17965742424;11743.76512469763;16082.035579900705;17318.740218896473;14748.336324865193;14836;14909.850901490847;15072.698546029238;15109.924450377677;14672.706545869236;14675.92662036683;14693.19187444658;14780.852191477947;14963.177025263714;14047.859521405064;14475.92762036183;15091.245437728288;15099.094054356774;15422.69154616879;9758.414495130315;9799.51002449889;9815.312928094965;9880.25898057663;9922.107010369102;14525.201113938412;14742.63143421423;14792.11247325164;15064.774028389802;15165 07:11:48 INFO - PROCESS | 4697 | |3;mootools.html;1450.622838062104;1473.7641977283633;1641.9261133249004;1747.5980524479378;1772.4505403324963;7812.648430820613;7909.446338756275;7967.482113662608;8059.556724380157;8061.87907181392;8009.11899691035;8037.879431808527;8066.274035336818;8115;8116.066652334968;2303.251443280936;2339.5671800716837;2347.9647805282934;2348.38941875112;2351.353377821096;2304.700388949434;2324.151684635113;2336.2173671819874;2342.5783358995373;2359.2568340972625;2290.6678531612906;2299.977000229993;2301.723793144825;2330.883455827202;2347.835651504395;2322.8257880658934;2364.0307473935777;2365.988170059156;2368.230325144335;2369.0642196332437;2252.1779550464125;2265.988670056639;2271.04616061253;2274.056266649355;2278.1912421090606;7732.381409487284;7790.688372465094;7814.960925195338;7820.804479888048;7838.09861865887;4721.527847215285;4804.20730579454;4814.927776083362;4831.782569784333;4846.61227101831;3002.5946497222812;3012.4276387486525;3043.4065357255345;3082.075377386775;3150.732187764043;918.9218916392115;920.6087412849579;942.5240253671852;970.6069042037985;979.7648564344577;11039.83440248405;11057.778844423146;11089.168312376603;11124.332540047622;11154.051905588034;4228.534861165269;4288.099499105223;4316.201502722007;4379.343098535245;4392.297232442794;8954.597043133075;8997.505137217517;9015;9031.954840225757;9048.638054477879;4736.076465089274;4743.810247590127;4752.3584316116885;4756.429228492603;4782.139214941344;4312.223799716081;4360.563943605614;4362.280223763107;4381.78091095444;4407.801648925806;3566.375884220303;3579.785212887235;3580.15866271426;3585.2650206707563;3614.945775813365;1092.6558134187865;1108.5256608710397;1110.8222684370623;1115.8884111588777;1118.5861231344454;1030.6135199300113;1030.829913064336;1059.9506488576408;1156.919015668912;1288.645622453814;7297.197308296083;7397.630118494054;7427.257274272638;7447.069116360455;7447.925520744723;1115.1580556679817;1117.580907159815;1136.5510623303749;1136.9545218191179;1152.5965911930925;5712.314522257356;5737.3975732548315;5738.598298119092;5758.1650660654805;5842.795502157404;9215.723528294162;9383.718488445358;9655.324127311022;9726.90273097274;9752.463614501128;9534.570944307523;9538.475383853816;9569.61721531131;9622.47076410804;9631.566579503939;7284.526505777108;7433.9256607433235;7471.775846724607;7481.476296659182;7510.361619262424;7124.358807707331;7171.641417928979;7175.497715159889;7179.605121718356;7189.281071892978;8328.167183281623;8380.832383352421;8626.870596941177;8641.395102342776;8662.523561204194;8749.91250087491;8755.343349248704;8842.292616590528;8893.066228045962;8984.146506081912;6661.766838160641;6714.462842972453;6715.966420167868;6741.056252124805;6753.3921947025;7209.855802884018;7212.963935180501;7225.24134965821;7251.818704532217;7252.5648461092505;6801.931980680328;6985.441164706913;7002.159740831133;7060.823479413056;7090.255523169993;6698.196216454056;6708.765193218214;6739.292374300824;6791.45668346541;6867.553609015398;7006.194287656985;7033.718651253893;7041.471889608402;7060.71757129709;7101.857962840818;6330.050492426173;6381.234251889803;6387.776427825004;6399.168108145911;6412.519061070531;6530.183727034121;6632.801015969529;6633.336666333521;6639.668016599054;6671.33286671329 07:11:48 INFO - PROCESS | 4697 | |4;prototype.html;330.1136448635414;334.16292188068894;340.8772841776961;343.99140021499477;348.7227654015059;6086.726097325625;6124.969375153124;6128.662923539209;6238.875222495547;6333.113364129025;6139.079138129283;6217.347178546255;6226.43962043416;6251.3123556408755;6282.308946015934;4689.062187562484;4705.882352941187;4706.29405589161;4716.693414928019;4723.197056500403;4709.317149013391;4719.551642593948;4720.480747117815;4721.173794585934;4736.739479328636;4479.48485924118;4600.493945665974;4642.883927901796;4678.485366609687;4687.531246875319;4670.626349892001;4674.836380726675;4678.274867395542;4682.7658617069355;4689.812407503696;4094.4063110849056;4096.262672718909;4100.835966561334;4110.486189226347;4110.91778164438;5873.500752436048;5877.79427720032;5878.030125029365;5923.881522369528;5926.288845338544;5492.632857996674;5526.336839579276;5530.170474428827;5562.638428502175;5566.749496272678;6580.86838263232;6581.177352830896;6582.275949645536;6598.637074960875;6602.1747281589805;4584.7936842842155;4598.402207713009;4598.609118224955;4602.815887364535;4604.447466304065;6734.427573656245;6815.829604259884;6853.280405557394;6873.793786186372;6895.620740859251;4660.067986402733;4662.323963025342;4663.440387153563;4670.159371313128;4672.906541869143;4716.339712440261;4729.668923175344;4731.668783185213;4736.905261894743;4742.739149346819;5450.809221677222;5458.563314934796;5461.0716178249795;5469.863253418617;5476.7535460904355;6431.067495213168;6590.275069742324;6610.008498725229;6628.038934354588;6639.203295604559;1685.3679870048732;1689.3158270900306;1708.265445858268;1710.1363811275226;1710.4013595241565;1145.1468655851445;1159.7912375772441;1160.0951258018758;1161.8199179127248;1179.7050737315672;6255.186825712628;6259.374062593795;6265.906011409833;6270.780522681775;6274.247090349096;6781.62701051437;6784.559003664746;6809.897851532231;6811.795646130624;6835.14560679915;6089.725962331706;6219;6243.75024999004;6278.843028924222;6295.96852015737;3713.2387860488534;3722.218334149805;3726.360401423365;3740.588535261119;3743.9251214975548;7075.363217310364;7130.42956563484;7133.215346311901;7144.749933752294;7165.104361954755;6949.441113331833;7024.894626580605;7062.1878483975;7089.7873063808165;7105.467089968273;7161.67772450241;7175.17485489165;7179.1026121734785;7183.640817959081;7201.387882030086;6764.985252212207;6832.350926661959;6843.863122737418;6845.623490708059;6873.793786186222;6564.081028655896;6712.328767123248;6742.393184613408;6767.052612634334;6778.0510728497065;7121.074260346122;7131.393831524171;7194.532355396883;7203.891941620985;7205.747798827016;4534.59188673021;4568.565986231302;4581.335706322631;4583.931241031454;4587.266037433995;6729;6918.7232510699005;6924.653767311514;6925.272846351262;6941.47938904574;6640;6678.031685405686;6679.0649309097735;6698;6703.698333575098;6649.335066493312;6680.131582894192;6690.230623478167;6701.296363881722;6707.0945422369305;6331.0819931110655;6412.102305677302;6428.357164283534;6453.483721302378;6506.41442270198;6697.698603562949;6720.865582688221;6723.966380168264;6738.59568425896;6741;6397.0724244983285;6511.088447617242;6544.9672751635935;6555.541671873048;6563.015547667888 07:11:48 INFO - PROCESS | 4697 | |5;yui.html;683.7230921476801;768.6886810841611;802.3300544045721;809.7407635835506;814.4909431605247;11756.588519401823;11921.22512036717;11923.940380298098;11936.224145430562;11952.223105498148;12050.337231452266;13992.370343334549;14169.71660566788;14901.701965960674;14940.551783446514;763.4884627299695;783.4437549339975;794.8092457810142;796.8685166947447;834.8789425533294;816.3877092180865;823.3248736036453;826.9297109745679;827.5365795154703;831.1646794971045;847.8728190771373;852.2372476633409;858.3262139220712;863.6804382378529;864.5763575847852;849.1762989899818;854.3891117850767;855.3499340501202;856.2807241916757;856.9314454843598;614.5483069943588;614.7418084404561;615.9630422174683;627.6767464755654;635.463033736492;13900.304984750723;13988.58034258974;14108.153510789283;14113;14130.222837744022;11419.143564232716;11797;12230.877691223151;12814.038947078912;12845.743085138338;10097.899021009769;10259.948700256526;10462.058414742634;10597.73505662357;10999;3613;3626.691731202851;3713.3130370881204;3724.4599533067826;3734.495843061179;44447.555524444666;44969.550304496865;44975;45005.54994450079;45058.54941450576;9283.953580232055;9371.390859594105;9411.294152938557;9441.952790236004;9558.474283914451;15854.68290634204;15872.92063539698;16176.110313932846;16225;16263.512094637179;7328.230535793665;7341.596212208273;7474.065741782278;7560.470767046364;7658.73194438192;4260.701750877471;4340.348947657877;4341.327094300388;4377.212101821639;4378.277584198635;2982.492976194052;3024.3346463777934;3024.6370435547433;3028.227801910499;3101.8914337998513;562.0838034004628;566.4618612318314;576.0667718296303;580.3210244014513;583.527342852291;520.6745783885071;547.8631838934227;556.8945642898842;574.4456599381617;596.7762089216544;7583.962080189674;7913.525188488709;8088.9595552021865;8195.672173113127;8258.298044666151;494.8911239527298;621.7202258983475;637.6206157336377;642.6176425027102;649.8407890066964;4035.636792688672;4169.187008533307;4302.827886884552;4322.178786030644;4340.348947657877;54662.72668636632;54981.45018549763;55233.72383138059;55472.445275547536;55526.16710749342;49231;50329.74835125801;50512.494875050776;51495.22757158645;51593.742031290356;45497;45611;45627.315590266175;46439.535604644196;46522;8364.330853531581;8487.830243394974;8498.150184981452;8560.400771946153;8658.740237792876;31425.8428707855;31960.84019579887;32269.51595726113;33066.338673226885;33227.16932076718;40084.19831603293;41096.38355424731;45195.774021129684;45740.771296143306;46630.76684616555;10757.784844302914;10854.34068653185;11086.168537359568;11114.22200445961;11688.766224675628;11606.825897611712;11658.533658653898;11671.59149429766;11894.34581098048;12256.203346782431;10740.83888741685;10757.677269681923;10793.62222322215;10833.349999000086;10918.181136414642;11365.772684546428;11457.484413201593;11668.066554675435;11860.22908510944;11965.461554230254;9335.486548239913;10641.521131548943;11084.168687348643;11304.152188585724;11588.420578970849;9107.134822191882;9452.716418507456;9473.905260947302;9712.611495540099;9905.55425005862;9531.428114313163;9716.951415242878;9820.607175712892;9929.503524823585;9994.75263110998 07:11:48 INFO - PROCESS | 4697 | __end_tp_report 07:11:48 INFO - PROCESS | 4697 | __start_cc_report 07:11:48 INFO - PROCESS | 4697 | _x_x_mozilla_cycle_collect,311 07:11:48 INFO - PROCESS | 4697 | __end_cc_report 07:11:48 INFO - PROCESS | 4697 | __startTimestamp1452006708927__endTimestamp 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | ------- Summary: start ------- 07:11:48 INFO - PROCESS | 4697 | Number of tests: 6 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | [#0] dojo.html Cycles:165 Average:5394.15 Median:5604.08 stddev:618.79 (11.0%) stddev-sans-first:596.44 07:11:48 INFO - PROCESS | 4697 | Values: 3207.6 3236.0 3258.5 3283.4 3288.3 5297.5 5377.2 5377.9 5419.0 5420.5 5304.7 5315.2 5347.4 5361.5 5416.4 4525.2 4834.6 4987.5 4995.7 5034.5 4817.7 4910.5 4964.7 4982.5 4995.4 4845.6 4855.2 4896.4 4953.8 4983.2 4891.8 4902.2 4904.7 4908.3 4952.1 4840.7 4875.9 4899.7 4934.4 5011.1 5160.0 5161.8 5224.1 5230.8 5241.2 5776.7 5800.7 5801.9 5810.4 5811.9 5740.1 5809.7 5842.4 5844.6 5857.9 5343.1 5426.6 5427.6 5433.8 5465.8 5978.1 6012.8 6013.9 6036.2 6041.3 5654.0 5744.4 5776.9 5779.9 5790.9 5885.1 5899.9 5902.0 5912.1 5914.9 5736.5 5792.2 5827.7 5831.6 5841.5 5698.6 5734.9 5780.6 5808.4 5840.9 4412.4 4429.5 4435.0 4472.8 4485.1 3965.0 3977.4 3985.0 3990.8 4014.6 5320.6 5372.9 5387.2 5420.5 5421.5 5824.4 5826.2 5859.4 5867.2 5877.8 5428.2 5458.6 5463.7 5469.4 5469.6 4846.1 4850.3 4918.7 4946.4 4963.3 6032.2 6055.5 6075.8 6077.2 6087.1 5682.7 5872.3 5879.6 5890.1 5896.7 5945.9 6011.2 6091.5 6108.8 6128.2 5767.5 5794.0 5817.6 5831.4 5849.2 5780.7 5928.2 5940.1 5944.5 5963.3 5576.1 5655.5 5665.9 5685.5 5699.5 5676.6 5680.7 5722.5 5732.8 5737.9 5401.3 5524.8 5569.6 5569.8 5579.1 5691.1 5758.6 5768.4 5785.9 5791.6 5591.1 5604.1 5625.5 5626.5 5643.2 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | [#1] ext.html Cycles:180 Average:44427.80 Median:36296.32 stddev:75569.29 (208.2%) stddev-sans-first:75709.32 07:11:48 INFO - PROCESS | 4697 | Values: 502.6 533.6 549.0 559.8 564.6 27012.5 35870.8 36287.0 36305.6 36350.3 38582.2 38879.2 38949.2 38960.2 39036.6 8423.5 8620.4 8627.3 8631.4 8649.3 8258.9 8378.4 8432.8 8434.5 8444.7 8397.5 8456.7 8493.9 8502.1 8532.4 8410.2 8485.5 8491.2 8491.3 8496.2 8247.2 8347.1 8362.2 8364.5 8379.0 36101.6 36456.1 36649.6 36675.3 36755.3 3238.3 3413.2 3526.7 3626.5 3952.9 27253.7 27377.2 27688.9 27759.6 27809.6 3373.5 3383.3 3474.6 3507.2 3563.7 184545.0 184820.0 185270.0 185625.0 186727.0 49611.8 51281.5 55643.4 55693.0 60229.0 52456.5 52878.0 53055.0 53108.0 53136.5 14945.9 15104.2 15146.6 15147.2 15156.4 11163.1 11226.8 11343.3 11358.4 11364.1 18992.6 19035.2 19037.1 19194.7 19261.6 7126.2 7297.2 7350.5 7387.0 7429.1 935.1 942.7 1041.8 1073.8 1113.7 28086.7 28515.9 28612.7 28623.0 28820.6 996.4 1002.8 1059.0 1089.5 1126.4 14316.4 14333.3 14438.4 14445.1 14510.1 364478.0 367037.0 367373.0 368750.0 370270.0 44837.6 45000.5 45165.0 45172.0 45176.0 1335.0 1364.5 1369.7 1375.4 1377.5 27817.9 28813.0 29053.0 29097.6 29220.1 47217.8 48245.8 48264.0 48721.0 48736.8 277265.0 280899.0 281682.0 282207.0 282892.0 41604.8 43158.4 43349.1 43785.0 44129.6 39721.6 40153.6 40510.4 40710.4 40890.2 35825.0 36181.0 36219.8 36885.3 37092.4 35420.3 35877.5 36052.6 36335.8 36422.5 35259.0 35396.3 35459.8 35658.8 35684.0 29895.3 33057.7 33346.2 33347.7 33389.3 24924.4 25268.9 25418.4 25551.9 25689.0 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | [#2] jquery.html Cycles:180 Average:29701.93 Median:22082.55 stddev:92185.77 (417.5%) stddev-sans-first:92418.04 07:11:48 INFO - PROCESS | 4697 | Values: 356.8 357.7 367.1 368.4 371.3 11403.8 11764.8 16194.5 16521.8 17079.8 17388.7 17550.3 17674.6 17922.5 17931.5 5979.5 6122.1 6127.9 6162.9 6164.5 5056.0 6115.4 6157.8 6169.3 6194.2 6135.8 6181.6 6188.7 6189.2 6189.8 6031.5 6077.6 6087.0 6094.7 6177.1 5781.7 5852.2 5859.6 5863.1 5880.6 22894.3 22998.0 23355.8 23425.9 23793.8 2241.8 2361.8 2381.7 2452.5 2453.5 13923.5 14127.2 14449.7 14493.6 14725.4 1943.2 1976.0 1992.5 2020.9 2022.4 63018.7 66400.3 67821.7 68761.3 69843.0 15232.3 15315.3 15335.5 15425.0 15531.1 12914.5 13128.3 13213.6 23965.4 24137.2 6886.5 7026.9 7660.8 7706.5 7913.5 7711.0 7748.8 7751.9 7773.4 7799.5 4467.1 4481.1 4505.9 4551.3 4556.7 1854.1 1855.9 1887.9 1919.0 1928.3 410.9 417.9 435.8 847.6 850.3 9747.8 10251.2 10360.8 10427.6 10589.5 438.7 441.6 441.9 443.7 445.3 5782.7 5798.5 5799.5 5839.3 5908.8 547985.0 558138.0 565914.2 570823.0 577887.0 77915.2 79251.0 79493.0 80351.2 81563.6 469.4 476.3 476.7 477.2 478.1 9944.6 10189.0 14815.4 15000.6 15503.6 25498.2 27732.3 31322.8 34083.7 34382.6 43729.3 44269.3 45606.8 45767.3 46196.5 9455.3 9479.3 9678.6 9748.2 9812.8 11667.4 11719.2 11743.8 16082.0 17318.7 14748.3 14836.0 14909.9 15072.7 15109.9 14672.7 14675.9 14693.2 14780.9 14963.2 14047.9 14475.9 15091.2 15099.1 15422.7 9758.4 9799.5 9815.3 9880.3 9922.1 14525.2 14742.6 14792.1 15064.8 15165.0 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | [#3] mootools.html Cycles:180 Average:5510.13 Median:6581.49 stddev:2871.88 (43.6%) stddev-sans-first:2863.73 07:11:48 INFO - PROCESS | 4697 | Values: 1450.6 1473.8 1641.9 1747.6 1772.5 7812.6 7909.4 7967.5 8059.6 8061.9 8009.1 8037.9 8066.3 8115.0 8116.1 2303.3 2339.6 2348.0 2348.4 2351.4 2304.7 2324.2 2336.2 2342.6 2359.3 2290.7 2300.0 2301.7 2330.9 2347.8 2322.8 2364.0 2366.0 2368.2 2369.1 2252.2 2266.0 2271.0 2274.1 2278.2 7732.4 7790.7 7815.0 7820.8 7838.1 4721.5 4804.2 4814.9 4831.8 4846.6 3002.6 3012.4 3043.4 3082.1 3150.7 918.9 920.6 942.5 970.6 979.8 11039.8 11057.8 11089.2 11124.3 11154.1 4228.5 4288.1 4316.2 4379.3 4392.3 8954.6 8997.5 9015.0 9032.0 9048.6 4736.1 4743.8 4752.4 4756.4 4782.1 4312.2 4360.6 4362.3 4381.8 4407.8 3566.4 3579.8 3580.2 3585.3 3614.9 1092.7 1108.5 1110.8 1115.9 1118.6 1030.6 1030.8 1060.0 1156.9 1288.6 7297.2 7397.6 7427.3 7447.1 7447.9 1115.2 1117.6 1136.6 1137.0 1152.6 5712.3 5737.4 5738.6 5758.2 5842.8 9215.7 9383.7 9655.3 9726.9 9752.5 9534.6 9538.5 9569.6 9622.5 9631.6 7284.5 7433.9 7471.8 7481.5 7510.4 7124.4 7171.6 7175.5 7179.6 7189.3 8328.2 8380.8 8626.9 8641.4 8662.5 8749.9 8755.3 8842.3 8893.1 8984.1 6661.8 6714.5 6716.0 6741.1 6753.4 7209.9 7213.0 7225.2 7251.8 7252.6 6801.9 6985.4 7002.2 7060.8 7090.3 6698.2 6708.8 6739.3 6791.5 6867.6 7006.2 7033.7 7041.5 7060.7 7101.9 6330.1 6381.2 6387.8 6399.2 6412.5 6530.2 6632.8 6633.3 6639.7 6671.3 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | [#4] prototype.html Cycles:180 Average:5525.46 Median:6253.25 stddev:1677.80 (26.8%) stddev-sans-first:1636.56 07:11:48 INFO - PROCESS | 4697 | Values: 330.1 334.2 340.9 344.0 348.7 6086.7 6125.0 6128.7 6238.9 6333.1 6139.1 6217.3 6226.4 6251.3 6282.3 4689.1 4705.9 4706.3 4716.7 4723.2 4709.3 4719.6 4720.5 4721.2 4736.7 4479.5 4600.5 4642.9 4678.5 4687.5 4670.6 4674.8 4678.3 4682.8 4689.8 4094.4 4096.3 4100.8 4110.5 4110.9 5873.5 5877.8 5878.0 5923.9 5926.3 5492.6 5526.3 5530.2 5562.6 5566.7 6580.9 6581.2 6582.3 6598.6 6602.2 4584.8 4598.4 4598.6 4602.8 4604.4 6734.4 6815.8 6853.3 6873.8 6895.6 4660.1 4662.3 4663.4 4670.2 4672.9 4716.3 4729.7 4731.7 4736.9 4742.7 5450.8 5458.6 5461.1 5469.9 5476.8 6431.1 6590.3 6610.0 6628.0 6639.2 1685.4 1689.3 1708.3 1710.1 1710.4 1145.1 1159.8 1160.1 1161.8 1179.7 6255.2 6259.4 6265.9 6270.8 6274.2 6781.6 6784.6 6809.9 6811.8 6835.1 6089.7 6219.0 6243.8 6278.8 6296.0 3713.2 3722.2 3726.4 3740.6 3743.9 7075.4 7130.4 7133.2 7144.7 7165.1 6949.4 7024.9 7062.2 7089.8 7105.5 7161.7 7175.2 7179.1 7183.6 7201.4 6765.0 6832.4 6843.9 6845.6 6873.8 6564.1 6712.3 6742.4 6767.1 6778.1 7121.1 7131.4 7194.5 7203.9 7205.7 4534.6 4568.6 4581.3 4583.9 4587.3 6729.0 6918.7 6924.7 6925.3 6941.5 6640.0 6678.0 6679.1 6698.0 6703.7 6649.3 6680.1 6690.2 6701.3 6707.1 6331.1 6412.1 6428.4 6453.5 6506.4 6697.7 6720.9 6724.0 6738.6 6741.0 6397.1 6511.1 6545.0 6555.5 6563.0 07:11:48 INFO - PROCESS | 4697 | 07:11:48 INFO - PROCESS | 4697 | [#5] yui.html Cycles:180 Average:13394.32 Median:46090.15 stddev:15378.45 (33.4%) stddev-sans-first:15391.96 07:11:48 INFO - PROCESS | 4697 | Values: 683.7 768.7 802.3 809.7 814.5 11756.6 11921.2 11923.9 11936.2 11952.2 12050.3 13992.4 14169.7 14901.7 14940.6 763.5 783.4 794.8 796.9 834.9 816.4 823.3 826.9 827.5 831.2 847.9 852.2 858.3 863.7 864.6 849.2 854.4 855.3 856.3 856.9 614.5 614.7 616.0 627.7 635.5 13900.3 13988.6 14108.2 14113.0 14130.2 11419.1 11797.0 12230.9 12814.0 12845.7 10097.9 10259.9 10462.1 10597.7 10999.0 3613.0 3626.7 3713.3 3724.5 3734.5 44447.6 44969.6 44975.0 45005.5 45058.5 9284.0 9371.4 9411.3 9442.0 9558.5 15854.7 15872.9 16176.1 16225.0 16263.5 7328.2 7341.6 7474.1 7560.5 7658.7 4260.7 4340.3 4341.3 4377.2 4378.3 2982.5 3024.3 3024.6 3028.2 3101.9 562.1 566.5 576.1 580.3 583.5 520.7 547.9 556.9 574.4 596.8 7584.0 7913.5 8089.0 8195.7 8258.3 494.9 621.7 637.6 642.6 649.8 4035.6 4169.2 4302.8 4322.2 4340.3 54662.7 54981.5 55233.7 55472.4 55526.2 49231.0 50329.7 50512.5 51495.2 51593.7 45497.0 45611.0 45627.3 46439.5 46522.0 8364.3 8487.8 8498.2 8560.4 8658.7 31425.8 31960.8 32269.5 33066.3 33227.2 40084.2 41096.4 45195.8 45740.8 46630.8 10757.8 10854.3 11086.2 11114.2 11688.8 11606.8 11658.5 11671.6 11894.3 12256.2 10740.8 10757.7 10793.6 10833.3 10918.2 11365.8 11457.5 11668.1 11860.2 11965.5 9335.5 10641.5 11084.2 11304.2 11588.4 9107.1 9452.7 9473.9 9712.6 9905.6 9531.4 9717.0 9820.6 9929.5 9994.8 07:11:48 INFO - PROCESS | 4697 | -------- Summary: end -------- 07:11:48 INFO - PROCESS | 4697 | 07:11:49 INFO - TEST-INFO | 4697: exit 0 07:11:49 INFO - TEST-OK | dromaeo_css | took 1109999ms 07:11:49 INFO - TEST-START | kraken 07:11:49 INFO - operating with platform_type : linux_ 07:11:49 INFO - Initialising browser for kraken test... 07:11:49 INFO - TEST-INFO | started process 4935 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPc5YpH/profile http://localhost:57359/getInfo.html) 07:11:53 INFO - PROCESS | 4935 | __metrics Screen width/height:1600/1200 07:11:53 INFO - PROCESS | 4935 | colorDepth:24 07:11:53 INFO - PROCESS | 4935 | Browser inner width/height: 1024/697 07:11:53 INFO - PROCESS | 4935 | __metrics 07:11:53 INFO - PROCESS | 4935 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:11:54 INFO - TEST-INFO | 4935: exit 0 07:11:54 INFO - Browser initialized. 07:11:54 INFO - Running cycle 1/1 for kraken test... 07:11:54 INFO - TEST-INFO | started process 5058 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPc5YpH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:06 INFO - PROCESS | 5058 | RSS: Main: 150601728 07:12:06 INFO - PROCESS | 5058 | 07:12:08 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:09 INFO - PROCESS | 5058 | RSS: Main: 151916544 07:12:09 INFO - PROCESS | 5058 | 07:12:12 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-dft) 07:12:12 INFO - PROCESS | 5058 | RSS: Main: 151285760 07:12:12 INFO - PROCESS | 5058 | 07:12:15 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-fft) 07:12:16 INFO - PROCESS | 5058 | RSS: Main: 146944000 07:12:16 INFO - PROCESS | 5058 | 07:12:18 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-oscillator) 07:12:19 INFO - PROCESS | 5058 | RSS: Main: 146407424 07:12:19 INFO - PROCESS | 5058 | 07:12:21 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:21 INFO - PROCESS | 5058 | RSS: Main: 146624512 07:12:21 INFO - PROCESS | 5058 | 07:12:24 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57359/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:25 INFO - PROCESS | 5058 | RSS: Main: 147705856 07:12:25 INFO - PROCESS | 5058 | 07:12:28 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57359/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:29 INFO - PROCESS | 5058 | RSS: Main: 149196800 07:12:29 INFO - PROCESS | 5058 | 07:12:32 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57359/tests/kraken/driver.html?testName=json-parse-financial) 07:12:32 INFO - PROCESS | 5058 | RSS: Main: 148119552 07:12:32 INFO - PROCESS | 5058 | 07:12:34 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:34 INFO - PROCESS | 5058 | RSS: Main: 148320256 07:12:34 INFO - PROCESS | 5058 | 07:12:36 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:37 INFO - PROCESS | 5058 | RSS: Main: 148733952 07:12:37 INFO - PROCESS | 5058 | 07:12:39 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:40 INFO - PROCESS | 5058 | RSS: Main: 149188608 07:12:40 INFO - PROCESS | 5058 | 07:12:42 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:43 INFO - PROCESS | 5058 | RSS: Main: 148549632 07:12:43 INFO - PROCESS | 5058 | 07:12:45 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:46 INFO - PROCESS | 5058 | RSS: Main: 148684800 07:12:46 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57359/tests/kraken/driver.html?testName=ai-astar) 07:12:48 INFO - PROCESS | 5058 | RSS: Main: 149864448 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | __start_tp_report 07:12:48 INFO - PROCESS | 5058 | _x_x_mozilla_page_load 07:12:48 INFO - PROCESS | 5058 | _x_x_mozilla_page_load_details 07:12:48 INFO - PROCESS | 5058 | |i|pagename|runs| 07:12:48 INFO - PROCESS | 5058 | |0;ai-astar;112;105;110;111;112;124;110;110;112;111 07:12:48 INFO - PROCESS | 5058 | |1;audio-beat-detection;154;130;158;175;130;155;150;126;163;126 07:12:48 INFO - PROCESS | 5058 | |2;audio-dft;164;166;166;166;165;166;164;170;173;164 07:12:48 INFO - PROCESS | 5058 | |3;audio-fft;75;74;73;75;72;147;71;72;74;75 07:12:48 INFO - PROCESS | 5058 | |4;audio-oscillator;97;97;143;96;97;96;146;96;97;138 07:12:48 INFO - PROCESS | 5058 | |5;imaging-gaussian-blur;110;110;110;110;111;109;110;109;110;110 07:12:48 INFO - PROCESS | 5058 | |6;imaging-darkroom;148;148;145;145;146;148;147;147;147;146 07:12:48 INFO - PROCESS | 5058 | |7;imaging-desaturate;97;97;96;96;96;95;97;96;97;97 07:12:48 INFO - PROCESS | 5058 | |8;json-parse-financial;59;67;62;58;59;57;60;61;58;58 07:12:48 INFO - PROCESS | 5058 | |9;json-stringify-tinderbox;68;68;67;68;68;68;68;67;69;70 07:12:48 INFO - PROCESS | 5058 | |10;stanford-crypto-aes;85;88;88;93;86;84;86;87;86;87 07:12:48 INFO - PROCESS | 5058 | |11;stanford-crypto-ccm;122;122;123;128;128;118;134;121;136;134 07:12:48 INFO - PROCESS | 5058 | |12;stanford-crypto-pbkdf2;147;159;146;156;157;147;150;157;156;152 07:12:48 INFO - PROCESS | 5058 | |13;stanford-crypto-sha256-iterative;71;69;72;70;70;71;69;71;71;68 07:12:48 INFO - PROCESS | 5058 | __end_tp_report 07:12:48 INFO - PROCESS | 5058 | __start_cc_report 07:12:48 INFO - PROCESS | 5058 | _x_x_mozilla_cycle_collect,755 07:12:48 INFO - PROCESS | 5058 | __end_cc_report 07:12:48 INFO - PROCESS | 5058 | __startTimestamp1452006768287__endTimestamp 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | ------- Summary: start ------- 07:12:48 INFO - PROCESS | 5058 | Number of tests: 14 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.79 (4.3%) stddev-sans-first:5.07 07:12:48 INFO - PROCESS | 5058 | Values: 112.0 105.0 110.0 111.0 112.0 124.0 110.0 110.0 112.0 111.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:154.50 stddev:17.46 (11.3%) stddev-sans-first:18.31 07:12:48 INFO - PROCESS | 5058 | Values: 154.0 130.0 158.0 175.0 130.0 155.0 150.0 126.0 163.0 126.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:2.91 (1.8%) stddev-sans-first:2.96 07:12:48 INFO - PROCESS | 5058 | Values: 164.0 166.0 166.0 166.0 165.0 166.0 164.0 170.0 173.0 164.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.00 stddev:23.30 (31.5%) stddev-sans-first:24.62 07:12:48 INFO - PROCESS | 5058 | Values: 75.0 74.0 73.0 75.0 72.0 147.0 71.0 72.0 74.0 75.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.50 stddev:22.19 (23.0%) stddev-sans-first:23.01 07:12:48 INFO - PROCESS | 5058 | Values: 97.0 97.0 143.0 96.0 97.0 96.0 146.0 96.0 97.0 138.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:12:48 INFO - PROCESS | 5058 | Values: 110.0 110.0 110.0 110.0 111.0 109.0 110.0 109.0 110.0 110.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 07:12:48 INFO - PROCESS | 5058 | Values: 148.0 148.0 145.0 145.0 146.0 148.0 147.0 147.0 147.0 146.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:12:48 INFO - PROCESS | 5058 | Values: 97.0 97.0 96.0 96.0 96.0 95.0 97.0 96.0 97.0 97.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.50 stddev:2.92 (4.9%) stddev-sans-first:3.08 07:12:48 INFO - PROCESS | 5058 | Values: 59.0 67.0 62.0 58.0 59.0 57.0 60.0 61.0 58.0 58.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 07:12:48 INFO - PROCESS | 5058 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 69.0 70.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.45 (2.8%) stddev-sans-first:2.49 07:12:48 INFO - PROCESS | 5058 | Values: 85.0 88.0 88.0 93.0 86.0 84.0 86.0 87.0 86.0 87.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:128.00 stddev:6.35 (5.0%) stddev-sans-first:6.51 07:12:48 INFO - PROCESS | 5058 | Values: 122.0 122.0 123.0 128.0 128.0 118.0 134.0 121.0 136.0 134.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:156.00 stddev:4.90 (3.1%) stddev-sans-first:4.74 07:12:48 INFO - PROCESS | 5058 | Values: 147.0 159.0 146.0 156.0 157.0 147.0 150.0 157.0 156.0 152.0 07:12:48 INFO - PROCESS | 5058 | 07:12:48 INFO - PROCESS | 5058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.27 07:12:48 INFO - PROCESS | 5058 | Values: 71.0 69.0 72.0 70.0 70.0 71.0 69.0 71.0 71.0 68.0 07:12:48 INFO - PROCESS | 5058 | -------- Summary: end -------- 07:12:48 INFO - PROCESS | 5058 | 07:12:49 INFO - TEST-INFO | 5058: exit 0 07:12:49 INFO - TEST-OK | kraken | took 59519ms 07:12:49 INFO - TEST-START | v8_7 07:12:49 INFO - operating with platform_type : linux_ 07:12:49 INFO - Initialising browser for v8_7 test... 07:12:49 INFO - TEST-INFO | started process 5346 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLGes6i/profile http://localhost:57359/getInfo.html) 07:12:53 INFO - PROCESS | 5346 | __metrics Screen width/height:1600/1200 07:12:53 INFO - PROCESS | 5346 | colorDepth:24 07:12:53 INFO - PROCESS | 5346 | Browser inner width/height: 1024/697 07:12:53 INFO - PROCESS | 5346 | __metrics 07:12:53 INFO - PROCESS | 5346 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:12:54 INFO - TEST-INFO | 5346: exit 0 07:12:54 INFO - Browser initialized. 07:12:54 INFO - Running cycle 1/1 for v8_7 test... 07:12:54 INFO - TEST-INFO | started process 5470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLGes6i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:06 INFO - PROCESS | 5470 | RSS: Main: 150396928 07:13:06 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:57359/tests/v8_7/run.html (next: http://localhost:57359/tests/v8_7/run.html) 07:13:27 INFO - PROCESS | 5470 | RSS: Main: 145813504 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | __start_tp_report 07:13:27 INFO - PROCESS | 5470 | _x_x_mozilla_page_load 07:13:27 INFO - PROCESS | 5470 | _x_x_mozilla_page_load_details 07:13:27 INFO - PROCESS | 5470 | |i|pagename|runs| 07:13:27 INFO - PROCESS | 5470 | |0;Richards;167.02856188408217 07:13:27 INFO - PROCESS | 5470 | |1;DeltaBlue;189.5016107636915 07:13:27 INFO - PROCESS | 5470 | |2;Encrypt;279.4857462269424 07:13:27 INFO - PROCESS | 5470 | |3;Decrypt;5284.210526315789 07:13:27 INFO - PROCESS | 5470 | |4;RayTrace;1079.913606911447 07:13:27 INFO - PROCESS | 5470 | |5;Earley;711.7437722419929 07:13:27 INFO - PROCESS | 5470 | |6;Boyer;12329.268292682927 07:13:27 INFO - PROCESS | 5470 | |7;RegExp;25200 07:13:27 INFO - PROCESS | 5470 | |8;Splay;675.857431069267 07:13:27 INFO - PROCESS | 5470 | |9;NavierStokes;4845.410628019324 07:13:27 INFO - PROCESS | 5470 | __end_tp_report 07:13:27 INFO - PROCESS | 5470 | __startTimestamp1452006807804__endTimestamp 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | ------- Summary: start ------- 07:13:27 INFO - PROCESS | 5470 | Number of tests: 10 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 167.0 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#1] DeltaBlue Cycles:1 Average:189.50 Median:189.50 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 189.5 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 279.5 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 5284.2 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 1079.9 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#5] Earley Cycles:1 Average:711.74 Median:711.74 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 711.7 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 12329.3 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 25200.0 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#8] Splay Cycles:1 Average:675.86 Median:675.86 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 675.9 07:13:27 INFO - PROCESS | 5470 | 07:13:27 INFO - PROCESS | 5470 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 07:13:27 INFO - PROCESS | 5470 | Values: 4845.4 07:13:27 INFO - PROCESS | 5470 | -------- Summary: end -------- 07:13:27 INFO - PROCESS | 5470 | 07:13:28 INFO - TEST-INFO | 5470: exit 0 07:13:28 INFO - TEST-OK | v8_7 | took 39476ms 07:13:28 INFO - SUITE-END | took 1208s 07:13:28 INFO - Completed test suite (00:20:09) 07:13:28 INFO - Working with test: dromaeo_css 07:13:28 INFO - Generating results file: dromaeo_css 07:13:28 INFO - Working with test: kraken 07:13:28 INFO - Generating results file: kraken 07:13:28 INFO - javascript benchmark 07:13:28 INFO - Working with test: v8_7 07:13:28 INFO - Generating results file: v8_7 07:13:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 07:13:28 INFO - process_Request line: dromaeo_css 6966.78 graph.html#tests=[[72,63,43]] 07:13:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:28 INFO - process_Request line: kraken 1533.40 graph.html#tests=[[232,63,43]] 07:13:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:29 INFO - process_Request line: v8_7 21047.17 graph.html#tests=[[230,63,43]] 07:13:29 INFO - RETURN: dromaeo_css: 6966.78 07:13:29 INFO - RETURN: kraken: 1533.40 07:13:29 INFO - RETURN: v8_7: 21047.17 07:13:29 INFO - javascript benchmark 07:13:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.550942867999, 3235.9676403235976, 3258.4786434170537, 3283.4254005549024, 3288.293017001345, 5297.496737809912, 5377.247185394048, 5377.865553361163, 5419.0, 5420.5392541633955, 5304.655197412166, 5315.176147697113, 5347.385050719168, 5361.490658387456, 5416.404195538487, 4525.162844873693, 4834.613230941525, 4987.451380348159, 4995.725235112068, 5034.496550344973, 4817.735024573647, 4910.459849416561, 4964.677295975768, 4982.451930287665, 4995.425526064495, 4845.588125009378, 4855.198892182768, 4896.4124305083615, 4953.777080031407, 4983.202687569971, 4891.804327826918, 4902.166631672589, 4904.705717656952, 4908.337374454439, 4952.083864485082, 4840.661153719241, 4875.853724388238, 4899.657024008321, 4934.432540257881, 5011.072951503984, 5160.019596276696, 5161.845144645667, 5224.085784987612, 5230.843074707765, 5241.161414173752, 5776.711164441803, 5800.651960882361, 5801.854953626151, 5810.389909059572, 5811.912821307684, 5740.052891272935, 5809.6804675742815, 5842.444967728059, 5844.561657875676, 5857.941420585782, 5343.09167441532, 5426.647267927611, 5427.565794736451, 5433.809816656398, 5465.836024919259, 5978.103284507359, 6012.849678758066, 6013.879722405527, 6036.185115009417, 6041.275046994301, 5654.038813401731, 5744.368119506851, 5776.884462310731, 5779.913301300484, 5790.913136302959, 5885.087811389241, 5899.852503687443, 5901.970490147522, 5912.142739302777, 5914.940850591525, 5736.512396446349, 5792.247007888947, 5827.708614569255, 5831.62094463867, 5841.474267315962, 5698.629589076697, 5734.913976290359, 5780.566457515619, 5808.39011903744, 5840.88318233633, 4412.448443944507, 4429.512753597101, 4434.955650443519, 4472.798724057425, 4485.147821913826, 3964.980175099106, 3977.3835055566433, 3984.963909383523, 3990.8004599770475, 4014.578469260744, 5320.600954928396, 5372.91940620891, 5387.218853266333, 5420.512153906167, 5421.5391691706645, 5824.446677565625, 5826.1552074948895, 5859.384764599741, 5867.237259156283, 5877.823665290048, 5428.240046393508, 5458.645188062763, 5463.726813659301, 5469.425710300441, 5469.562435005269, 4846.079244943449, 4850.296706977469, 4918.6556941014505, 4946.3817022872145, 4963.255511673206, 6032.155498230251, 6055.485283750931, 6075.787347442907, 6077.24034495688, 6087.1173679816175, 5682.659040457585, 5872.29532456108, 5879.647221166743, 5890.087036509348, 5896.705164741831, 5945.881082378415, 6011.218541589566, 6091.496397955189, 6108.7670647404, 6128.233970753656, 5767.452092051249, 5793.971030144822, 5817.621854579608, 5831.4168583141345, 5849.181114643869, 5780.653160810365, 5928.170056192051, 5940.108983652487, 5944.524438044859, 5963.344032156372, 5576.10782274834, 5655.462731040545, 5665.915011274917, 5685.516731077904, 5699.458551437607, 5676.574256930664, 5680.7443665036, 5722.5135863450405, 5732.799352022659, 5737.8565535861935, 5401.270828438111, 5524.806631767869, 5569.554435645057, 5569.777208911598, 5579.051561234519, 5691.117876729114, 5758.596898217253, 5768.423157684198, 5785.942140578541, 5791.623544469596, 5591.077472217201, 5604.075327570905, 5625.46558076982, 5626.465485778845, 5643.238162847963], "unit": "score", "name": "dojo.html", "value": 5353.1789246218395}, {"lowerIsBetter": false, "replicates": [502.6054547180464, 533.5544820075237, 549.0227395236478, 559.7621011070296, 564.5906717629719, 27012.459750804974, 35870.82064589677, 36287.0, 36305.636943630554, 36350.27299454013, 38582.22835543295, 38879.22241555174, 38949.22101557967, 38960.22079558407, 39036.60963390365, 8423.536705481181, 8620.439671421338, 8627.266682332009, 8631.43895646784, 8649.308055355556, 8258.876116858222, 8378.371622128334, 8432.789180270482, 8434.53610051447, 8444.746657600283, 8397.496150231005, 8456.704015359464, 8493.915060849406, 8502.06477287498, 8532.402731808745, 8410.201030902084, 8485.490870547786, 8491.193336633041, 8491.320694344438, 8496.150384961516, 8247.21651443112, 8347.081820999685, 8362.247397734232, 8364.539950302731, 8378.958105209496, 36101.63898361009, 36456.088597785005, 36649.63350366516, 36675.26649466996, 36755.264894701955, 3238.2713889374936, 3413.2149605590603, 3526.7354948378975, 3626.4560315952554, 3952.932708168807, 27253.727462725317, 27377.178684639493, 27688.861555692292, 27759.583606245924, 27809.582856257173, 3373.460246360595, 3383.3064221834466, 3474.617792042873, 3507.175813683782, 3563.732720045981, 184545.0, 184820.0, 185270.0, 185624.99999999866, 186727.0, 49611.751941240065, 51281.48718512767, 55643.44356556464, 55693.0, 60229.0, 52456.47543524592, 52878.0, 53055.0, 53108.0, 53136.468635313926, 14945.925270373578, 15104.244787760568, 15146.621334466507, 15147.166905820286, 15156.393744250106, 11163.106951443864, 11226.831597526043, 11343.262687925258, 11358.432078396212, 11364.147688923198, 18992.620147596972, 19035.238590456505, 19037.14332855025, 19194.712079318822, 19261.614767704847, 7126.2161162272105, 7297.233790451926, 7350.485466017328, 7386.96306518464, 7429.108506979197, 935.1256575102301, 942.7313215733483, 1041.7656027393928, 1073.8281874899978, 1113.6547670222258, 28086.71913280882, 28515.857420712764, 28612.713872861423, 28623.0, 28820.567691484644, 996.3922007575374, 1002.8044531316323, 1059.041567381521, 1089.4661615808197, 1126.4030064065894, 14316.355763990645, 14333.283335833166, 14438.422463101568, 14445.06107103035, 14510.12939223629, 364478.0, 367037.0, 367373.0, 368750.0, 370270.0, 44837.551624483334, 45000.54999450029, 45165.0, 45172.0, 45176.0, 1334.9933250333686, 1364.5224171539883, 1369.664432214094, 1375.3879523611897, 1377.4627895120911, 27817.860910695315, 28813.0, 29053.0, 29097.563536546546, 29220.123396298146, 47217.76391118023, 48245.75877120592, 48264.0, 48721.0, 48736.75631621819, 277265.0, 280899.0, 281682.0, 282207.0, 282892.0, 41604.79197603992, 43158.35262471002, 43349.13301734011, 43785.0, 44129.55870441254, 39721.60278397294, 40153.59846401498, 40510.39234411427, 40710.389344159266, 40890.1821963565, 35825.0, 36181.0, 36219.818900905324, 36885.26229475342, 37092.443613345284, 35420.29159416746, 35877.46183807297, 36052.639473604926, 36335.81832090928, 36422.453663194545, 35259.0, 35396.29207415889, 35459.82270088633, 35658.82170589131, 35684.0, 29895.252618684706, 33057.66942330546, 33346.16634584155, 33347.666523334454, 33389.32717401133, 24924.37689057788, 25268.873655631603, 25418.364540886625, 25551.872240638677, 25689.0], "unit": "score", "name": "ext.html", "value": 17913.992289994498}, {"lowerIsBetter": false, "replicates": [356.79127710289464, 357.7406380374231, 367.0768018433639, 368.4399712437096, 371.3316031143941, 11403.828942565868, 11764.7647047059, 16194.514164575066, 16521.83478165218, 17079.82920170798, 17388.65222695545, 17550.297988080492, 17674.64650706985, 17922.462326130237, 17931.462056138305, 5979.491743201833, 6122.081687746829, 6127.938720612804, 6162.9383706163035, 6164.537659675542, 5055.988802239548, 6115.3884611538715, 6157.784477543287, 6169.29053158888, 6194.225721784777, 6135.754569817202, 6181.59819611726, 6188.690565471731, 6189.16446279751, 6189.81430557084, 6031.457168854802, 6077.6353418795015, 6086.995645718451, 6094.725737341831, 6177.073438984144, 5781.71091445426, 5852.239208902815, 5859.589828711992, 5863.149843272701, 5880.617759845596, 22894.31317060491, 22998.0, 23355.766442335527, 23425.88287058571, 23793.787838641907, 2241.7758224177614, 2361.7638236176244, 2381.7141942966955, 2452.460458699083, 2453.4970331082086, 13923.512677056255, 14127.223002734845, 14449.711005779931, 14493.637659058502, 14725.410983560645, 1943.2032866524657, 1975.980240197594, 1992.501874531367, 2020.9292674756314, 2022.4438279473115, 63018.68490657563, 66400.3359966399, 67821.66089169572, 68761.3123868765, 69842.95235571521, 15232.314545845464, 15315.315315315307, 15335.463258786112, 15425.0, 15531.145786981824, 12914.547990820276, 13128.277944712941, 13213.603591892259, 23965.400864978168, 24137.15519956793, 6886.51794374399, 7026.92973070273, 7660.80847978805, 7706.535449165731, 7913.525188488709, 7710.961445192738, 7748.806279842936, 7751.92248077512, 7773.416993725493, 7799.45403821727, 4467.106578684211, 4481.148581769454, 4505.864824055284, 4551.271796512542, 4556.749378784132, 1854.1100271869577, 1855.879367841086, 1887.9433616991512, 1919.04047976012, 1928.2768961639385, 410.9260333140004, 417.8934371735188, 435.7603318174991, 847.6228078505129, 850.3027517435767, 9747.805043899083, 10251.231157663056, 10360.844587331196, 10427.635032773816, 10589.470526473646, 438.7323732523158, 441.6047637364605, 441.8895276180955, 443.66724956282786, 445.25197667918206, 5782.653040817564, 5798.478136967693, 5799.5070419014855, 5839.2992840858515, 5908.822735317947, 547985.0, 558138.0, 565914.193003243, 570823.0, 577887.0, 77915.22084779193, 79251.0, 79493.0, 80351.19648803437, 81563.59218203872, 469.4413647759156, 476.29746124466135, 476.70206121174266, 477.1697246790629, 478.1011698007723, 9944.552495137881, 10189.032041956003, 14815.40738370453, 15000.624984375041, 15503.612409689847, 25498.235052948443, 27732.30669233285, 31322.843385782926, 34083.65916340805, 34382.58351225825, 43729.344059839765, 44269.335959961274, 45606.771966141285, 45767.31349029834, 46196.538034619225, 9455.290853185901, 9479.28905332089, 9678.56446459925, 9748.220142388735, 9812.803743924938, 11667.416629168338, 11719.17965742424, 11743.76512469763, 16082.035579900705, 17318.740218896473, 14748.336324865193, 14836.0, 14909.850901490847, 15072.698546029238, 15109.924450377677, 14672.706545869236, 14675.92662036683, 14693.19187444658, 14780.852191477947, 14963.177025263714, 14047.859521405064, 14475.92762036183, 15091.245437728288, 15099.094054356774, 15422.69154616879, 9758.414495130315, 9799.51002449889, 9815.312928094965, 9880.25898057663, 9922.107010369102, 14525.201113938412, 14742.63143421423, 14792.11247325164, 15064.774028389802, 15165.0], "unit": "score", "name": "jquery.html", "value": 8582.031710621019}, {"lowerIsBetter": false, "replicates": [1450.622838062104, 1473.7641977283633, 1641.9261133249004, 1747.5980524479378, 1772.4505403324963, 7812.648430820613, 7909.446338756275, 7967.482113662608, 8059.556724380157, 8061.87907181392, 8009.11899691035, 8037.879431808527, 8066.274035336818, 8115.0, 8116.066652334968, 2303.251443280936, 2339.5671800716837, 2347.9647805282934, 2348.38941875112, 2351.353377821096, 2304.700388949434, 2324.151684635113, 2336.2173671819874, 2342.5783358995373, 2359.2568340972625, 2290.6678531612906, 2299.977000229993, 2301.723793144825, 2330.883455827202, 2347.835651504395, 2322.8257880658934, 2364.0307473935777, 2365.988170059156, 2368.230325144335, 2369.0642196332437, 2252.1779550464125, 2265.988670056639, 2271.04616061253, 2274.056266649355, 2278.1912421090606, 7732.381409487284, 7790.688372465094, 7814.960925195338, 7820.804479888048, 7838.09861865887, 4721.527847215285, 4804.20730579454, 4814.927776083362, 4831.782569784333, 4846.61227101831, 3002.5946497222812, 3012.4276387486525, 3043.4065357255345, 3082.075377386775, 3150.732187764043, 918.9218916392115, 920.6087412849579, 942.5240253671852, 970.6069042037985, 979.7648564344577, 11039.83440248405, 11057.778844423146, 11089.168312376603, 11124.332540047622, 11154.051905588034, 4228.534861165269, 4288.099499105223, 4316.201502722007, 4379.343098535245, 4392.297232442794, 8954.597043133075, 8997.505137217517, 9015.0, 9031.954840225757, 9048.638054477879, 4736.076465089274, 4743.810247590127, 4752.3584316116885, 4756.429228492603, 4782.139214941344, 4312.223799716081, 4360.563943605614, 4362.280223763107, 4381.78091095444, 4407.801648925806, 3566.375884220303, 3579.785212887235, 3580.15866271426, 3585.2650206707563, 3614.945775813365, 1092.6558134187865, 1108.5256608710397, 1110.8222684370623, 1115.8884111588777, 1118.5861231344454, 1030.6135199300113, 1030.829913064336, 1059.9506488576408, 1156.919015668912, 1288.645622453814, 7297.197308296083, 7397.630118494054, 7427.257274272638, 7447.069116360455, 7447.925520744723, 1115.1580556679817, 1117.580907159815, 1136.5510623303749, 1136.9545218191179, 1152.5965911930925, 5712.314522257356, 5737.3975732548315, 5738.598298119092, 5758.1650660654805, 5842.795502157404, 9215.723528294162, 9383.718488445358, 9655.324127311022, 9726.90273097274, 9752.463614501128, 9534.570944307523, 9538.475383853816, 9569.61721531131, 9622.47076410804, 9631.566579503939, 7284.526505777108, 7433.9256607433235, 7471.775846724607, 7481.476296659182, 7510.361619262424, 7124.358807707331, 7171.641417928979, 7175.497715159889, 7179.605121718356, 7189.281071892978, 8328.167183281623, 8380.832383352421, 8626.870596941177, 8641.395102342776, 8662.523561204194, 8749.91250087491, 8755.343349248704, 8842.292616590528, 8893.066228045962, 8984.146506081912, 6661.766838160641, 6714.462842972453, 6715.966420167868, 6741.056252124805, 6753.3921947025, 7209.855802884018, 7212.963935180501, 7225.24134965821, 7251.818704532217, 7252.5648461092505, 6801.931980680328, 6985.441164706913, 7002.159740831133, 7060.823479413056, 7090.255523169993, 6698.196216454056, 6708.765193218214, 6739.292374300824, 6791.45668346541, 6867.553609015398, 7006.194287656985, 7033.718651253893, 7041.471889608402, 7060.71757129709, 7101.857962840818, 6330.050492426173, 6381.234251889803, 6387.776427825004, 6399.168108145911, 6412.519061070531, 6530.183727034121, 6632.801015969529, 6633.336666333521, 6639.668016599054, 6671.33286671329], "unit": "score", "name": "mootools.html", "value": 4514.180117739037}, {"lowerIsBetter": false, "replicates": [330.1136448635414, 334.16292188068894, 340.8772841776961, 343.99140021499477, 348.7227654015059, 6086.726097325625, 6124.969375153124, 6128.662923539209, 6238.875222495547, 6333.113364129025, 6139.079138129283, 6217.347178546255, 6226.43962043416, 6251.3123556408755, 6282.308946015934, 4689.062187562484, 4705.882352941187, 4706.29405589161, 4716.693414928019, 4723.197056500403, 4709.317149013391, 4719.551642593948, 4720.480747117815, 4721.173794585934, 4736.739479328636, 4479.48485924118, 4600.493945665974, 4642.883927901796, 4678.485366609687, 4687.531246875319, 4670.626349892001, 4674.836380726675, 4678.274867395542, 4682.7658617069355, 4689.812407503696, 4094.4063110849056, 4096.262672718909, 4100.835966561334, 4110.486189226347, 4110.91778164438, 5873.500752436048, 5877.79427720032, 5878.030125029365, 5923.881522369528, 5926.288845338544, 5492.632857996674, 5526.336839579276, 5530.170474428827, 5562.638428502175, 5566.749496272678, 6580.86838263232, 6581.177352830896, 6582.275949645536, 6598.637074960875, 6602.1747281589805, 4584.7936842842155, 4598.402207713009, 4598.609118224955, 4602.815887364535, 4604.447466304065, 6734.427573656245, 6815.829604259884, 6853.280405557394, 6873.793786186372, 6895.620740859251, 4660.067986402733, 4662.323963025342, 4663.440387153563, 4670.159371313128, 4672.906541869143, 4716.339712440261, 4729.668923175344, 4731.668783185213, 4736.905261894743, 4742.739149346819, 5450.809221677222, 5458.563314934796, 5461.0716178249795, 5469.863253418617, 5476.7535460904355, 6431.067495213168, 6590.275069742324, 6610.008498725229, 6628.038934354588, 6639.203295604559, 1685.3679870048732, 1689.3158270900306, 1708.265445858268, 1710.1363811275226, 1710.4013595241565, 1145.1468655851445, 1159.7912375772441, 1160.0951258018758, 1161.8199179127248, 1179.7050737315672, 6255.186825712628, 6259.374062593795, 6265.906011409833, 6270.780522681775, 6274.247090349096, 6781.62701051437, 6784.559003664746, 6809.897851532231, 6811.795646130624, 6835.14560679915, 6089.725962331706, 6219.0, 6243.75024999004, 6278.843028924222, 6295.96852015737, 3713.2387860488534, 3722.218334149805, 3726.360401423365, 3740.588535261119, 3743.9251214975548, 7075.363217310364, 7130.42956563484, 7133.215346311901, 7144.749933752294, 7165.104361954755, 6949.441113331833, 7024.894626580605, 7062.1878483975, 7089.7873063808165, 7105.467089968273, 7161.67772450241, 7175.17485489165, 7179.1026121734785, 7183.640817959081, 7201.387882030086, 6764.985252212207, 6832.350926661959, 6843.863122737418, 6845.623490708059, 6873.793786186222, 6564.081028655896, 6712.328767123248, 6742.393184613408, 6767.052612634334, 6778.0510728497065, 7121.074260346122, 7131.393831524171, 7194.532355396883, 7203.891941620985, 7205.747798827016, 4534.59188673021, 4568.565986231302, 4581.335706322631, 4583.931241031454, 4587.266037433995, 6729.0, 6918.7232510699005, 6924.653767311514, 6925.272846351262, 6941.47938904574, 6640.0, 6678.031685405686, 6679.0649309097735, 6698.0, 6703.698333575098, 6649.335066493312, 6680.131582894192, 6690.230623478167, 6701.296363881722, 6707.0945422369305, 6331.0819931110655, 6412.102305677302, 6428.357164283534, 6453.483721302378, 6506.41442270198, 6697.698603562949, 6720.865582688221, 6723.966380168264, 6738.59568425896, 6741.0, 6397.0724244983285, 6511.088447617242, 6544.9672751635935, 6555.541671873048, 6563.015547667888], "unit": "score", "name": "prototype.html", "value": 4981.261191254218}, {"lowerIsBetter": false, "replicates": [683.7230921476801, 768.6886810841611, 802.3300544045721, 809.7407635835506, 814.4909431605247, 11756.588519401823, 11921.22512036717, 11923.940380298098, 11936.224145430562, 11952.223105498148, 12050.337231452266, 13992.370343334549, 14169.71660566788, 14901.701965960674, 14940.551783446514, 763.4884627299695, 783.4437549339975, 794.8092457810142, 796.8685166947447, 834.8789425533294, 816.3877092180865, 823.3248736036453, 826.9297109745679, 827.5365795154703, 831.1646794971045, 847.8728190771373, 852.2372476633409, 858.3262139220712, 863.6804382378529, 864.5763575847852, 849.1762989899818, 854.3891117850767, 855.3499340501202, 856.2807241916757, 856.9314454843598, 614.5483069943588, 614.7418084404561, 615.9630422174683, 627.6767464755654, 635.463033736492, 13900.304984750723, 13988.58034258974, 14108.153510789283, 14113.0, 14130.222837744022, 11419.143564232716, 11797.0, 12230.877691223151, 12814.038947078912, 12845.743085138338, 10097.899021009769, 10259.948700256526, 10462.058414742634, 10597.73505662357, 10999.0, 3613.0, 3626.691731202851, 3713.3130370881204, 3724.4599533067826, 3734.495843061179, 44447.555524444666, 44969.550304496865, 44975.0, 45005.54994450079, 45058.54941450576, 9283.953580232055, 9371.390859594105, 9411.294152938557, 9441.952790236004, 9558.474283914451, 15854.68290634204, 15872.92063539698, 16176.110313932846, 16225.0, 16263.512094637179, 7328.230535793665, 7341.596212208273, 7474.065741782278, 7560.470767046364, 7658.73194438192, 4260.701750877471, 4340.348947657877, 4341.327094300388, 4377.212101821639, 4378.277584198635, 2982.492976194052, 3024.3346463777934, 3024.6370435547433, 3028.227801910499, 3101.8914337998513, 562.0838034004628, 566.4618612318314, 576.0667718296303, 580.3210244014513, 583.527342852291, 520.6745783885071, 547.8631838934227, 556.8945642898842, 574.4456599381617, 596.7762089216544, 7583.962080189674, 7913.525188488709, 8088.9595552021865, 8195.672173113127, 8258.298044666151, 494.8911239527298, 621.7202258983475, 637.6206157336377, 642.6176425027102, 649.8407890066964, 4035.636792688672, 4169.187008533307, 4302.827886884552, 4322.178786030644, 4340.348947657877, 54662.72668636632, 54981.45018549763, 55233.72383138059, 55472.445275547536, 55526.16710749342, 49231.0, 50329.74835125801, 50512.494875050776, 51495.22757158645, 51593.742031290356, 45497.0, 45611.0, 45627.315590266175, 46439.535604644196, 46522.0, 8364.330853531581, 8487.830243394974, 8498.150184981452, 8560.400771946153, 8658.740237792876, 31425.8428707855, 31960.84019579887, 32269.51595726113, 33066.338673226885, 33227.16932076718, 40084.19831603293, 41096.38355424731, 45195.774021129684, 45740.771296143306, 46630.76684616555, 10757.784844302914, 10854.34068653185, 11086.168537359568, 11114.22200445961, 11688.766224675628, 11606.825897611712, 11658.533658653898, 11671.59149429766, 11894.34581098048, 12256.203346782431, 10740.83888741685, 10757.677269681923, 10793.62222322215, 10833.349999000086, 10918.181136414642, 11365.772684546428, 11457.484413201593, 11668.066554675435, 11860.22908510944, 11965.461554230254, 9335.486548239913, 10641.521131548943, 11084.168687348643, 11304.152188585724, 11588.420578970849, 9107.134822191882, 9452.716418507456, 9473.905260947302, 9712.611495540099, 9905.55425005862, 9531.428114313163, 9716.951415242878, 9820.607175712892, 9929.503524823585, 9994.75263110998], "unit": "score", "name": "yui.html", "value": 6177.954172786658}], "name": "dromaeo_css", "value": 6966.780505616143}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 110.0, 111.0, 112.0, 124.0, 110.0, 110.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 158.0, 175.0, 130.0, 155.0, 150.0, 126.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [164.0, 166.0, 166.0, 166.0, 165.0, 166.0, 164.0, 170.0, 173.0, 164.0], "unit": "score", "name": "audio-dft", "value": 166.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 73.0, 75.0, 72.0, 147.0, 71.0, 72.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 143.0, 96.0, 97.0, 96.0, 146.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 145.0, 145.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [59.0, 67.0, 62.0, 58.0, 59.0, 57.0, 60.0, 61.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 88.0, 93.0, 86.0, 84.0, 86.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 123.0, 128.0, 128.0, 118.0, 134.0, 121.0, 136.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [147.0, 159.0, 146.0, 156.0, 157.0, 147.0, 150.0, 157.0, 156.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.7}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 72.0, 70.0, 70.0, 71.0, 69.0, 71.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1533.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [189.5016107636915], "unit": "score", "name": "DeltaBlue", "value": 348.90468599999986}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [711.7437722419929], "unit": "score", "name": "Earley", "value": 936.3805150000001}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [675.857431069267], "unit": "score", "name": "Splay", "value": 120.57424577114423}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21047.16899784729}]} 07:13:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21047.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1533.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6966.78"}}} 07:13:29 INFO - Return code: 0 07:13:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:13:29 INFO - # TBPL SUCCESS # 07:13:29 INFO - Running post-action listener: _resource_record_post_action 07:13:29 INFO - Running post-run listener: _resource_record_post_run 07:13:30 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 569221120; Read time: 0; Write time: 638340 07:13:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245231616; Read time: 0; Write time: 335380 07:13:30 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 319959040; Read time: 0; Write time: 302404 07:13:30 INFO - Running post-run listener: _upload_blobber_files 07:13:30 INFO - Blob upload gear active. 07:13:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:13:30 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 07:13:30 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'] 07:13:30 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 07:13:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:13:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:31 INFO - (blobuploader) - INFO - Done attempting. 07:13:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:32 INFO - (blobuploader) - INFO - Done attempting. 07:13:32 INFO - (blobuploader) - INFO - Iteration through files over. 07:13:32 INFO - Return code: 0 07:13:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:13:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:13:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21e6d281179dbf4128c59436a2771a243a2df3a0b8ece9b2015c036ad5ac349afafb4086d46a94aeccfface66565529fcb09cd47547b13a6c3c20f59a0026091", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/785e8ccaf2aa7fc0a9e6f311cc5d4ff932db54400278d01370d55d9b914af1460a4759a875549c543ef18825af4f13ac73962efd53b4be2f02bcab0ed37f9398"} 07:13:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:13:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:13:32 INFO - Contents: 07:13:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21e6d281179dbf4128c59436a2771a243a2df3a0b8ece9b2015c036ad5ac349afafb4086d46a94aeccfface66565529fcb09cd47547b13a6c3c20f59a0026091", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/785e8ccaf2aa7fc0a9e6f311cc5d4ff932db54400278d01370d55d9b914af1460a4759a875549c543ef18825af4f13ac73962efd53b4be2f02bcab0ed37f9398"} 07:13:32 INFO - Copying logs to upload dir... 07:13:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.609675 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-05 07:13:31.784423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 07:13:31.788551) ========= 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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 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/21e6d281179dbf4128c59436a2771a243a2df3a0b8ece9b2015c036ad5ac349afafb4086d46a94aeccfface66565529fcb09cd47547b13a6c3c20f59a0026091", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/785e8ccaf2aa7fc0a9e6f311cc5d4ff932db54400278d01370d55d9b914af1460a4759a875549c543ef18825af4f13ac73962efd53b4be2f02bcab0ed37f9398"} build_url:https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/cVs1i6tdTS6SYqIJgGyBAA/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/21e6d281179dbf4128c59436a2771a243a2df3a0b8ece9b2015c036ad5ac349afafb4086d46a94aeccfface66565529fcb09cd47547b13a6c3c20f59a0026091", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/785e8ccaf2aa7fc0a9e6f311cc5d4ff932db54400278d01370d55d9b914af1460a4759a875549c543ef18825af4f13ac73962efd53b4be2f02bcab0ed37f9398"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 07:13:31.813869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:13:31.814267) ========= 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=1b9da9da7504fe468691862d000001b9-1452005519.964494-1441287783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:13:31.897327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 07:13:31.897695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 07:13:31.898092) ========= ========= Total master_lag: 0.27 =========