builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1452794703.31 results: success (0) buildid: 20160114073313 builduid: 97a0187206d44849a89ebfcfb7225eed revision: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.309288) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.309704) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.309984) ========= 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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006491 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.340010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.340319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.379307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.379597) ========= 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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.428027) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.428340) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.428696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.429235) ========= 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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 10:05:03-- 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% 78.2M=0s 2016-01-14 10:05:04 (78.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.610069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.610340) ========= 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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017972 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.659769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:03.660062) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 --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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 10:05:04,213 truncating revision to first 12 chars 2016-01-14 10:05:04,214 Setting DEBUG logging. 2016-01-14 10:05:04,214 attempt 1/10 2016-01-14 10:05:04,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27eb5e90eeee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 10:05:04,450 unpacking tar archive at: mozilla-central-27eb5e90eeee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:04.181395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:04.181678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:04.194349) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:04.194618) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:04.194962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-14 10:05:04.195232) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:04 INFO - MultiFileLogger online at 20160114 10:05:04 in /builds/slave/test-pgo 10:05:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:05:04 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:05:04 INFO - {'append_to_log': False, 10:05:04 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:05:04 INFO - 'blob_upload_branch': 'Firefox', 10:05:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:05:04 INFO - 'branch': 'Firefox', 10:05:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:04 INFO - 'config_files': ('talos/linux_config.py',), 10:05:04 INFO - 'default_actions': ('clobber', 10:05:04 INFO - 'read-buildbot-config', 10:05:04 INFO - 'download-and-extract', 10:05:04 INFO - 'populate-webroot', 10:05:04 INFO - 'create-virtualenv', 10:05:04 INFO - 'install', 10:05:04 INFO - 'run-tests'), 10:05:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:04 INFO - 'download_minidump_stackwalk': True, 10:05:04 INFO - 'download_symbols': 'ondemand', 10:05:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:04 INFO - 'installer_path': 'installer.exe', 10:05:04 INFO - 'log_level': 'info', 10:05:04 INFO - 'log_name': 'talos', 10:05:04 INFO - 'log_to_console': True, 10:05:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:04 INFO - 'opt_config_files': (), 10:05:04 INFO - 'pip_index': False, 10:05:04 INFO - 'sps_profile': False, 10:05:04 INFO - 'sps_profile_interval': 0, 10:05:04 INFO - 'suite': 'dromaeojs-e10s', 10:05:04 INFO - 'system_bits': '32', 10:05:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:04 INFO - 'title': 'talos-linux64-ix-035', 10:05:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:04 INFO - 'use_talos_json': True, 10:05:04 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:05:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:04 INFO - 'work_dir': 'build'} 10:05:04 INFO - ##### 10:05:04 INFO - ##### Running clobber step. 10:05:04 INFO - ##### 10:05:04 INFO - Running pre-action listener: _resource_record_pre_action 10:05:04 INFO - Running main action method: clobber 10:05:04 INFO - rmtree: /builds/slave/test-pgo/build 10:05:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:05:05 INFO - Running post-action listener: _resource_record_post_action 10:05:05 INFO - ##### 10:05:05 INFO - ##### Running read-buildbot-config step. 10:05:05 INFO - ##### 10:05:05 INFO - Running pre-action listener: _resource_record_pre_action 10:05:05 INFO - Running main action method: read_buildbot_config 10:05:05 INFO - Using buildbot properties: 10:05:05 INFO - { 10:05:05 INFO - "project": "", 10:05:05 INFO - "product": "firefox", 10:05:05 INFO - "script_repo_revision": "production", 10:05:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:05:05 INFO - "repository": "", 10:05:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:05:05 INFO - "buildid": "20160114073313", 10:05:05 INFO - "pgo_build": "True", 10:05:05 INFO - "basedir": "/builds/slave/test-pgo", 10:05:05 INFO - "buildnumber": 71, 10:05:05 INFO - "slavename": "talos-linux64-ix-035", 10:05:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:05:05 INFO - "platform": "ubuntu64_hw", 10:05:05 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:05:05 INFO - "branch": "mozilla-central", 10:05:05 INFO - "repo_path": "mozilla-central", 10:05:05 INFO - "revision": "27eb5e90eeee2e6a1ffe61c368c294d3de51b797", 10:05:05 INFO - "stage_platform": "linux64-pgo", 10:05:05 INFO - "builduid": "97a0187206d44849a89ebfcfb7225eed", 10:05:05 INFO - "slavebuilddir": "test" 10:05:05 INFO - } 10:05:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:05:05 INFO - Running post-action listener: _resource_record_post_action 10:05:05 INFO - ##### 10:05:05 INFO - ##### Running download-and-extract step. 10:05:05 INFO - ##### 10:05:05 INFO - Running pre-action listener: _resource_record_pre_action 10:05:05 INFO - Running main action method: download_and_extract 10:05:05 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:05:05 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')]} 10:05:05 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:05:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json 10:05:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json 10:05:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:05:08 INFO - Downloaded 1448 bytes. 10:05:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:05:08 INFO - Using the following test package requirements: 10:05:08 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:08 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:08 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:08 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'jsshell-linux-x86_64.zip'], 10:05:08 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:08 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:08 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:08 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:08 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:08 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:08 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:08 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:08 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:11 INFO - Downloaded 24030232 bytes. 10:05:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:05:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:05:12 INFO - Return code: 0 10:05:12 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 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:12 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:18 INFO - Downloaded 24030232 bytes. 10:05:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:05:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:05:20 INFO - Return code: 0 10:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:20 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:22 INFO - Downloaded 11132144 bytes. 10:05:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:05:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:05:22 INFO - Return code: 0 10:05:22 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')]} 10:05:22 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:30 INFO - Downloaded 55844893 bytes. 10:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:30 INFO - mkdir: /builds/slave/test-pgo/properties 10:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:05:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:05:30 INFO - Contents: 10:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:30 INFO - Running post-action listener: _resource_record_post_action 10:05:30 INFO - Running post-action listener: set_extra_try_arguments 10:05:30 INFO - ##### 10:05:30 INFO - ##### Running populate-webroot step. 10:05:30 INFO - ##### 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: populate_webroot 10:05:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:30 INFO - '--tppagecycles', 10:05:30 INFO - '7'], 10:05:30 INFO - 'tests': ['tsvgm']}}, 10:05:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:05:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'tests': ['damp', 'tps']}, 10:05:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['damp', 'tps']}, 10:05:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:05:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:30 INFO - 'other': {'tests': ['a11yr', 10:05:30 INFO - 'ts_paint', 10:05:30 INFO - 'tpaint', 10:05:30 INFO - 'sessionrestore', 10:05:30 INFO - 'sessionrestore_no_auto_restore']}, 10:05:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['a11yr', 10:05:30 INFO - 'ts_paint', 10:05:30 INFO - 'tpaint', 10:05:30 INFO - 'sessionrestore', 10:05:30 INFO - 'sessionrestore_no_auto_restore']}, 10:05:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['a11yr', 10:05:30 INFO - 'ts_paint', 10:05:30 INFO - 'tpaint', 10:05:30 INFO - 'sessionrestore', 10:05:30 INFO - 'sessionrestore_no_auto_restore']}, 10:05:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['a11yr', 10:05:30 INFO - 'ts_paint', 10:05:30 INFO - 'tpaint', 10:05:30 INFO - 'sessionrestore', 10:05:30 INFO - 'sessionrestore_no_auto_restore']}, 10:05:30 INFO - 'other_l64': {'tests': ['a11yr', 10:05:30 INFO - 'ts_paint', 10:05:30 INFO - 'tpaint', 10:05:30 INFO - 'sessionrestore', 10:05:30 INFO - 'sessionrestore_no_auto_restore']}, 10:05:30 INFO - 'other_nol64': {'tests': ['a11yr', 10:05:30 INFO - 'ts_paint', 10:05:30 INFO - 'tpaint', 10:05:30 INFO - 'sessionrestore', 10:05:30 INFO - 'sessionrestore_no_auto_restore']}, 10:05:30 INFO - 'svgr': {'tests': ['tsvgx', 10:05:30 INFO - 'tsvgr_opacity', 10:05:30 INFO - 'tart', 10:05:30 INFO - 'tscrollx', 10:05:30 INFO - 'cart']}, 10:05:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['tsvgx', 10:05:30 INFO - 'tsvgr_opacity', 10:05:30 INFO - 'tart', 10:05:30 INFO - 'tscrollx', 10:05:30 INFO - 'cart']}, 10:05:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'tests': ['tp5o']}, 10:05:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'talos_options': ['--e10s'], 10:05:30 INFO - 'tests': ['tp5o']}, 10:05:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'talos_options': ['--xperf_path', 10:05:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:30 INFO - 'tests': ['tp5n']}, 10:05:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:30 INFO - 'talos_options': ['--e10s', 10:05:30 INFO - '--xperf_path', 10:05:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:30 INFO - 'tests': ['tp5n']}}, 10:05:30 INFO - 'talos.zip': {'path': '', 10:05:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:30 INFO - Running post-action listener: _resource_record_post_action 10:05:30 INFO - ##### 10:05:30 INFO - ##### Running create-virtualenv step. 10:05:30 INFO - ##### 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: create_virtualenv 10:05:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:05:30 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 10:05:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:05:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:30 INFO - Using real prefix '/usr' 10:05:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:05:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:32 INFO - Installing pip.................done. 10:05:32 INFO - Return code: 0 10:05:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:05:32 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')]} 10:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:32 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')]} 10:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:32 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:32 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 10:05:32 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 10:05:32 INFO - Using env: {'DISPLAY': ':0', 10:05:32 INFO - 'HOME': '/home/cltbld', 10:05:32 INFO - 'LANG': 'en_US.UTF-8', 10:05:32 INFO - 'LANGUAGE': 'en_US:en', 10:05:32 INFO - 'LOGNAME': 'cltbld', 10:05:32 INFO - 'MAIL': '/var/mail/cltbld', 10:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:32 INFO - 'MOZ_NO_REMOTE': '1', 10:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:32 INFO - 'NO_EM_RESTART': '1', 10:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:32 INFO - 'SHELL': '/bin/bash', 10:05:32 INFO - 'SHLVL': '1', 10:05:32 INFO - 'TERM': 'linux', 10:05:32 INFO - 'TMOUT': '86400', 10:05:32 INFO - 'USER': 'cltbld', 10:05:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:32 INFO - '_': '/tools/buildbot/bin/python'} 10:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:32 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 10:05:32 INFO - Cleaning up... 10:05:32 INFO - Return code: 0 10:05:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:05:32 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')]} 10:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:32 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')]} 10:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:32 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:32 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 10:05:32 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 10:05:32 INFO - Using env: {'DISPLAY': ':0', 10:05:32 INFO - 'HOME': '/home/cltbld', 10:05:32 INFO - 'LANG': 'en_US.UTF-8', 10:05:32 INFO - 'LANGUAGE': 'en_US:en', 10:05:32 INFO - 'LOGNAME': 'cltbld', 10:05:32 INFO - 'MAIL': '/var/mail/cltbld', 10:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:32 INFO - 'MOZ_NO_REMOTE': '1', 10:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:32 INFO - 'NO_EM_RESTART': '1', 10:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:32 INFO - 'SHELL': '/bin/bash', 10:05:32 INFO - 'SHLVL': '1', 10:05:32 INFO - 'TERM': 'linux', 10:05:32 INFO - 'TMOUT': '86400', 10:05:32 INFO - 'USER': 'cltbld', 10:05:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:32 INFO - '_': '/tools/buildbot/bin/python'} 10:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:33 INFO - Downloading/unpacking psutil>=0.7.1 10:05:33 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 10:05:33 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 10:05:33 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 10:05:33 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 10:05:33 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 10:05:33 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 10:05:34 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:05:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:05:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:34 INFO - Installing collected packages: psutil 10:05:34 INFO - Running setup.py install for psutil 10:05:34 INFO - building 'psutil._psutil_linux' extension 10:05:34 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 10:05:35 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 10:05:35 INFO - building 'psutil._psutil_posix' extension 10:05:35 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 10:05:35 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 10:05:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:35 INFO - Successfully installed psutil 10:05:35 INFO - Cleaning up... 10:05:35 INFO - Return code: 0 10:05:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:05: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')]} 10:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:35 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 10:05:35 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 10:05:35 INFO - Using env: {'DISPLAY': ':0', 10:05:35 INFO - 'HOME': '/home/cltbld', 10:05:35 INFO - 'LANG': 'en_US.UTF-8', 10:05:35 INFO - 'LANGUAGE': 'en_US:en', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MAIL': '/var/mail/cltbld', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SHLVL': '1', 10:05:35 INFO - 'TERM': 'linux', 10:05:35 INFO - 'TMOUT': '86400', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:35 INFO - '_': '/tools/buildbot/bin/python'} 10:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:05:35 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 10:05:35 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 10:05:35 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 10:05:35 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 10:05:35 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 10:05:35 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 10:05:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:05:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:37 INFO - Installing collected packages: mozsystemmonitor 10:05:37 INFO - Running setup.py install for mozsystemmonitor 10:05:37 INFO - Successfully installed mozsystemmonitor 10:05:37 INFO - Cleaning up... 10:05:37 INFO - Return code: 0 10:05:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:05:37 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')]} 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:37 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')]} 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:37 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:37 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 10:05:37 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 10:05:37 INFO - Using env: {'DISPLAY': ':0', 10:05:37 INFO - 'HOME': '/home/cltbld', 10:05:37 INFO - 'LANG': 'en_US.UTF-8', 10:05:37 INFO - 'LANGUAGE': 'en_US:en', 10:05:37 INFO - 'LOGNAME': 'cltbld', 10:05:37 INFO - 'MAIL': '/var/mail/cltbld', 10:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:37 INFO - 'MOZ_NO_REMOTE': '1', 10:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:37 INFO - 'NO_EM_RESTART': '1', 10:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:37 INFO - 'SHELL': '/bin/bash', 10:05:37 INFO - 'SHLVL': '1', 10:05:37 INFO - 'TERM': 'linux', 10:05:37 INFO - 'TMOUT': '86400', 10:05:37 INFO - 'USER': 'cltbld', 10:05:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:37 INFO - '_': '/tools/buildbot/bin/python'} 10:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:37 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 10:05:37 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 10:05:37 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 10:05:37 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 10:05:37 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 10:05:37 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 10:05:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:05:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:05:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:05:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 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 10:05:39 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 10:05:40 INFO - Downloading docopt-0.6.1.tar.gz 10:05:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:05:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:40 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:40 INFO - Running setup.py install for blobuploader 10:05:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:05:40 INFO - Running setup.py install for requests 10:05:40 INFO - Running setup.py install for docopt 10:05:40 INFO - Successfully installed blobuploader requests docopt 10:05:40 INFO - Cleaning up... 10:05:40 INFO - Return code: 0 10:05:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:40 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 10:05:40 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 10:05:40 INFO - Using env: {'DISPLAY': ':0', 10:05:40 INFO - 'HOME': '/home/cltbld', 10:05:40 INFO - 'LANG': 'en_US.UTF-8', 10:05:40 INFO - 'LANGUAGE': 'en_US:en', 10:05:40 INFO - 'LOGNAME': 'cltbld', 10:05:40 INFO - 'MAIL': '/var/mail/cltbld', 10:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:40 INFO - 'MOZ_NO_REMOTE': '1', 10:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:40 INFO - 'NO_EM_RESTART': '1', 10:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:40 INFO - 'SHELL': '/bin/bash', 10:05:40 INFO - 'SHLVL': '1', 10:05:40 INFO - 'TERM': 'linux', 10:05:40 INFO - 'TMOUT': '86400', 10:05:40 INFO - 'USER': 'cltbld', 10:05:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:40 INFO - '_': '/tools/buildbot/bin/python'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:41 INFO - Running setup.py (path:/tmp/pip-jFRJH3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:41 INFO - Running setup.py (path:/tmp/pip-14Z7aE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:41 INFO - Running setup.py (path:/tmp/pip-rLuA8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:41 INFO - Running setup.py (path:/tmp/pip-TKpD9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:41 INFO - Running setup.py (path:/tmp/pip-QyxyWe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:41 INFO - Running setup.py (path:/tmp/pip-2YKf4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:41 INFO - Running setup.py (path:/tmp/pip-Y1_XqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:41 INFO - Running setup.py (path:/tmp/pip-tjVC_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:41 INFO - Running setup.py (path:/tmp/pip-6THZJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:05:41 INFO - Running setup.py (path:/tmp/pip-foNViH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:05:41 INFO - Running setup.py (path:/tmp/pip-kJAjq3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:05:41 INFO - Running setup.py (path:/tmp/pip-Fyu5Pb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:05:41 INFO - Running setup.py (path:/tmp/pip-CASEE8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:05:41 INFO - Running setup.py (path:/tmp/pip-bB2ZFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:05:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:05:42 INFO - Running setup.py (path:/tmp/pip-8iW9I4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:05:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:05:42 INFO - Running setup.py (path:/tmp/pip-iBdy02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:05:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:05:42 INFO - Running setup.py (path:/tmp/pip-C0xKqJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:05:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:42 INFO - Running setup.py install for manifestparser 10:05:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:05:42 INFO - Running setup.py install for mozcrash 10:05:42 INFO - Running setup.py install for mozdebug 10:05:42 INFO - Running setup.py install for mozdevice 10:05:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:05:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:05:42 INFO - Running setup.py install for mozfile 10:05:42 INFO - Running setup.py install for mozhttpd 10:05:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:05:42 INFO - Running setup.py install for mozinfo 10:05:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:05:42 INFO - Running setup.py install for mozInstall 10:05:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Running setup.py install for mozleak 10:05:43 INFO - Running setup.py install for mozlog 10:05:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Running setup.py install for moznetwork 10:05:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Running setup.py install for mozprocess 10:05:43 INFO - Running setup.py install for mozprofile 10:05:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Running setup.py install for mozrunner 10:05:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:05:43 INFO - Running setup.py install for mozscreenshot 10:05:43 INFO - Running setup.py install for moztest 10:05:43 INFO - Running setup.py install for mozversion 10:05:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:05:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:44 INFO - Cleaning up... 10:05:44 INFO - Return code: 0 10:05:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:05: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')]} 10:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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', '-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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:44 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 10:05:44 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 10:05:44 INFO - Using env: {'DISPLAY': ':0', 10:05:44 INFO - 'HOME': '/home/cltbld', 10:05:44 INFO - 'LANG': 'en_US.UTF-8', 10:05:44 INFO - 'LANGUAGE': 'en_US:en', 10:05:44 INFO - 'LOGNAME': 'cltbld', 10:05:44 INFO - 'MAIL': '/var/mail/cltbld', 10:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:44 INFO - 'MOZ_NO_REMOTE': '1', 10:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:44 INFO - 'NO_EM_RESTART': '1', 10:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:44 INFO - 'SHELL': '/bin/bash', 10:05:44 INFO - 'SHLVL': '1', 10:05:44 INFO - 'TERM': 'linux', 10:05:44 INFO - 'TMOUT': '86400', 10:05:44 INFO - 'USER': 'cltbld', 10:05:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:44 INFO - '_': '/tools/buildbot/bin/python'} 10:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:44 INFO - Running setup.py (path:/tmp/pip-HbfdHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:44 INFO - Running setup.py (path:/tmp/pip-fMqB_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:44 INFO - Running setup.py (path:/tmp/pip-n3vt4p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:44 INFO - Running setup.py (path:/tmp/pip-1MdzYv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:44 INFO - Running setup.py (path:/tmp/pip-KbJ5KP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:44 INFO - Running setup.py (path:/tmp/pip-5cHjic-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:44 INFO - Running setup.py (path:/tmp/pip-kDIBiw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:44 INFO - Running setup.py (path:/tmp/pip-zCmPiT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:44 INFO - Running setup.py (path:/tmp/pip-_F_rEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:05:44 INFO - Running setup.py (path:/tmp/pip-BEWITf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:05:44 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)) 10:05:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:05:44 INFO - Running setup.py (path:/tmp/pip-a9rUfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:05:45 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)) 10:05:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:05:45 INFO - Running setup.py (path:/tmp/pip-2FVz01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:05:45 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)) 10:05:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:05:45 INFO - Running setup.py (path:/tmp/pip-72Rzp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:05:45 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)) 10:05:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:05:45 INFO - Running setup.py (path:/tmp/pip-RRqnZe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:05:45 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)) 10:05:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:05:45 INFO - Running setup.py (path:/tmp/pip-B9e9Kt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:05:45 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)) 10:05:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:05:45 INFO - Running setup.py (path:/tmp/pip-EKcuCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:05:45 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)) 10:05:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:05:45 INFO - Running setup.py (path:/tmp/pip-L3FUX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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)) 10:05:45 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:45 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:45 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 10:05:45 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 10:05:45 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 10:05:45 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 10:05:45 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 10:05:45 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 10:05:47 INFO - Downloading blessings-1.5.1.tar.gz 10:05:47 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 10:05:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:47 INFO - Installing collected packages: blessings 10:05:47 INFO - Running setup.py install for blessings 10:05:47 INFO - Successfully installed blessings 10:05:47 INFO - Cleaning up... 10:05:47 INFO - Return code: 0 10:05:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:05:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:05:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:05:47 INFO - Reading from file tmpfile_stdout 10:05:47 INFO - Current package versions: 10:05:47 INFO - argparse == 1.2.1 10:05:47 INFO - blessings == 1.5.1 10:05:47 INFO - blobuploader == 1.2.4 10:05:47 INFO - docopt == 0.6.1 10:05:47 INFO - manifestparser == 1.1 10:05:47 INFO - mozInstall == 1.12 10:05:47 INFO - mozcrash == 0.16 10:05:47 INFO - mozdebug == 0.1 10:05:47 INFO - mozdevice == 0.48 10:05:47 INFO - mozfile == 1.2 10:05:47 INFO - mozhttpd == 0.7 10:05:47 INFO - mozinfo == 0.9 10:05:47 INFO - mozleak == 0.1 10:05:47 INFO - mozlog == 3.1 10:05:47 INFO - moznetwork == 0.27 10:05:47 INFO - mozprocess == 0.22 10:05:47 INFO - mozprofile == 0.28 10:05:47 INFO - mozrunner == 6.11 10:05:47 INFO - mozscreenshot == 0.1 10:05:47 INFO - mozsystemmonitor == 0.0 10:05:47 INFO - moztest == 0.7 10:05:47 INFO - mozversion == 1.4 10:05:47 INFO - psutil == 3.1.1 10:05:47 INFO - requests == 1.2.3 10:05:47 INFO - wsgiref == 0.1.2 10:05:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:05:47 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')]} 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 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')]} 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:47 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 10:05:47 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 10:05:47 INFO - Using env: {'DISPLAY': ':0', 10:05:47 INFO - 'HOME': '/home/cltbld', 10:05:47 INFO - 'LANG': 'en_US.UTF-8', 10:05:47 INFO - 'LANGUAGE': 'en_US:en', 10:05:47 INFO - 'LOGNAME': 'cltbld', 10:05:47 INFO - 'MAIL': '/var/mail/cltbld', 10:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:47 INFO - 'MOZ_NO_REMOTE': '1', 10:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:47 INFO - 'NO_EM_RESTART': '1', 10:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:47 INFO - 'SHELL': '/bin/bash', 10:05:47 INFO - 'SHLVL': '1', 10:05:47 INFO - 'TERM': 'linux', 10:05:47 INFO - 'TMOUT': '86400', 10:05:47 INFO - 'USER': 'cltbld', 10:05:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:47 INFO - '_': '/tools/buildbot/bin/python'} 10:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 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)) 10:05:47 INFO - Cleaning up... 10:05:47 INFO - Return code: 0 10:05:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:05:47 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')]} 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 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')]} 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:47 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 10:05:47 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 10:05:47 INFO - Using env: {'DISPLAY': ':0', 10:05:47 INFO - 'HOME': '/home/cltbld', 10:05:47 INFO - 'LANG': 'en_US.UTF-8', 10:05:47 INFO - 'LANGUAGE': 'en_US:en', 10:05:47 INFO - 'LOGNAME': 'cltbld', 10:05:47 INFO - 'MAIL': '/var/mail/cltbld', 10:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:47 INFO - 'MOZ_NO_REMOTE': '1', 10:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:47 INFO - 'NO_EM_RESTART': '1', 10:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:47 INFO - 'SHELL': '/bin/bash', 10:05:47 INFO - 'SHLVL': '1', 10:05:47 INFO - 'TERM': 'linux', 10:05:47 INFO - 'TMOUT': '86400', 10:05:47 INFO - 'USER': 'cltbld', 10:05:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:47 INFO - '_': '/tools/buildbot/bin/python'} 10:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:48 INFO - Downloading/unpacking jsonschema 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:49 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 10:05:49 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:50 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:05:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:50 INFO - warning: no files found matching '*.txt' 10:05:50 INFO - no previously-included directories found matching 'build' 10:05:50 INFO - no previously-included directories found matching 'dist' 10:05:50 INFO - no previously-included directories found matching '.git*' 10:05:50 INFO - Installing collected packages: jsonschema, functools32 10:05:50 INFO - Running setup.py install for functools32 10:05:50 INFO - warning: no files found matching '*.txt' 10:05:50 INFO - no previously-included directories found matching 'build' 10:05:50 INFO - no previously-included directories found matching 'dist' 10:05:50 INFO - no previously-included directories found matching '.git*' 10:05:50 INFO - Successfully installed jsonschema functools32 10:05:50 INFO - Cleaning up... 10:05:50 INFO - Return code: 0 10:05:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:50 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 0x7f34772f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', '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 10:05:50 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 10:05:50 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 10:05:50 INFO - Using env: {'DISPLAY': ':0', 10:05:50 INFO - 'HOME': '/home/cltbld', 10:05:50 INFO - 'LANG': 'en_US.UTF-8', 10:05:50 INFO - 'LANGUAGE': 'en_US:en', 10:05:50 INFO - 'LOGNAME': 'cltbld', 10:05:50 INFO - 'MAIL': '/var/mail/cltbld', 10:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:50 INFO - 'MOZ_NO_REMOTE': '1', 10:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:50 INFO - 'NO_EM_RESTART': '1', 10:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:50 INFO - 'SHELL': '/bin/bash', 10:05:50 INFO - 'SHLVL': '1', 10:05:50 INFO - 'TERM': 'linux', 10:05:50 INFO - 'TMOUT': '86400', 10:05:50 INFO - 'USER': 'cltbld', 10:05:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:50 INFO - '_': '/tools/buildbot/bin/python'} 10:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:50 INFO - Downloading/unpacking flake8 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:52 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 10:05:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:52 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 10:05:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:05:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:52 INFO - no previously-included directories found matching 'docs/_build' 10:05:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:52 INFO - Running setup.py install for pep8 10:05:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:53 INFO - no previously-included directories found matching 'docs/_build' 10:05:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:05:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:53 INFO - Cleaning up... 10:05:53 INFO - Return code: 0 10:05:53 INFO - Running post-action listener: _resource_record_post_action 10:05:53 INFO - Running post-action listener: _start_resource_monitoring 10:05:53 INFO - Starting resource monitoring. 10:05:53 INFO - ##### 10:05:53 INFO - ##### Running install step. 10:05:53 INFO - ##### 10:05:53 INFO - Running pre-action listener: _resource_record_pre_action 10:05:53 INFO - Running main action method: install 10:05:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:05:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:05:53 INFO - Reading from file tmpfile_stdout 10:05:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:05:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:05:53 INFO - Reading from file tmpfile_stdout 10:05:53 INFO - Output received: 10:05:53 INFO - Usage: mozinstall [options] installer 10:05:53 INFO - Options: 10:05:53 INFO - -h, --help show this help message and exit 10:05:53 INFO - -d DEST, --destination=DEST 10:05:53 INFO - Directory to install application into. [default: 10:05:53 INFO - "/builds/slave/test-pgo"] 10:05:53 INFO - --app=APP Application being installed. [default: firefox] 10:05:53 INFO - mkdir: /builds/slave/test-pgo/build/application 10:05:53 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'] 10:05:53 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 10:06:09 INFO - Reading from file tmpfile_stdout 10:06:09 INFO - Output received: 10:06:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:06:09 INFO - Running post-action listener: _resource_record_post_action 10:06:09 INFO - ##### 10:06:09 INFO - ##### Running run-tests step. 10:06:09 INFO - ##### 10:06:09 INFO - Running pre-action listener: _resource_record_pre_action 10:06:09 INFO - Running main action method: run_tests 10:06:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:06:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:06:09 INFO - Python 2.7.3 10:06:09 INFO - Return code: 0 10:06:09 INFO - grabbing minidump binary from tooltool 10:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:09 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 0x2c59840>, '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 0x2bc66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:06:09 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 10:06:09 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 10:06:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:09 INFO - Return code: 0 10:06:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:06:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:06:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:06:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:06:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:06:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:06:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:06:10 INFO - Return code: 0 10:06:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:06:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:06:10 INFO - Using env: {'DISPLAY': ':0', 10:06:10 INFO - 'HOME': '/home/cltbld', 10:06:10 INFO - 'LANG': 'en_US.UTF-8', 10:06:10 INFO - 'LANGUAGE': 'en_US:en', 10:06:10 INFO - 'LOGNAME': 'cltbld', 10:06:10 INFO - 'MAIL': '/var/mail/cltbld', 10:06:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:06:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:10 INFO - 'MOZ_NO_REMOTE': '1', 10:06:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:10 INFO - 'NO_EM_RESTART': '1', 10:06:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:06:10 INFO - 'SHELL': '/bin/bash', 10:06:10 INFO - 'SHLVL': '1', 10:06:10 INFO - 'TERM': 'linux', 10:06:10 INFO - 'TMOUT': '86400', 10:06:10 INFO - 'USER': 'cltbld', 10:06:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913', 10:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:10 INFO - '_': '/tools/buildbot/bin/python'} 10:06:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:06:10 INFO - mozversion application_buildid: 20160114073313 10:06:10 INFO - mozversion application_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 10:06:10 INFO - mozversion application_display_name: Nightly 10:06:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:10 INFO - mozversion application_name: Firefox 10:06:10 INFO - mozversion application_remotingname: firefox 10:06:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:10 INFO - mozversion application_vendor: Mozilla 10:06:10 INFO - mozversion application_version: 46.0a1 10:06:10 INFO - mozversion platform_buildid: 20160114073313 10:06:10 INFO - mozversion platform_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 10:06:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:10 INFO - mozversion platform_version: 46.0a1 10:06:10 INFO - using testdate: 1452794770 10:06:10 INFO - actual date: 1452794770 10:06:10 INFO - starting webserver on 'localhost:41830' 10:06:10 INFO - SUITE-START | Running 3 tests 10:06:10 INFO - TEST-START | dromaeo_css 10:06:10 INFO - operating with platform_type : linux_ 10:06:10 INFO - Initialising browser for dromaeo_css test... 10:06:10 INFO - TEST-INFO | started process 26629 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6GKq42/profile http://localhost:41830/getInfo.html) 10:06:14 INFO - PROCESS | 26629 | 10:06:14 INFO - PROCESS | 26629 | (process:26713): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:06:15 INFO - PROCESS | 26629 | __metrics Screen width/height:1600/1200 10:06:15 INFO - PROCESS | 26629 | colorDepth:24 10:06:15 INFO - PROCESS | 26629 | Browser inner width/height: 1024/697 10:06:15 INFO - PROCESS | 26629 | __metrics 10:06:15 INFO - PROCESS | 26629 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:06:16 INFO - TEST-INFO | 26629: exit 0 10:06:16 INFO - Browser initialized. 10:06:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:16 INFO - TEST-INFO | started process 26762 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6GKq42/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:17 INFO - PROCESS | 26762 | 10:06:17 INFO - PROCESS | 26762 | (process:26821): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:06:27 INFO - PROCESS | 26762 | RSS: Main: 150577152 10:06:27 INFO - PROCESS | 26762 | 10:07:17 INFO - PROCESS | 26762 | 1452794837550 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] 10:09:25 INFO - PROCESS | 26762 | Cycle 1(1): loaded http://localhost:41830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41830/tests/dromaeo/cssquery-ext.html) 10:09:26 INFO - PROCESS | 26762 | RSS: Main: 156205056 10:09:26 INFO - PROCESS | 26762 | 10:12:28 INFO - PROCESS | 26762 | Cycle 1(1): loaded http://localhost:41830/tests/dromaeo/cssquery-ext.html (next: http://localhost:41830/tests/dromaeo/cssquery-jquery.html) 10:12:29 INFO - PROCESS | 26762 | RSS: Main: 151834624 10:12:29 INFO - PROCESS | 26762 | 10:15:31 INFO - PROCESS | 26762 | Cycle 1(1): loaded http://localhost:41830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41830/tests/dromaeo/cssquery-mootools.html) 10:15:31 INFO - PROCESS | 26762 | RSS: Main: 152920064 10:15:31 INFO - PROCESS | 26762 | 10:18:33 INFO - PROCESS | 26762 | Cycle 1(1): loaded http://localhost:41830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41830/tests/dromaeo/cssquery-prototype.html) 10:18:34 INFO - PROCESS | 26762 | RSS: Main: 150650880 10:18:34 INFO - PROCESS | 26762 | 10:21:36 INFO - PROCESS | 26762 | Cycle 1(1): loaded http://localhost:41830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41830/tests/dromaeo/cssquery-yui.html) 10:21:37 INFO - PROCESS | 26762 | RSS: Main: 150573056 10:21:37 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | Cycle 1(1): loaded http://localhost:41830/tests/dromaeo/cssquery-yui.html (next: http://localhost:41830/tests/dromaeo/cssquery-dojo.html) 10:24:39 INFO - PROCESS | 26762 | RSS: Main: 154132480 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | __start_tp_report 10:24:39 INFO - PROCESS | 26762 | _x_x_mozilla_page_load 10:24:39 INFO - PROCESS | 26762 | _x_x_mozilla_page_load_details 10:24:39 INFO - PROCESS | 26762 | |i|pagename|runs| 10:24:39 INFO - PROCESS | 26762 | |0;dojo.html;3138.3723255348928;3151.0704342219055;3180.6024246969127;3183.2041989502623;3193.5848339715835;4996.825111121111;5125.308083408739;5133.281340612312;5175.767090480928;5203.505666961642;5061.291419201315;5100.668456550322;5113.769880355384;5150.381954165496;5175.094358487259;4702.811887524504;4772.57046865782;4829.106615276168;4857.319975203474;4906.9263961040615;4722.716637001774;4810.39870016248;4841.370621819176;4895.804167833282;4926.162552366106;4590.357349971006;4712.246040633482;4778.450478195017;4790.616750659956;4864.416270047599;4671.532846715335;4720.763961801897;4729.101470720587;4742.07529531738;4745.098431298077;4716.292556116576;4727.125481785881;4737.73942433166;4756.167670657655;4778.259369797687;4851.27230915362;4981.078500477387;5038.2190760432195;5051.545360917498;5067.062593420193;5571.749271282802;5582.804601838957;5583.720813959327;5585.357683866367;5615.943840561583;5620.522255608278;5622.8313150605545;5628.324601047901;5631.60578759487;5645.774169033234;5112.156494178456;5163.845084647466;5195.896082078338;5252.133397989289;5310.601704872111;5623.550115990711;5634.60557760961;5636.60543761941;5649.152627105885;5659.773609055674;5436.184572314184;5452.372977107683;5470.863228419242;5489.64317319373;5513;5345;5412.78348866041;5521.944780552223;5605.971970140124;5625.015622266087;5510.669359838423;5518.806841760519;5523.199136125239;5525.889482210414;5529.0324193266015;5505.476979686923;5512.542582842957;5516.255305533782;5521.365043020024;5545.306836645419;4222.3244280914905;4268.061026574149;4329.350597410414;4380.970471939092;4408.052268762167;3852.075501879529;3852.614738526125;3869.2261547690573;3901.395283731026;3908.1988192420486;5130;5175.45657705943;5179.22311653255;5184.326037615086;5224.425313215544;5542.473465020817;5569.303837020372;5592.832215033555;5615.494605485526;5680.943190568124;5144.048351055067;5160.8967820643375;5166.4316925138955;5175.81884634036;5205.583553315726;4659.20793465105;4728.1962066448095;4731.668783185144;4737.45519265282;4748.264019077049;5812.534997200214;5816.389279125716;5827.35899051104;5840.8539786504825;5866.061430171152;5570.080936645408;5588.552915766811;5594.41258667834;5599.580031497735;5608.523275521627;5568.443155684399;5684.658920464785;5810.506106980785;5811.941880581309;5849.795257165979;5478.890422191614;5479.506844384025;5484.040292948798;5487.835364939058;5525.778968841362;5471.343438787212;5517.531009864207;5532.253145825262;5560.19377190297;5600.075987462186;5309.2301616266195;5363.115086010765;5391.973040134774;5424;5476.507114359727;5400.891982160256;5402.432744561765;5408;5420.078586640359;5452.809151679672;5289.6032797539565;5305.204219367126;5332.840014799563;5335.039692855324;5380.515753582196;5303.416624171261;5367.141257398797;5373.408925018323;5429.837104886859;5462.8361149165585;5284.365876094893;5314.734263286743;5323.0684630190335;5327.946720532745;5341.866453338697 10:24:39 INFO - PROCESS | 26762 | |1;ext.html;505.08831559035946;523.8553760034326;543.5515699547873;545.3646501825374;559.9356074051483;37891;38239.61760382395;38240.617593824056;38478.807605962;38693.80653096734;43150.352744708856;43574.56425435745;43597.7820110899;43649;43902;8549.487030778142;8666.176713212266;8712.172343627346;8752.562371881413;8773.7806554836;8486.872696909551;8672.089430609789;8674.696385626505;8709.912900871006;8732.825343493158;8710.172533609297;8767.956160219223;8776.429532080427;8788.956055219714;8800;8631.784205394853;8645.740627781177;8703.43427677199;8712.782180445476;8719.389642725011;8575.571221438902;8641.30869530436;8665.696700615448;8714.825703485958;8716.738497845012;39317.60682393168;39593.80203098966;39647.8017609913;39660;39741.602583974076;3422.9657703422895;3446.724262059029;3514.0512061743443;3773.52830896138;3919.8824035278985;30078.54882176769;30539.23651908698;30614;30794.23014424635;30920;3825.3879379299456;3918.686505079587;3964.6431821136234;4082.5917408259234;4111.342185250345;269179;270837.999999998;271093;271357;271465;48793.51206487961;55305;56213.437865621636;56287.43712562822;56407.333523320856;44354.77822610866;59744.40255597388;59871.700641496514;60786;60837.391626083176;14251.073680210753;14268.714625707635;14281.857181428053;14283;14357.856421435861;10509.106725928228;10510.421926794099;10535.525901334458;10550.944905509541;10618.522166502526;18260.178291976892;18388.448346549623;18569.350072747387;18574;19217.213504041836;7007.684654190573;7509;7682.001339825899;7715.614219289013;7737.49706269102;967.8064387122604;991.613270824379;1006.713086770267;1023.959041638341;1126.1722633864103;27693.584596231074;28193.43613127726;28398.71601284002;28557.714422855923;28585.142445726662;1029.902159294866;1035.8290882004535;1037.180627304436;1123.4775829239443;1132.767782604564;15451.304691288919;15552.455664051704;16138.67722645564;16239.756403653955;16372;281538;284358;286592;286804;286839;52318.21522677163;52730.73634631802;52951;53149;53265.2010219847;1342.664333916521;1343.1538130977617;1364.34511434512;1370.095736813698;1409.7734970575664;25119.497610047332;27687.169384918485;27848;27976.44047119087;28187.295317617223;45223.547764521936;45236.321455178855;45361.319580205665;45475;45659;301544;303057;304903;305615;306480;32504.34991300208;42969;43060.35409468798;43882.92819502732;44085.559144408144;38663.226735465694;38945.41581876217;39368;39478.40782388324;39881.800590996856;35393.29213415769;35860.82069589636;36197.27605447929;36366.454503183006;36438;35587.644123558435;36605.81697091497;36652.26695466129;36939.81530092332;36969.6303036977;35287.82356088306;36733.81633091818;36878.26243475169;37030.44454333241;37056.25887482181;29293;32711.509327359632;32996.34007319888;33078.834605826814;33400.83299583486;22567.58038982644;22684.432889177904;22833.88583057074;22835.08659653595;23006.539869202858 10:24:39 INFO - PROCESS | 26762 | |2;jquery.html;352.0968715245394;352.17942194686384;360.1464529066112;361.92580520993215;362.8403502458919;15994.84005159948;16464;16734.330626774943;17284.395046173388;17351.219195136247;15856.762148567752;15865.84134158658;16081.597960051005;16323.59191020225;16393.83606163938;4861.854144375666;5048.545630893219;5050.090983622947;5050.671706339094;5051.848444546651;4894.070126675938;4922.26166075088;4927.162382395001;4985.850424487253;5002.674826136289;4979.950200498003;4991.975040124794;4997.550220480156;5153.613478989072;5162.6128040397125;5069.898602027957;5085.084684756761;5096.694198348111;5127.384713834326;5655.4910058094965;5427.83716488506;5440.401555828856;5441.727913604304;5446.482584154499;5456.099743542351;12692.30192339421;13919.373628186755;16703.331866725315;19844.90077549603;19866.90066549658;2076.086521930346;2108.5677436125557;2166.9783302166934;2194.9451263718374;2298.2645553422913;6757.087793147961;8787.912120878837;9493.572789224501;9495.620175192984;9656.372335798222;1813.4740925131696;1813.8095499972576;1826.0960824391877;1847.178005787425;1895.4313705888178;52031.47968520304;53589.928201436145;55843;56282;56309.71845140789;9661.613535458644;9963.103320701026;10080.798384032278;10167.186625069977;10172.796544069226;13148.276844773629;13176.934115329363;13211.273379964003;13211.735765284833;13378.799318010238;7333.303336183054;7375.01749055504;7377.741779037815;7410.96294518524;7419;6975.755848545276;6999.37005669482;7031.472639552054;7041.647917604202;7041.718331266795;4314.288142456459;4390.429244198298;4391.385206071152;4409.4488188976375;4437.134758722018;1672.4230140601474;1794.7397627344224;1849.5745978425039;1881.689521228982;1888.5845114074882;425.29613489674637;860.9612567434481;955.1403736636944;962.451402700454;983.0218932162401;10254.333468324536;10789;10925.344479331265;11034.724131896606;11094.445277736242;442;454.9476810166807;455.703792534855;467.42506716738603;474.926386410107;5565.387807341189;5638.577106717013;5949.9107513387335;6007.639541627516;6083.5741498095595;490832;498797;499387;515362;517192;69954.3004569958;70647.29352706509;72646;72911;74648.62675686587;471.4272159326435;475.5221002892071;475.81443237137546;475.9547842954914;477.91158635652516;9854.310198286052;9928.801423971336;9945.900540994497;10182.134518566005;10197.74505637365;29146;29842.850785745934;30666.233344166576;30982.53526197064;31569.21076973094;41606;42505;42649;43892.78053609839;44893.326600101675;6036.004059330161;7404.296591823768;7500.587467689329;7517.699292028257;7552.282533159341;9948.651797187063;10598.735031624272;10718.517666704862;10832.24174307791;11241.494132764208;8699.43453675509;8896.288296936358;9113.954430227806;9315.487648179414;9536.141747242782;9230.307726920373;9424.81150376975;9787.16809071237;9795.216382689225;10028.64899728506;9529.666461674085;9700.223982081558;9793.65722199748;9847.162991145546;10131.544080516247;7524.661390237343;7676.347510461674;7680.462367634212;7686.730964416219;7706.422018348759;7339.59632220233;9037.548122593975;9211.585478653342;9233.722988310361;9237.815243695222 10:24:39 INFO - PROCESS | 26762 | |3;mootools.html;1435.239323158726;1489.3893503663496;1633.5344426838346;1771.3800169940514;1793.0586442117894;7803.258690424408;7850.96074519628;8012.719554815582;8040.075391329999;8069.233422824829;8229.958850205756;8233.259006689397;8311;8320.084790673036;8347.749567512968;2362.9291121266388;2381.714194296687;2382.7855493005627;2388.976110238893;2397.580423425902;2353.4234112642425;2368.27767530903;2383.7616238376195;2389.7968672662846;2392.031227352925;2264.6036943534896;2321.9535609287805;2329.24299602629;2349.788519033287;2367.6685264063044;2290.8167346612313;2316.872572008539;2319.675245465636;2321.721393432799;2326.4765427778784;2328.429534763977;2351.3298709867604;2353.599888019041;2354.2701762453694;2358.858468491896;8159.592020398956;8190.4266701330935;8219.260266575977;8225.259726624572;8242.340612750966;4735.289706544046;4862.975685121587;4876.439209490918;4876.975615121902;4902.093112774148;3049.9542506862413;3069.877204911801;3189;3208.855601497915;3218.243712727507;1038.3665963762098;1044.660485342259;1054.8417737339385;1056.240063593011;1096.2107282756403;11118.722031949184;11306.038986686142;11321.999999999918;11339;11375.488103035383;4093.836246550164;4175;4290.699651024398;4302.26861433557;4325.545817689097;9109.40788848736;9168.404053736485;9171.77070573241;9179.357444978921;9179.954100229455;4758.643101767381;4787;4788.880277993008;4794.513700752777;4805.4233491980485;4384.714993525411;4396.032872767986;4397.648188144941;4405.691601587922;4438.955610443854;3485.3029394121277;3545.982270088633;3548.8048157351595;3555.7333200010103;3567.6432356764117;1063.984040239397;1080.4117946618458;1085.2294870641933;1087.7443800706828;1139.8518192634904;1236.7650146472142;1237.9071569632313;1276.6106337566946;1285.7299967007034;1295.106376600143;6976.058232138596;7045.68294426752;7080.504364694422;7099.148102227662;7103.857922841515;1096.6709987004026;1105.3147048829776;1111.727626731456;1113.276370359273;1132.8130858408435;5611.382747897728;5732.369439361667;5779.0464573344925;5802.82591522255;5839.562032847553;9680.903190968142;9797.265205109645;10045.397276163454;10137.64518241858;10141.543630536644;9786.070323319273;9900.950495247478;9930;9949.55227014786;9965.950170249102;7236.963815180996;7387.593682347522;7459.8508029839095;7467.887981680279;7596.278353556514;7229.674664639999;7253.093363329584;7296.452766042674;7301.561906285639;7354.970304157315;8628.697995570124;8694.43486173422;8779.956100219713;8789.780255493664;8969.372143950122;8895.73312800617;8900.73297801067;8938.910610893809;8943.060978597154;9008.099190080939;7121.4302855770375;7147.82130446743;7153.749618763319;7178.28217178278;7191.7842464726145;7201.891971620325;7373.668184931584;7423.8144046399275;7424.257574242532;7426.74006409773;6536.3136870629805;6540.50946179029;6974.128233970754;7027.15674119109;7106.076210092655;6016.608920420159;6059.151718759289;6078.787242446493;6157.722902469489;6245.594036387621;6355;6375.4262116409745;6379.298277189599;6386.872262554816;6390.48876089921;5683.7442315095095;5693.345265294544;5712.571557133315;5720.628159169641;5721.199032135588;6010;6052.364501727431;6067.605605635619;6072.574919755752;6100.6949652516305 10:24:39 INFO - PROCESS | 26762 | |4;prototype.html;332.46971081125605;338.48550203690394;345.16986647113686;346.26418859922666;350.714167953118;6204.503639708823;6251;6251.062340648905;6281.183446151994;6297.905531417021;5997.6701281429505;6103.60326578772;6108.969455152729;6116.388361163881;6138.8465288367815;4686.835960741375;4687.718736875799;4731.645126615509;4741.691790033654;4745.92881106782;4736.171170045245;4748.453927798296;4751.596114330286;4754.762261886909;4763.285507173934;4648.588269320921;4665.790039448233;4718.669693121483;4722.693024953367;4731.455882573514;4710.811567537295;4717.457492388385;4724.669273150898;4725.598324142452;4733.029728905601;4151.958480415187;4156.792160391999;4160.209560183555;4161.9583804161875;4167.187398457302;5822.214001109881;5824.213731146283;5826.912596311059;5826.9708651456895;5838.854028649275;5355.705436201008;5466.262054622614;5518.365387980393;5526.253955716007;5533.253010843525;6615.503837212228;6627.635480048595;6631.204255489324;6637;6639.3692599203;4573.49691533931;4577.33628623851;4578.610818080467;4578.931316030262;4580.129775342708;6784.185897692309;6847.281035491302;6873.278305777922;6882.655867206619;6918.93081069193;4654.394928659252;4660.091282199938;4661.813527458864;4665.230237010923;4685.648576356787;4737.928931066037;4750.881227969259;4754.548317909793;4759.738214398241;4761.642876784255;5484.91772623411;5492.670439773627;5493.038718224295;5503.229547863302;5507.366652834895;6510.381513756186;6647.933520664828;6669.799906002828;6743.797686069426;6744.426723728538;1628.2835552356926;1644.8519633232827;1664.076437577132;1667.1247595012715;1669.4323929863904;1091.4433638844246;1100.5872797700863;1101.1191047162238;1113.8997490225918;1122.7313136156092;6206.565540412218;6261.154744109578;6273.18448601688;6277.246730392382;6290.119383286344;6765.391114799691;6777.6272305023695;6779.389854913082;6779.694913728894;6790.32096790317;6114.991026480581;6193.6903154842075;6255.311915689271;6259.405356491126;6267.6866156691985;3683.797391143459;3691.1694868654877;3692.316921369555;3692.833822477995;3696.1129328960856;7128.465365097639;7147.392471639865;7148.714051437884;7152.713891444388;7157.821054473679;6834.624095674786;6983.965080174668;6998.370146686822;6998.965005174941;7001.894971575431;7091.078159839291;7137.357637812622;7138.892916606255;7147.785566433015;7150.606716630636;6688.665566721547;6707.228668703162;6717.1267735194115;6723.125993620798;6764.932350676627;6613.867722645424;6661.1007513985;6697.698603562754;6737.3599508046655;6745.392914637706;7119;7121.928780712126;7126.85746285061;7135.036770036187;7142.5000249982;4644.953550464587;4650.627949764078;4665.066986602626;4670.579647831712;4671.8364857229835;6744.8651026978205;6785.287544807724;6785.93214067853;6791.558548694319;6935.89596156048;6705.899411508929;6718;6738.797836064926;6746.595204287562;6772.221194562491;6697.028930805103;6707.832304192434;6712.127423434922;6724.29394913527;6739.797806065826;6431.678416079084;6570.244421891352;6576.868462630625;6583.901241481286;6602.108715323562;6705.765298214539;6713.56361836479;6749.156355455568;6753.257141714505;6762.289959554373;6589.27517973013;6592.736290548324;6598.670066496752;6601.867962640817;6602.735890564323 10:24:39 INFO - PROCESS | 26762 | |5;yui.html;704.3695892176502;800.3557136505112;811.5617566514082;821.1008945205002;831.6922738586716;11434.485448154832;11766.176367654267;12547.435365408555;12709.936450317735;12808.423620937057;13838.100523465968;13953.651158721037;14057.718845623082;14077.859221407783;14210.07634503759;768.7040489411589;773.9226077392273;777.4402430250211;779.4660657449637;781.9804504887367;782.5500337306044;788.329919568368;789.1831953927687;789.7354386280603;790.8971833661616;818.6193420059672;820.1306614988102;824.4805772363403;826.5701835045772;830.1325115254543;819.700809204639;823.7775800533852;824.3775949158407;825.0347093900122;827.420805436197;602.713710987282;607.7295603456464;608.3399511529996;608.9391060893876;610.7190692281556;12727.109102362838;12752.2986235757;12786.424610892533;12800.48798048077;12801.615951521377;11704.941475292655;12358.814617780741;12368.938155309166;12432.564860229939;12532.624021279376;9879.259055570788;9902.504874756234;9952.90047099527;9957.502124893726;9990.150837178848;3497.9475307870403;3550;3555.7510974231814;3561.4301711726257;3562.3765840977985;44206;44473.665790026025;47755.28367074497;48392;48584.514154858705;9224.907750922539;9423.528823558794;9475.76310592227;9516.809663806685;9638.373505722106;17723.82276177222;17898.821011789976;17995.280188792563;17999.64000719978;18006.819931800514;7367.300106489874;7434.405247580181;7463.664135113824;7504.58724770132;7548.433867459962;4154.335306350969;4249.830006799755;4264.104538047045;4268.530461649216;4279.743215407086;3061.831599262062;3094.241910731885;3096.1330827368374;3107.8446077696026;3139.3250451153112;578.1414599320007;585.7686213945468;586.5923183387505;601.1223613524216;604.9758009679651;466.2121015483821;528.289450688823;528.9632320651489;609.4058293164218;700.9940735045226;7961.641726122339;9163.77090572741;9418.387804792666;9484.33609647318;9555.522223888778;648.1800522339245;650.4893658478072;652.709544252803;661.7683810666229;667.813012356541;3828.712846536521;3914.3541315683165;3915.686745060388;3936.6653834424396;4063.2686116499312;54491;55243.72378138084;55374.169387459224;55591.722041389534;55679.72160139254;50916.74541627268;51157.48842511602;51332;52097.21854172191;52102.73948630233;42444;42821.143577128285;43016;45397;45887.54112458833;8962.820743584962;9198.402103863227;9402.106799854002;9436.480993545421;9444.574994125418;33036.33927321488;33168;35485;36313.81843090873;36554.451683224244;43385.132297353244;43619.56380436282;43633.56366436295;44158.11683766243;44511.33233001572;10682.73293167677;10686.198535110054;11107.166962478008;11138.10895128404;11396.430178490877;11375.715607109558;11713.297202167898;11837.644870653894;11855;12282.201656892274;11084.390358530358;11676.182667213214;11792.23350482216;11882.10884183707;12105.273683579013;11057.889421105687;11513.827292590451;11582.420878956187;11606.361650108987;11722.882771172179;10785.946070269598;11211.159163062966;11220.062993997793;11240.718982025188;11268.83096753533;9302.16280534755;9308.44149351041;9340.252779777737;9478.431294122374;9645;9109.908900910907;9257.953710231406;9431.528423578931;9541.522923853918;9799.363041402286 10:24:39 INFO - PROCESS | 26762 | __end_tp_report 10:24:39 INFO - PROCESS | 26762 | __start_cc_report 10:24:39 INFO - PROCESS | 26762 | _x_x_mozilla_cycle_collect,304 10:24:39 INFO - PROCESS | 26762 | __end_cc_report 10:24:39 INFO - PROCESS | 26762 | __startTimestamp1452795879695__endTimestamp 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | ------- Summary: start ------- 10:24:39 INFO - PROCESS | 26762 | Number of tests: 6 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | [#0] dojo.html Cycles:165 Average:5159.75 Median:5327.95 stddev:556.01 (10.4%) stddev-sans-first:534.62 10:24:39 INFO - PROCESS | 26762 | Values: 3138.4 3151.1 3180.6 3183.2 3193.6 4996.8 5125.3 5133.3 5175.8 5203.5 5061.3 5100.7 5113.8 5150.4 5175.1 4702.8 4772.6 4829.1 4857.3 4906.9 4722.7 4810.4 4841.4 4895.8 4926.2 4590.4 4712.2 4778.5 4790.6 4864.4 4671.5 4720.8 4729.1 4742.1 4745.1 4716.3 4727.1 4737.7 4756.2 4778.3 4851.3 4981.1 5038.2 5051.5 5067.1 5571.7 5582.8 5583.7 5585.4 5615.9 5620.5 5622.8 5628.3 5631.6 5645.8 5112.2 5163.8 5195.9 5252.1 5310.6 5623.6 5634.6 5636.6 5649.2 5659.8 5436.2 5452.4 5470.9 5489.6 5513.0 5345.0 5412.8 5521.9 5606.0 5625.0 5510.7 5518.8 5523.2 5525.9 5529.0 5505.5 5512.5 5516.3 5521.4 5545.3 4222.3 4268.1 4329.4 4381.0 4408.1 3852.1 3852.6 3869.2 3901.4 3908.2 5130.0 5175.5 5179.2 5184.3 5224.4 5542.5 5569.3 5592.8 5615.5 5680.9 5144.0 5160.9 5166.4 5175.8 5205.6 4659.2 4728.2 4731.7 4737.5 4748.3 5812.5 5816.4 5827.4 5840.9 5866.1 5570.1 5588.6 5594.4 5599.6 5608.5 5568.4 5684.7 5810.5 5811.9 5849.8 5478.9 5479.5 5484.0 5487.8 5525.8 5471.3 5517.5 5532.3 5560.2 5600.1 5309.2 5363.1 5392.0 5424.0 5476.5 5400.9 5402.4 5408.0 5420.1 5452.8 5289.6 5305.2 5332.8 5335.0 5380.5 5303.4 5367.1 5373.4 5429.8 5462.8 5284.4 5314.7 5323.1 5327.9 5341.9 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | [#1] ext.html Cycles:180 Average:45690.53 Median:37043.35 stddev:74912.56 (202.2%) stddev-sans-first:75045.88 10:24:39 INFO - PROCESS | 26762 | Values: 505.1 523.9 543.6 545.4 559.9 37891.0 38239.6 38240.6 38478.8 38693.8 43150.4 43574.6 43597.8 43649.0 43902.0 8549.5 8666.2 8712.2 8752.6 8773.8 8486.9 8672.1 8674.7 8709.9 8732.8 8710.2 8768.0 8776.4 8789.0 8800.0 8631.8 8645.7 8703.4 8712.8 8719.4 8575.6 8641.3 8665.7 8714.8 8716.7 39317.6 39593.8 39647.8 39660.0 39741.6 3423.0 3446.7 3514.1 3773.5 3919.9 30078.5 30539.2 30614.0 30794.2 30920.0 3825.4 3918.7 3964.6 4082.6 4111.3 269179.0 270838.0 271093.0 271357.0 271465.0 48793.5 55305.0 56213.4 56287.4 56407.3 44354.8 59744.4 59871.7 60786.0 60837.4 14251.1 14268.7 14281.9 14283.0 14357.9 10509.1 10510.4 10535.5 10550.9 10618.5 18260.2 18388.4 18569.4 18574.0 19217.2 7007.7 7509.0 7682.0 7715.6 7737.5 967.8 991.6 1006.7 1024.0 1126.2 27693.6 28193.4 28398.7 28557.7 28585.1 1029.9 1035.8 1037.2 1123.5 1132.8 15451.3 15552.5 16138.7 16239.8 16372.0 281538.0 284358.0 286592.0 286804.0 286839.0 52318.2 52730.7 52951.0 53149.0 53265.2 1342.7 1343.2 1364.3 1370.1 1409.8 25119.5 27687.2 27848.0 27976.4 28187.3 45223.5 45236.3 45361.3 45475.0 45659.0 301544.0 303057.0 304903.0 305615.0 306480.0 32504.3 42969.0 43060.4 43882.9 44085.6 38663.2 38945.4 39368.0 39478.4 39881.8 35393.3 35860.8 36197.3 36366.5 36438.0 35587.6 36605.8 36652.3 36939.8 36969.6 35287.8 36733.8 36878.3 37030.4 37056.3 29293.0 32711.5 32996.3 33078.8 33400.8 22567.6 22684.4 22833.9 22835.1 23006.5 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | [#2] jquery.html Cycles:180 Average:25788.59 Median:252189.49 stddev:82518.79 (32.7%) stddev-sans-first:82728.17 10:24:39 INFO - PROCESS | 26762 | Values: 352.1 352.2 360.1 361.9 362.8 15994.8 16464.0 16734.3 17284.4 17351.2 15856.8 15865.8 16081.6 16323.6 16393.8 4861.9 5048.5 5050.1 5050.7 5051.8 4894.1 4922.3 4927.2 4985.9 5002.7 4980.0 4992.0 4997.6 5153.6 5162.6 5069.9 5085.1 5096.7 5127.4 5655.5 5427.8 5440.4 5441.7 5446.5 5456.1 12692.3 13919.4 16703.3 19844.9 19866.9 2076.1 2108.6 2167.0 2194.9 2298.3 6757.1 8787.9 9493.6 9495.6 9656.4 1813.5 1813.8 1826.1 1847.2 1895.4 52031.5 53589.9 55843.0 56282.0 56309.7 9661.6 9963.1 10080.8 10167.2 10172.8 13148.3 13176.9 13211.3 13211.7 13378.8 7333.3 7375.0 7377.7 7411.0 7419.0 6975.8 6999.4 7031.5 7041.6 7041.7 4314.3 4390.4 4391.4 4409.4 4437.1 1672.4 1794.7 1849.6 1881.7 1888.6 425.3 861.0 955.1 962.5 983.0 10254.3 10789.0 10925.3 11034.7 11094.4 442.0 454.9 455.7 467.4 474.9 5565.4 5638.6 5949.9 6007.6 6083.6 490832.0 498797.0 499387.0 515362.0 517192.0 69954.3 70647.3 72646.0 72911.0 74648.6 471.4 475.5 475.8 476.0 477.9 9854.3 9928.8 9945.9 10182.1 10197.7 29146.0 29842.9 30666.2 30982.5 31569.2 41606.0 42505.0 42649.0 43892.8 44893.3 6036.0 7404.3 7500.6 7517.7 7552.3 9948.7 10598.7 10718.5 10832.2 11241.5 8699.4 8896.3 9114.0 9315.5 9536.1 9230.3 9424.8 9787.2 9795.2 10028.6 9529.7 9700.2 9793.7 9847.2 10131.5 7524.7 7676.3 7680.5 7686.7 7706.4 7339.6 9037.5 9211.6 9233.7 9237.8 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | [#3] mootools.html Cycles:180 Average:5514.05 Median:5702.96 stddev:2910.05 (51.0%) stddev-sans-first:2902.07 10:24:39 INFO - PROCESS | 26762 | Values: 1435.2 1489.4 1633.5 1771.4 1793.1 7803.3 7851.0 8012.7 8040.1 8069.2 8230.0 8233.3 8311.0 8320.1 8347.7 2362.9 2381.7 2382.8 2389.0 2397.6 2353.4 2368.3 2383.8 2389.8 2392.0 2264.6 2322.0 2329.2 2349.8 2367.7 2290.8 2316.9 2319.7 2321.7 2326.5 2328.4 2351.3 2353.6 2354.3 2358.9 8159.6 8190.4 8219.3 8225.3 8242.3 4735.3 4863.0 4876.4 4877.0 4902.1 3050.0 3069.9 3189.0 3208.9 3218.2 1038.4 1044.7 1054.8 1056.2 1096.2 11118.7 11306.0 11322.0 11339.0 11375.5 4093.8 4175.0 4290.7 4302.3 4325.5 9109.4 9168.4 9171.8 9179.4 9180.0 4758.6 4787.0 4788.9 4794.5 4805.4 4384.7 4396.0 4397.6 4405.7 4439.0 3485.3 3546.0 3548.8 3555.7 3567.6 1064.0 1080.4 1085.2 1087.7 1139.9 1236.8 1237.9 1276.6 1285.7 1295.1 6976.1 7045.7 7080.5 7099.1 7103.9 1096.7 1105.3 1111.7 1113.3 1132.8 5611.4 5732.4 5779.0 5802.8 5839.6 9680.9 9797.3 10045.4 10137.6 10141.5 9786.1 9901.0 9930.0 9949.6 9966.0 7237.0 7387.6 7459.9 7467.9 7596.3 7229.7 7253.1 7296.5 7301.6 7355.0 8628.7 8694.4 8780.0 8789.8 8969.4 8895.7 8900.7 8938.9 8943.1 9008.1 7121.4 7147.8 7153.7 7178.3 7191.8 7201.9 7373.7 7423.8 7424.3 7426.7 6536.3 6540.5 6974.1 7027.2 7106.1 6016.6 6059.2 6078.8 6157.7 6245.6 6355.0 6375.4 6379.3 6386.9 6390.5 5683.7 5693.3 5712.6 5720.6 5721.2 6010.0 6052.4 6067.6 6072.6 6100.7 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | [#4] prototype.html Cycles:180 Average:5527.77 Median:6253.19 stddev:1678.79 (26.8%) stddev-sans-first:1637.59 10:24:39 INFO - PROCESS | 26762 | Values: 332.5 338.5 345.2 346.3 350.7 6204.5 6251.0 6251.1 6281.2 6297.9 5997.7 6103.6 6109.0 6116.4 6138.8 4686.8 4687.7 4731.6 4741.7 4745.9 4736.2 4748.5 4751.6 4754.8 4763.3 4648.6 4665.8 4718.7 4722.7 4731.5 4710.8 4717.5 4724.7 4725.6 4733.0 4152.0 4156.8 4160.2 4162.0 4167.2 5822.2 5824.2 5826.9 5827.0 5838.9 5355.7 5466.3 5518.4 5526.3 5533.3 6615.5 6627.6 6631.2 6637.0 6639.4 4573.5 4577.3 4578.6 4578.9 4580.1 6784.2 6847.3 6873.3 6882.7 6918.9 4654.4 4660.1 4661.8 4665.2 4685.6 4737.9 4750.9 4754.5 4759.7 4761.6 5484.9 5492.7 5493.0 5503.2 5507.4 6510.4 6647.9 6669.8 6743.8 6744.4 1628.3 1644.9 1664.1 1667.1 1669.4 1091.4 1100.6 1101.1 1113.9 1122.7 6206.6 6261.2 6273.2 6277.2 6290.1 6765.4 6777.6 6779.4 6779.7 6790.3 6115.0 6193.7 6255.3 6259.4 6267.7 3683.8 3691.2 3692.3 3692.8 3696.1 7128.5 7147.4 7148.7 7152.7 7157.8 6834.6 6984.0 6998.4 6999.0 7001.9 7091.1 7137.4 7138.9 7147.8 7150.6 6688.7 6707.2 6717.1 6723.1 6764.9 6613.9 6661.1 6697.7 6737.4 6745.4 7119.0 7121.9 7126.9 7135.0 7142.5 4645.0 4650.6 4665.1 4670.6 4671.8 6744.9 6785.3 6785.9 6791.6 6935.9 6705.9 6718.0 6738.8 6746.6 6772.2 6697.0 6707.8 6712.1 6724.3 6739.8 6431.7 6570.2 6576.9 6583.9 6602.1 6705.8 6713.6 6749.2 6753.3 6762.3 6589.3 6592.7 6598.7 6601.9 6602.7 10:24:39 INFO - PROCESS | 26762 | 10:24:39 INFO - PROCESS | 26762 | [#5] yui.html Cycles:180 Average:13553.97 Median:49750.63 stddev:15538.63 (31.2%) stddev-sans-first:15552.26 10:24:39 INFO - PROCESS | 26762 | Values: 704.4 800.4 811.6 821.1 831.7 11434.5 11766.2 12547.4 12709.9 12808.4 13838.1 13953.7 14057.7 14077.9 14210.1 768.7 773.9 777.4 779.5 782.0 782.6 788.3 789.2 789.7 790.9 818.6 820.1 824.5 826.6 830.1 819.7 823.8 824.4 825.0 827.4 602.7 607.7 608.3 608.9 610.7 12727.1 12752.3 12786.4 12800.5 12801.6 11704.9 12358.8 12368.9 12432.6 12532.6 9879.3 9902.5 9952.9 9957.5 9990.2 3497.9 3550.0 3555.8 3561.4 3562.4 44206.0 44473.7 47755.3 48392.0 48584.5 9224.9 9423.5 9475.8 9516.8 9638.4 17723.8 17898.8 17995.3 17999.6 18006.8 7367.3 7434.4 7463.7 7504.6 7548.4 4154.3 4249.8 4264.1 4268.5 4279.7 3061.8 3094.2 3096.1 3107.8 3139.3 578.1 585.8 586.6 601.1 605.0 466.2 528.3 529.0 609.4 701.0 7961.6 9163.8 9418.4 9484.3 9555.5 648.2 650.5 652.7 661.8 667.8 3828.7 3914.4 3915.7 3936.7 4063.3 54491.0 55243.7 55374.2 55591.7 55679.7 50916.7 51157.5 51332.0 52097.2 52102.7 42444.0 42821.1 43016.0 45397.0 45887.5 8962.8 9198.4 9402.1 9436.5 9444.6 33036.3 33168.0 35485.0 36313.8 36554.5 43385.1 43619.6 43633.6 44158.1 44511.3 10682.7 10686.2 11107.2 11138.1 11396.4 11375.7 11713.3 11837.6 11855.0 12282.2 11084.4 11676.2 11792.2 11882.1 12105.3 11057.9 11513.8 11582.4 11606.4 11722.9 10785.9 11211.2 11220.1 11240.7 11268.8 9302.2 9308.4 9340.3 9478.4 9645.0 9109.9 9258.0 9431.5 9541.5 9799.4 10:24:39 INFO - PROCESS | 26762 | -------- Summary: end -------- 10:24:39 INFO - PROCESS | 26762 | 10:24:40 INFO - TEST-INFO | 26762: exit 0 10:24:40 INFO - TEST-OK | dromaeo_css | took 1109651ms 10:24:40 INFO - TEST-START | kraken 10:24:40 INFO - operating with platform_type : linux_ 10:24:40 INFO - Initialising browser for kraken test... 10:24:40 INFO - TEST-INFO | started process 27005 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi_kZfA/profile http://localhost:41830/getInfo.html) 10:24:43 INFO - PROCESS | 27005 | 10:24:43 INFO - PROCESS | 27005 | (process:27075): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:24:44 INFO - PROCESS | 27005 | __metrics Screen width/height:1600/1200 10:24:44 INFO - PROCESS | 27005 | colorDepth:24 10:24:44 INFO - PROCESS | 27005 | Browser inner width/height: 1024/697 10:24:44 INFO - PROCESS | 27005 | __metrics 10:24:44 INFO - PROCESS | 27005 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:24:45 INFO - TEST-INFO | 27005: exit 0 10:24:45 INFO - Browser initialized. 10:24:45 INFO - Running cycle 1/1 for kraken test... 10:24:45 INFO - TEST-INFO | started process 27124 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi_kZfA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:46 INFO - PROCESS | 27124 | 10:24:46 INFO - PROCESS | 27124 | (process:27183): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:24:57 INFO - PROCESS | 27124 | RSS: Main: 150978560 10:24:57 INFO - PROCESS | 27124 | 10:24:59 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41830/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:00 INFO - PROCESS | 27124 | RSS: Main: 150781952 10:25:00 INFO - PROCESS | 27124 | 10:25:03 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41830/tests/kraken/driver.html?testName=audio-dft) 10:25:03 INFO - PROCESS | 27124 | RSS: Main: 155070464 10:25:03 INFO - PROCESS | 27124 | 10:25:06 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41830/tests/kraken/driver.html?testName=audio-fft) 10:25:07 INFO - PROCESS | 27124 | RSS: Main: 147537920 10:25:07 INFO - PROCESS | 27124 | 10:25:09 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41830/tests/kraken/driver.html?testName=audio-oscillator) 10:25:09 INFO - PROCESS | 27124 | RSS: Main: 148500480 10:25:09 INFO - PROCESS | 27124 | 10:25:12 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:12 INFO - PROCESS | 27124 | RSS: Main: 148926464 10:25:12 INFO - PROCESS | 27124 | 10:25:15 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41830/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:16 INFO - PROCESS | 27124 | RSS: Main: 148865024 10:25:16 INFO - PROCESS | 27124 | 10:25:19 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41830/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:20 INFO - PROCESS | 27124 | RSS: Main: 149553152 10:25:20 INFO - PROCESS | 27124 | 10:25:22 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41830/tests/kraken/driver.html?testName=json-parse-financial) 10:25:23 INFO - PROCESS | 27124 | RSS: Main: 150048768 10:25:23 INFO - PROCESS | 27124 | 10:25:25 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:25 INFO - PROCESS | 27124 | RSS: Main: 151027712 10:25:25 INFO - PROCESS | 27124 | 10:25:27 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:28 INFO - PROCESS | 27124 | RSS: Main: 149454848 10:25:28 INFO - PROCESS | 27124 | 10:25:30 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:30 INFO - PROCESS | 27124 | RSS: Main: 149811200 10:25:30 INFO - PROCESS | 27124 | 10:25:33 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:33 INFO - PROCESS | 27124 | RSS: Main: 150540288 10:25:33 INFO - PROCESS | 27124 | 10:25:36 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:36 INFO - PROCESS | 27124 | RSS: Main: 150671360 10:25:36 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | Cycle 1(1): loaded http://localhost:41830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41830/tests/kraken/driver.html?testName=ai-astar) 10:25:38 INFO - PROCESS | 27124 | RSS: Main: 149790720 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | __start_tp_report 10:25:38 INFO - PROCESS | 27124 | _x_x_mozilla_page_load 10:25:38 INFO - PROCESS | 27124 | _x_x_mozilla_page_load_details 10:25:38 INFO - PROCESS | 27124 | |i|pagename|runs| 10:25:38 INFO - PROCESS | 27124 | |0;ai-astar;112;108;110;111;112;123;113;110;110;110 10:25:38 INFO - PROCESS | 27124 | |1;audio-beat-detection;151;125;153;160;127;150;147;131;159;129 10:25:38 INFO - PROCESS | 27124 | |2;audio-dft;164;163;162;162;161;161;168;173;168;164 10:25:38 INFO - PROCESS | 27124 | |3;audio-fft;72;73;72;72;74;72;157;74;71;83 10:25:38 INFO - PROCESS | 27124 | |4;audio-oscillator;96;95;146;96;99;96;147;96;98;136 10:25:38 INFO - PROCESS | 27124 | |5;imaging-gaussian-blur;110;110;110;110;111;110;111;115;110;109 10:25:38 INFO - PROCESS | 27124 | |6;imaging-darkroom;146;146;146;147;147;146;146;150;148;147 10:25:38 INFO - PROCESS | 27124 | |7;imaging-desaturate;97;97;99;97;96;96;96;96;96;96 10:25:38 INFO - PROCESS | 27124 | |8;json-parse-financial;62;62;59;60;58;60;62;61;57;57 10:25:38 INFO - PROCESS | 27124 | |9;json-stringify-tinderbox;67;70;68;67;68;70;68;68;68;69 10:25:38 INFO - PROCESS | 27124 | |10;stanford-crypto-aes;82;82;82;93;86;83;82;83;84;84 10:25:38 INFO - PROCESS | 27124 | |11;stanford-crypto-ccm;123;128;117;118;114;115;116;123;119;121 10:25:38 INFO - PROCESS | 27124 | |12;stanford-crypto-pbkdf2;158;144;141;152;143;139;148;141;154;139 10:25:38 INFO - PROCESS | 27124 | |13;stanford-crypto-sha256-iterative;72;67;71;68;70;65;70;66;66;69 10:25:38 INFO - PROCESS | 27124 | __end_tp_report 10:25:38 INFO - PROCESS | 27124 | __start_cc_report 10:25:38 INFO - PROCESS | 27124 | _x_x_mozilla_cycle_collect,729 10:25:38 INFO - PROCESS | 27124 | __end_cc_report 10:25:38 INFO - PROCESS | 27124 | __startTimestamp1452795938930__endTimestamp 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | ------- Summary: start ------- 10:25:38 INFO - PROCESS | 27124 | Number of tests: 14 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.15 (3.7%) stddev-sans-first:4.40 10:25:38 INFO - PROCESS | 27124 | Values: 112.0 108.0 110.0 111.0 112.0 123.0 113.0 110.0 110.0 110.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:150.50 stddev:13.72 (9.1%) stddev-sans-first:14.26 10:25:38 INFO - PROCESS | 27124 | Values: 151.0 125.0 153.0 160.0 127.0 150.0 147.0 131.0 159.0 129.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.89 (2.4%) stddev-sans-first:4.12 10:25:38 INFO - PROCESS | 27124 | Values: 164.0 163.0 162.0 162.0 161.0 161.0 168.0 173.0 168.0 164.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#3] audio-fft Cycles:10 Average:82.00 Median:72.50 stddev:26.57 (36.7%) stddev-sans-first:27.94 10:25:38 INFO - PROCESS | 27124 | Values: 72.0 73.0 72.0 72.0 74.0 72.0 157.0 74.0 71.0 83.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:22.64 (23.6%) stddev-sans-first:23.40 10:25:38 INFO - PROCESS | 27124 | Values: 96.0 95.0 146.0 96.0 99.0 96.0 147.0 96.0 98.0 136.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 10:25:38 INFO - PROCESS | 27124 | Values: 110.0 110.0 110.0 110.0 111.0 110.0 111.0 115.0 110.0 109.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 10:25:38 INFO - PROCESS | 27124 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 150.0 148.0 147.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 10:25:38 INFO - PROCESS | 27124 | Values: 97.0 97.0 99.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.50 stddev:1.99 (3.3%) stddev-sans-first:1.94 10:25:38 INFO - PROCESS | 27124 | Values: 62.0 62.0 59.0 60.0 58.0 60.0 62.0 61.0 57.0 57.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 10:25:38 INFO - PROCESS | 27124 | Values: 67.0 70.0 68.0 67.0 68.0 70.0 68.0 68.0 68.0 69.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.38 (4.0%) stddev-sans-first:3.50 10:25:38 INFO - PROCESS | 27124 | Values: 82.0 82.0 82.0 93.0 86.0 83.0 82.0 83.0 84.0 84.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.00 stddev:4.35 (3.6%) stddev-sans-first:4.42 10:25:38 INFO - PROCESS | 27124 | Values: 123.0 128.0 117.0 118.0 114.0 115.0 116.0 123.0 119.0 121.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:146.00 stddev:6.74 (4.6%) stddev-sans-first:5.55 10:25:38 INFO - PROCESS | 27124 | Values: 158.0 144.0 141.0 152.0 143.0 139.0 148.0 141.0 154.0 139.0 10:25:38 INFO - PROCESS | 27124 | 10:25:38 INFO - PROCESS | 27124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.50 stddev:2.37 (3.4%) stddev-sans-first:2.12 10:25:38 INFO - PROCESS | 27124 | Values: 72.0 67.0 71.0 68.0 70.0 65.0 70.0 66.0 66.0 69.0 10:25:38 INFO - PROCESS | 27124 | -------- Summary: end -------- 10:25:38 INFO - PROCESS | 27124 | 10:25:39 INFO - TEST-INFO | 27124: exit 0 10:25:39 INFO - TEST-OK | kraken | took 59468ms 10:25:39 INFO - TEST-START | v8_7 10:25:39 INFO - operating with platform_type : linux_ 10:25:39 INFO - Initialising browser for v8_7 test... 10:25:39 INFO - TEST-INFO | started process 27411 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5x_umm/profile http://localhost:41830/getInfo.html) 10:25:43 INFO - PROCESS | 27411 | 10:25:43 INFO - PROCESS | 27411 | (process:27484): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:25:44 INFO - PROCESS | 27411 | __metrics Screen width/height:1600/1200 10:25:44 INFO - PROCESS | 27411 | colorDepth:24 10:25:44 INFO - PROCESS | 27411 | Browser inner width/height: 1024/697 10:25:44 INFO - PROCESS | 27411 | __metrics 10:25:44 INFO - PROCESS | 27411 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:25:45 INFO - TEST-INFO | 27411: exit 0 10:25:45 INFO - Browser initialized. 10:25:45 INFO - Running cycle 1/1 for v8_7 test... 10:25:45 INFO - TEST-INFO | started process 27533 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5x_umm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:46 INFO - PROCESS | 27533 | 10:25:46 INFO - PROCESS | 27533 | (process:27590): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:25:57 INFO - PROCESS | 27533 | RSS: Main: 150781952 10:25:57 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | Cycle 1(1): loaded http://localhost:41830/tests/v8_7/run.html (next: http://localhost:41830/tests/v8_7/run.html) 10:26:19 INFO - PROCESS | 27533 | RSS: Main: 147136512 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | __start_tp_report 10:26:19 INFO - PROCESS | 27533 | _x_x_mozilla_page_load 10:26:19 INFO - PROCESS | 27533 | _x_x_mozilla_page_load_details 10:26:19 INFO - PROCESS | 27533 | |i|pagename|runs| 10:26:19 INFO - PROCESS | 27533 | |0;Richards;166.08536787908986 10:26:19 INFO - PROCESS | 27533 | |1;DeltaBlue;188.5014137606032 10:26:19 INFO - PROCESS | 27533 | |2;Encrypt;280.0336040324839 10:26:19 INFO - PROCESS | 27533 | |3;Decrypt;5256.544502617801 10:26:19 INFO - PROCESS | 27533 | |4;RayTrace;1051.5247108307046 10:26:19 INFO - PROCESS | 27533 | |5;Earley;756.4296520423601 10:26:19 INFO - PROCESS | 27533 | |6;Boyer;11916.666666666666 10:26:19 INFO - PROCESS | 27533 | |7;RegExp;42354.166666666664 10:26:19 INFO - PROCESS | 27533 | |8;Splay;606.4281382656155 10:26:19 INFO - PROCESS | 27533 | |9;NavierStokes;4835.748792270531 10:26:19 INFO - PROCESS | 27533 | __end_tp_report 10:26:19 INFO - PROCESS | 27533 | __startTimestamp1452795979651__endTimestamp 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | ------- Summary: start ------- 10:26:19 INFO - PROCESS | 27533 | Number of tests: 10 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 166.1 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 188.5 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 280.0 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 5256.5 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 1051.5 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#5] Earley Cycles:1 Average:756.43 Median:756.43 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 756.4 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#6] Boyer Cycles:1 Average:11916.67 Median:11916.67 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 11916.7 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#7] RegExp Cycles:1 Average:42354.17 Median:42354.17 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 42354.2 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#8] Splay Cycles:1 Average:606.43 Median:606.43 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 606.4 10:26:19 INFO - PROCESS | 27533 | 10:26:19 INFO - PROCESS | 27533 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:26:19 INFO - PROCESS | 27533 | Values: 4835.7 10:26:19 INFO - PROCESS | 27533 | -------- Summary: end -------- 10:26:19 INFO - PROCESS | 27533 | 10:26:20 INFO - TEST-INFO | 27533: exit 0 10:26:20 INFO - TEST-OK | v8_7 | took 40647ms 10:26:20 INFO - SUITE-END | took 1209s 10:26:20 INFO - Completed test suite (00:20:09) 10:26:20 INFO - Working with test: dromaeo_css 10:26:20 INFO - Generating results file: dromaeo_css 10:26:20 INFO - Working with test: kraken 10:26:20 INFO - Generating results file: kraken 10:26:20 INFO - javascript benchmark 10:26:20 INFO - Working with test: v8_7 10:26:20 INFO - Generating results file: v8_7 10:26:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:26:20 INFO - process_Request line: dromaeo_css 6776.40 graph.html#tests=[[72,1,43]] 10:26:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:21 INFO - process_Request line: kraken 1512.20 graph.html#tests=[[232,1,43]] 10:26:21 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:21 INFO - process_Request line: v8_7 20262.29 graph.html#tests=[[230,1,43]] 10:26:21 INFO - RETURN: dromaeo_css: 6776.40 10:26:21 INFO - RETURN: kraken: 1512.20 10:26:21 INFO - RETURN: v8_7: 20262.29 10:26:21 INFO - javascript benchmark 10:26:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.3723255348928, 3151.0704342219055, 3180.6024246969127, 3183.2041989502623, 3193.5848339715835, 4996.825111121111, 5125.308083408739, 5133.281340612312, 5175.767090480928, 5203.505666961642, 5061.291419201315, 5100.668456550322, 5113.769880355384, 5150.381954165496, 5175.094358487259, 4702.811887524504, 4772.57046865782, 4829.106615276168, 4857.319975203474, 4906.9263961040615, 4722.716637001774, 4810.39870016248, 4841.370621819176, 4895.804167833282, 4926.162552366106, 4590.357349971006, 4712.246040633482, 4778.450478195017, 4790.616750659956, 4864.416270047599, 4671.532846715335, 4720.763961801897, 4729.101470720587, 4742.07529531738, 4745.098431298077, 4716.292556116576, 4727.125481785881, 4737.73942433166, 4756.167670657655, 4778.259369797687, 4851.27230915362, 4981.078500477387, 5038.2190760432195, 5051.545360917498, 5067.062593420193, 5571.749271282802, 5582.804601838957, 5583.720813959327, 5585.357683866367, 5615.943840561583, 5620.522255608278, 5622.8313150605545, 5628.324601047901, 5631.60578759487, 5645.774169033234, 5112.156494178456, 5163.845084647466, 5195.896082078338, 5252.133397989289, 5310.601704872111, 5623.550115990711, 5634.60557760961, 5636.60543761941, 5649.152627105885, 5659.773609055674, 5436.184572314184, 5452.372977107683, 5470.863228419242, 5489.64317319373, 5513.0, 5345.0, 5412.78348866041, 5521.944780552223, 5605.971970140124, 5625.015622266087, 5510.669359838423, 5518.806841760519, 5523.199136125239, 5525.889482210414, 5529.0324193266015, 5505.476979686923, 5512.542582842957, 5516.255305533782, 5521.365043020024, 5545.306836645419, 4222.3244280914905, 4268.061026574149, 4329.350597410414, 4380.970471939092, 4408.052268762167, 3852.075501879529, 3852.614738526125, 3869.2261547690573, 3901.395283731026, 3908.1988192420486, 5130.0, 5175.45657705943, 5179.22311653255, 5184.326037615086, 5224.425313215544, 5542.473465020817, 5569.303837020372, 5592.832215033555, 5615.494605485526, 5680.943190568124, 5144.048351055067, 5160.8967820643375, 5166.4316925138955, 5175.81884634036, 5205.583553315726, 4659.20793465105, 4728.1962066448095, 4731.668783185144, 4737.45519265282, 4748.264019077049, 5812.534997200214, 5816.389279125716, 5827.35899051104, 5840.8539786504825, 5866.061430171152, 5570.080936645408, 5588.552915766811, 5594.41258667834, 5599.580031497735, 5608.523275521627, 5568.443155684399, 5684.658920464785, 5810.506106980785, 5811.941880581309, 5849.795257165979, 5478.890422191614, 5479.506844384025, 5484.040292948798, 5487.835364939058, 5525.778968841362, 5471.343438787212, 5517.531009864207, 5532.253145825262, 5560.19377190297, 5600.075987462186, 5309.2301616266195, 5363.115086010765, 5391.973040134774, 5424.0, 5476.507114359727, 5400.891982160256, 5402.432744561765, 5408.0, 5420.078586640359, 5452.809151679672, 5289.6032797539565, 5305.204219367126, 5332.840014799563, 5335.039692855324, 5380.515753582196, 5303.416624171261, 5367.141257398797, 5373.408925018323, 5429.837104886859, 5462.8361149165585, 5284.365876094893, 5314.734263286743, 5323.0684630190335, 5327.946720532745, 5341.866453338697], "unit": "score", "name": "dojo.html", "value": 5125.1320155755575}, {"lowerIsBetter": false, "replicates": [505.08831559035946, 523.8553760034326, 543.5515699547873, 545.3646501825374, 559.9356074051483, 37891.0, 38239.61760382395, 38240.617593824056, 38478.807605962, 38693.80653096734, 43150.352744708856, 43574.56425435745, 43597.7820110899, 43649.0, 43902.0, 8549.487030778142, 8666.176713212266, 8712.172343627346, 8752.562371881413, 8773.7806554836, 8486.872696909551, 8672.089430609789, 8674.696385626505, 8709.912900871006, 8732.825343493158, 8710.172533609297, 8767.956160219223, 8776.429532080427, 8788.956055219714, 8800.0, 8631.784205394853, 8645.740627781177, 8703.43427677199, 8712.782180445476, 8719.389642725011, 8575.571221438902, 8641.30869530436, 8665.696700615448, 8714.825703485958, 8716.738497845012, 39317.60682393168, 39593.80203098966, 39647.8017609913, 39660.0, 39741.602583974076, 3422.9657703422895, 3446.724262059029, 3514.0512061743443, 3773.52830896138, 3919.8824035278985, 30078.54882176769, 30539.23651908698, 30614.0, 30794.23014424635, 30920.0, 3825.3879379299456, 3918.686505079587, 3964.6431821136234, 4082.5917408259234, 4111.342185250345, 269179.0, 270837.999999998, 271093.0, 271357.0, 271465.0, 48793.51206487961, 55305.0, 56213.437865621636, 56287.43712562822, 56407.333523320856, 44354.77822610866, 59744.40255597388, 59871.700641496514, 60786.0, 60837.391626083176, 14251.073680210753, 14268.714625707635, 14281.857181428053, 14283.0, 14357.856421435861, 10509.106725928228, 10510.421926794099, 10535.525901334458, 10550.944905509541, 10618.522166502526, 18260.178291976892, 18388.448346549623, 18569.350072747387, 18574.0, 19217.213504041836, 7007.684654190573, 7509.0, 7682.001339825899, 7715.614219289013, 7737.49706269102, 967.8064387122604, 991.613270824379, 1006.713086770267, 1023.959041638341, 1126.1722633864103, 27693.584596231074, 28193.43613127726, 28398.71601284002, 28557.714422855923, 28585.142445726662, 1029.902159294866, 1035.8290882004535, 1037.180627304436, 1123.4775829239443, 1132.767782604564, 15451.304691288919, 15552.455664051704, 16138.67722645564, 16239.756403653955, 16372.0, 281538.0, 284358.0, 286592.0, 286804.0, 286839.0, 52318.21522677163, 52730.73634631802, 52951.0, 53149.0, 53265.2010219847, 1342.664333916521, 1343.1538130977617, 1364.34511434512, 1370.095736813698, 1409.7734970575664, 25119.497610047332, 27687.169384918485, 27848.0, 27976.44047119087, 28187.295317617223, 45223.547764521936, 45236.321455178855, 45361.319580205665, 45475.0, 45659.0, 301544.0, 303057.0, 304903.0, 305615.0, 306480.0, 32504.34991300208, 42969.0, 43060.35409468798, 43882.92819502732, 44085.559144408144, 38663.226735465694, 38945.41581876217, 39368.0, 39478.40782388324, 39881.800590996856, 35393.29213415769, 35860.82069589636, 36197.27605447929, 36366.454503183006, 36438.0, 35587.644123558435, 36605.81697091497, 36652.26695466129, 36939.81530092332, 36969.6303036977, 35287.82356088306, 36733.81633091818, 36878.26243475169, 37030.44454333241, 37056.25887482181, 29293.0, 32711.509327359632, 32996.34007319888, 33078.834605826814, 33400.83299583486, 22567.58038982644, 22684.432889177904, 22833.88583057074, 22835.08659653595, 23006.539869202858], "unit": "score", "name": "ext.html", "value": 18345.59261716022}, {"lowerIsBetter": false, "replicates": [352.0968715245394, 352.17942194686384, 360.1464529066112, 361.92580520993215, 362.8403502458919, 15994.84005159948, 16464.0, 16734.330626774943, 17284.395046173388, 17351.219195136247, 15856.762148567752, 15865.84134158658, 16081.597960051005, 16323.59191020225, 16393.83606163938, 4861.854144375666, 5048.545630893219, 5050.090983622947, 5050.671706339094, 5051.848444546651, 4894.070126675938, 4922.26166075088, 4927.162382395001, 4985.850424487253, 5002.674826136289, 4979.950200498003, 4991.975040124794, 4997.550220480156, 5153.613478989072, 5162.6128040397125, 5069.898602027957, 5085.084684756761, 5096.694198348111, 5127.384713834326, 5655.4910058094965, 5427.83716488506, 5440.401555828856, 5441.727913604304, 5446.482584154499, 5456.099743542351, 12692.30192339421, 13919.373628186755, 16703.331866725315, 19844.90077549603, 19866.90066549658, 2076.086521930346, 2108.5677436125557, 2166.9783302166934, 2194.9451263718374, 2298.2645553422913, 6757.087793147961, 8787.912120878837, 9493.572789224501, 9495.620175192984, 9656.372335798222, 1813.4740925131696, 1813.8095499972576, 1826.0960824391877, 1847.178005787425, 1895.4313705888178, 52031.47968520304, 53589.928201436145, 55843.0, 56282.0, 56309.71845140789, 9661.613535458644, 9963.103320701026, 10080.798384032278, 10167.186625069977, 10172.796544069226, 13148.276844773629, 13176.934115329363, 13211.273379964003, 13211.735765284833, 13378.799318010238, 7333.303336183054, 7375.01749055504, 7377.741779037815, 7410.96294518524, 7419.0, 6975.755848545276, 6999.37005669482, 7031.472639552054, 7041.647917604202, 7041.718331266795, 4314.288142456459, 4390.429244198298, 4391.385206071152, 4409.4488188976375, 4437.134758722018, 1672.4230140601474, 1794.7397627344224, 1849.5745978425039, 1881.689521228982, 1888.5845114074882, 425.29613489674637, 860.9612567434481, 955.1403736636944, 962.451402700454, 983.0218932162401, 10254.333468324536, 10789.0, 10925.344479331265, 11034.724131896606, 11094.445277736242, 442.0, 454.9476810166807, 455.703792534855, 467.42506716738603, 474.926386410107, 5565.387807341189, 5638.577106717013, 5949.9107513387335, 6007.639541627516, 6083.5741498095595, 490832.0, 498797.0, 499387.0, 515362.0, 517192.0, 69954.3004569958, 70647.29352706509, 72646.0, 72911.0, 74648.62675686587, 471.4272159326435, 475.5221002892071, 475.81443237137546, 475.9547842954914, 477.91158635652516, 9854.310198286052, 9928.801423971336, 9945.900540994497, 10182.134518566005, 10197.74505637365, 29146.0, 29842.850785745934, 30666.233344166576, 30982.53526197064, 31569.21076973094, 41606.0, 42505.0, 42649.0, 43892.78053609839, 44893.326600101675, 6036.004059330161, 7404.296591823768, 7500.587467689329, 7517.699292028257, 7552.282533159341, 9948.651797187063, 10598.735031624272, 10718.517666704862, 10832.24174307791, 11241.494132764208, 8699.43453675509, 8896.288296936358, 9113.954430227806, 9315.487648179414, 9536.141747242782, 9230.307726920373, 9424.81150376975, 9787.16809071237, 9795.216382689225, 10028.64899728506, 9529.666461674085, 9700.223982081558, 9793.65722199748, 9847.162991145546, 10131.544080516247, 7524.661390237343, 7676.347510461674, 7680.462367634212, 7686.730964416219, 7706.422018348759, 7339.59632220233, 9037.548122593975, 9211.585478653342, 9233.722988310361, 9237.815243695222], "unit": "score", "name": "jquery.html", "value": 7345.473897324416}, {"lowerIsBetter": false, "replicates": [1435.239323158726, 1489.3893503663496, 1633.5344426838346, 1771.3800169940514, 1793.0586442117894, 7803.258690424408, 7850.96074519628, 8012.719554815582, 8040.075391329999, 8069.233422824829, 8229.958850205756, 8233.259006689397, 8311.0, 8320.084790673036, 8347.749567512968, 2362.9291121266388, 2381.714194296687, 2382.7855493005627, 2388.976110238893, 2397.580423425902, 2353.4234112642425, 2368.27767530903, 2383.7616238376195, 2389.7968672662846, 2392.031227352925, 2264.6036943534896, 2321.9535609287805, 2329.24299602629, 2349.788519033287, 2367.6685264063044, 2290.8167346612313, 2316.872572008539, 2319.675245465636, 2321.721393432799, 2326.4765427778784, 2328.429534763977, 2351.3298709867604, 2353.599888019041, 2354.2701762453694, 2358.858468491896, 8159.592020398956, 8190.4266701330935, 8219.260266575977, 8225.259726624572, 8242.340612750966, 4735.289706544046, 4862.975685121587, 4876.439209490918, 4876.975615121902, 4902.093112774148, 3049.9542506862413, 3069.877204911801, 3189.0, 3208.855601497915, 3218.243712727507, 1038.3665963762098, 1044.660485342259, 1054.8417737339385, 1056.240063593011, 1096.2107282756403, 11118.722031949184, 11306.038986686142, 11321.999999999918, 11339.0, 11375.488103035383, 4093.836246550164, 4175.0, 4290.699651024398, 4302.26861433557, 4325.545817689097, 9109.40788848736, 9168.404053736485, 9171.77070573241, 9179.357444978921, 9179.954100229455, 4758.643101767381, 4787.0, 4788.880277993008, 4794.513700752777, 4805.4233491980485, 4384.714993525411, 4396.032872767986, 4397.648188144941, 4405.691601587922, 4438.955610443854, 3485.3029394121277, 3545.982270088633, 3548.8048157351595, 3555.7333200010103, 3567.6432356764117, 1063.984040239397, 1080.4117946618458, 1085.2294870641933, 1087.7443800706828, 1139.8518192634904, 1236.7650146472142, 1237.9071569632313, 1276.6106337566946, 1285.7299967007034, 1295.106376600143, 6976.058232138596, 7045.68294426752, 7080.504364694422, 7099.148102227662, 7103.857922841515, 1096.6709987004026, 1105.3147048829776, 1111.727626731456, 1113.276370359273, 1132.8130858408435, 5611.382747897728, 5732.369439361667, 5779.0464573344925, 5802.82591522255, 5839.562032847553, 9680.903190968142, 9797.265205109645, 10045.397276163454, 10137.64518241858, 10141.543630536644, 9786.070323319273, 9900.950495247478, 9930.0, 9949.55227014786, 9965.950170249102, 7236.963815180996, 7387.593682347522, 7459.8508029839095, 7467.887981680279, 7596.278353556514, 7229.674664639999, 7253.093363329584, 7296.452766042674, 7301.561906285639, 7354.970304157315, 8628.697995570124, 8694.43486173422, 8779.956100219713, 8789.780255493664, 8969.372143950122, 8895.73312800617, 8900.73297801067, 8938.910610893809, 8943.060978597154, 9008.099190080939, 7121.4302855770375, 7147.82130446743, 7153.749618763319, 7178.28217178278, 7191.7842464726145, 7201.891971620325, 7373.668184931584, 7423.8144046399275, 7424.257574242532, 7426.74006409773, 6536.3136870629805, 6540.50946179029, 6974.128233970754, 7027.15674119109, 7106.076210092655, 6016.608920420159, 6059.151718759289, 6078.787242446493, 6157.722902469489, 6245.594036387621, 6355.0, 6375.4262116409745, 6379.298277189599, 6386.872262554816, 6390.48876089921, 5683.7442315095095, 5693.345265294544, 5712.571557133315, 5720.628159169641, 5721.199032135588, 6010.0, 6052.364501727431, 6067.605605635619, 6072.574919755752, 6100.6949652516305], "unit": "score", "name": "mootools.html", "value": 4532.471308395203}, {"lowerIsBetter": false, "replicates": [332.46971081125605, 338.48550203690394, 345.16986647113686, 346.26418859922666, 350.714167953118, 6204.503639708823, 6251.0, 6251.062340648905, 6281.183446151994, 6297.905531417021, 5997.6701281429505, 6103.60326578772, 6108.969455152729, 6116.388361163881, 6138.8465288367815, 4686.835960741375, 4687.718736875799, 4731.645126615509, 4741.691790033654, 4745.92881106782, 4736.171170045245, 4748.453927798296, 4751.596114330286, 4754.762261886909, 4763.285507173934, 4648.588269320921, 4665.790039448233, 4718.669693121483, 4722.693024953367, 4731.455882573514, 4710.811567537295, 4717.457492388385, 4724.669273150898, 4725.598324142452, 4733.029728905601, 4151.958480415187, 4156.792160391999, 4160.209560183555, 4161.9583804161875, 4167.187398457302, 5822.214001109881, 5824.213731146283, 5826.912596311059, 5826.9708651456895, 5838.854028649275, 5355.705436201008, 5466.262054622614, 5518.365387980393, 5526.253955716007, 5533.253010843525, 6615.503837212228, 6627.635480048595, 6631.204255489324, 6637.0, 6639.3692599203, 4573.49691533931, 4577.33628623851, 4578.610818080467, 4578.931316030262, 4580.129775342708, 6784.185897692309, 6847.281035491302, 6873.278305777922, 6882.655867206619, 6918.93081069193, 4654.394928659252, 4660.091282199938, 4661.813527458864, 4665.230237010923, 4685.648576356787, 4737.928931066037, 4750.881227969259, 4754.548317909793, 4759.738214398241, 4761.642876784255, 5484.91772623411, 5492.670439773627, 5493.038718224295, 5503.229547863302, 5507.366652834895, 6510.381513756186, 6647.933520664828, 6669.799906002828, 6743.797686069426, 6744.426723728538, 1628.2835552356926, 1644.8519633232827, 1664.076437577132, 1667.1247595012715, 1669.4323929863904, 1091.4433638844246, 1100.5872797700863, 1101.1191047162238, 1113.8997490225918, 1122.7313136156092, 6206.565540412218, 6261.154744109578, 6273.18448601688, 6277.246730392382, 6290.119383286344, 6765.391114799691, 6777.6272305023695, 6779.389854913082, 6779.694913728894, 6790.32096790317, 6114.991026480581, 6193.6903154842075, 6255.311915689271, 6259.405356491126, 6267.6866156691985, 3683.797391143459, 3691.1694868654877, 3692.316921369555, 3692.833822477995, 3696.1129328960856, 7128.465365097639, 7147.392471639865, 7148.714051437884, 7152.713891444388, 7157.821054473679, 6834.624095674786, 6983.965080174668, 6998.370146686822, 6998.965005174941, 7001.894971575431, 7091.078159839291, 7137.357637812622, 7138.892916606255, 7147.785566433015, 7150.606716630636, 6688.665566721547, 6707.228668703162, 6717.1267735194115, 6723.125993620798, 6764.932350676627, 6613.867722645424, 6661.1007513985, 6697.698603562754, 6737.3599508046655, 6745.392914637706, 7119.0, 7121.928780712126, 7126.85746285061, 7135.036770036187, 7142.5000249982, 4644.953550464587, 4650.627949764078, 4665.066986602626, 4670.579647831712, 4671.8364857229835, 6744.8651026978205, 6785.287544807724, 6785.93214067853, 6791.558548694319, 6935.89596156048, 6705.899411508929, 6718.0, 6738.797836064926, 6746.595204287562, 6772.221194562491, 6697.028930805103, 6707.832304192434, 6712.127423434922, 6724.29394913527, 6739.797806065826, 6431.678416079084, 6570.244421891352, 6576.868462630625, 6583.901241481286, 6602.108715323562, 6705.765298214539, 6713.56361836479, 6749.156355455568, 6753.257141714505, 6762.289959554373, 6589.27517973013, 6592.736290548324, 6598.670066496752, 6601.867962640817, 6602.735890564323], "unit": "score", "name": "prototype.html", "value": 4978.013816405915}, {"lowerIsBetter": false, "replicates": [704.3695892176502, 800.3557136505112, 811.5617566514082, 821.1008945205002, 831.6922738586716, 11434.485448154832, 11766.176367654267, 12547.435365408555, 12709.936450317735, 12808.423620937057, 13838.100523465968, 13953.651158721037, 14057.718845623082, 14077.859221407783, 14210.07634503759, 768.7040489411589, 773.9226077392273, 777.4402430250211, 779.4660657449637, 781.9804504887367, 782.5500337306044, 788.329919568368, 789.1831953927687, 789.7354386280603, 790.8971833661616, 818.6193420059672, 820.1306614988102, 824.4805772363403, 826.5701835045772, 830.1325115254543, 819.700809204639, 823.7775800533852, 824.3775949158407, 825.0347093900122, 827.420805436197, 602.713710987282, 607.7295603456464, 608.3399511529996, 608.9391060893876, 610.7190692281556, 12727.109102362838, 12752.2986235757, 12786.424610892533, 12800.48798048077, 12801.615951521377, 11704.941475292655, 12358.814617780741, 12368.938155309166, 12432.564860229939, 12532.624021279376, 9879.259055570788, 9902.504874756234, 9952.90047099527, 9957.502124893726, 9990.150837178848, 3497.9475307870403, 3550.0, 3555.7510974231814, 3561.4301711726257, 3562.3765840977985, 44206.0, 44473.665790026025, 47755.28367074497, 48392.0, 48584.514154858705, 9224.907750922539, 9423.528823558794, 9475.76310592227, 9516.809663806685, 9638.373505722106, 17723.82276177222, 17898.821011789976, 17995.280188792563, 17999.64000719978, 18006.819931800514, 7367.300106489874, 7434.405247580181, 7463.664135113824, 7504.58724770132, 7548.433867459962, 4154.335306350969, 4249.830006799755, 4264.104538047045, 4268.530461649216, 4279.743215407086, 3061.831599262062, 3094.241910731885, 3096.1330827368374, 3107.8446077696026, 3139.3250451153112, 578.1414599320007, 585.7686213945468, 586.5923183387505, 601.1223613524216, 604.9758009679651, 466.2121015483821, 528.289450688823, 528.9632320651489, 609.4058293164218, 700.9940735045226, 7961.641726122339, 9163.77090572741, 9418.387804792666, 9484.33609647318, 9555.522223888778, 648.1800522339245, 650.4893658478072, 652.709544252803, 661.7683810666229, 667.813012356541, 3828.712846536521, 3914.3541315683165, 3915.686745060388, 3936.6653834424396, 4063.2686116499312, 54491.0, 55243.72378138084, 55374.169387459224, 55591.722041389534, 55679.72160139254, 50916.74541627268, 51157.48842511602, 51332.0, 52097.21854172191, 52102.73948630233, 42444.0, 42821.143577128285, 43016.0, 45397.0, 45887.54112458833, 8962.820743584962, 9198.402103863227, 9402.106799854002, 9436.480993545421, 9444.574994125418, 33036.33927321488, 33168.0, 35485.0, 36313.81843090873, 36554.451683224244, 43385.132297353244, 43619.56380436282, 43633.56366436295, 44158.11683766243, 44511.33233001572, 10682.73293167677, 10686.198535110054, 11107.166962478008, 11138.10895128404, 11396.430178490877, 11375.715607109558, 11713.297202167898, 11837.644870653894, 11855.0, 12282.201656892274, 11084.390358530358, 11676.182667213214, 11792.23350482216, 11882.10884183707, 12105.273683579013, 11057.889421105687, 11513.827292590451, 11582.420878956187, 11606.361650108987, 11722.882771172179, 10785.946070269598, 11211.159163062966, 11220.062993997793, 11240.718982025188, 11268.83096753533, 9302.16280534755, 9308.44149351041, 9340.252779777737, 9478.431294122374, 9645.0, 9109.908900910907, 9257.953710231406, 9431.528423578931, 9541.522923853918, 9799.363041402286], "unit": "score", "name": "yui.html", "value": 6213.1339223997975}], "name": "dromaeo_css", "value": 6776.4006389499145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 110.0, 111.0, 112.0, 123.0, 113.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 153.0, 160.0, 127.0, 150.0, 147.0, 131.0, 159.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 162.0, 161.0, 161.0, 168.0, 173.0, 168.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 72.0, 157.0, 74.0, 71.0, 83.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 146.0, 96.0, 99.0, 96.0, 147.0, 96.0, 98.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 115.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 150.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 99.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 59.0, 60.0, 58.0, 60.0, 62.0, 61.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 68.0, 67.0, 68.0, 70.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 93.0, 86.0, 83.0, 82.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 117.0, 118.0, 114.0, 115.0, 116.0, 123.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [158.0, 144.0, 141.0, 152.0, 143.0, 139.0, 148.0, 141.0, 154.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [72.0, 67.0, 71.0, 68.0, 70.0, 65.0, 70.0, 66.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1512.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1051.5247108307046], "unit": "score", "name": "RayTrace", "value": 703.7295389999999}, {"lowerIsBetter": false, "replicates": [756.4296520423601], "unit": "score", "name": "Earley", "value": 881.0640860000002}, {"lowerIsBetter": false, "replicates": [11916.666666666666], "unit": "score", "name": "Boyer", "value": 55.926965034964994}, {"lowerIsBetter": false, "replicates": [42354.166666666664], "unit": "score", "name": "RegExp", "value": 21.508745696015737}, {"lowerIsBetter": false, "replicates": [606.4281382656155], "unit": "score", "name": "Splay", "value": 134.37865900000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20262.290119546604}]} 10:26:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20262.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1512.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6776.40"}}} 10:26:21 INFO - Return code: 0 10:26:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:21 INFO - # TBPL SUCCESS # 10:26:21 INFO - Running post-action listener: _resource_record_post_action 10:26:21 INFO - Running post-run listener: _resource_record_post_run 10:26:22 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 543195136; Read time: 0; Write time: 450372 10:26:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 185278464; Read time: 0; Write time: 213836 10:26:22 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 314990592; Read time: 0; Write time: 220688 10:26:22 INFO - Running post-run listener: _upload_blobber_files 10:26:22 INFO - Blob upload gear active. 10:26:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:26:22 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 10:26:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:26:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:26:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:23 INFO - (blobuploader) - INFO - Done attempting. 10:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:24 INFO - (blobuploader) - INFO - Done attempting. 10:26:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:24 INFO - Return code: 0 10:26:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:26:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bceb644119e26fcfafdd885a0b4622b225e0f17316058b182fd3e38098a0a69665816724ebd1698af712b46e52177b46882d585a02b62eee0b33e26480054811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0106aa79e27c4a50e6534e69d3a00a2ab1a7c8340750bc0f46504335fd4f04af4d234180947b3dc9c321a96710c75658db97b19e1e4a257cfa260b0aaee1bb9"} 10:26:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:26:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:26:24 INFO - Contents: 10:26:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bceb644119e26fcfafdd885a0b4622b225e0f17316058b182fd3e38098a0a69665816724ebd1698af712b46e52177b46882d585a02b62eee0b33e26480054811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0106aa79e27c4a50e6534e69d3a00a2ab1a7c8340750bc0f46504335fd4f04af4d234180947b3dc9c321a96710c75658db97b19e1e4a257cfa260b0aaee1bb9"} 10:26:24 INFO - Copying logs to upload dir... 10:26:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.840855 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-14 10:26:24.061634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:24.065272) ========= 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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bceb644119e26fcfafdd885a0b4622b225e0f17316058b182fd3e38098a0a69665816724ebd1698af712b46e52177b46882d585a02b62eee0b33e26480054811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0106aa79e27c4a50e6534e69d3a00a2ab1a7c8340750bc0f46504335fd4f04af4d234180947b3dc9c321a96710c75658db97b19e1e4a257cfa260b0aaee1bb9"} build_url:https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bceb644119e26fcfafdd885a0b4622b225e0f17316058b182fd3e38098a0a69665816724ebd1698af712b46e52177b46882d585a02b62eee0b33e26480054811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0106aa79e27c4a50e6534e69d3a00a2ab1a7c8340750bc0f46504335fd4f04af4d234180947b3dc9c321a96710c75658db97b19e1e4a257cfa260b0aaee1bb9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:24.096703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:24.097196) ========= 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=ed14279e38b05397cf4aa391000001a4-1452794502.504537-1561504913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:24.178386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 10:26:24.178769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 10:26:24.179143) ========= ========= Total master_lag: 0.25 =========