builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1451955869.15 results: success (0) buildid: 20160104143010 builduid: aa37b6a0b34841d8b9b6e0d4297ee31d revision: 4ed8e9fdc7cc0e4ef4530d6cb0745a8a12f631ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.147410) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.147858) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.148139) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006308 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.172623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.172930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.186473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.186766) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.236498) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.236799) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.237181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.237476) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 17:04:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 40.4M=0s 2016-01-04 17:04:29 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.348723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.349049) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.402247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:29.402596) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4ed8e9fdc7cc0e4ef4530d6cb0745a8a12f631ef --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4ed8e9fdc7cc0e4ef4530d6cb0745a8a12f631ef --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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 17:04:29,812 truncating revision to first 12 chars 2016-01-04 17:04:29,812 Setting DEBUG logging. 2016-01-04 17:04:29,812 attempt 1/10 2016-01-04 17:04:29,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4ed8e9fdc7cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 17:04:30,378 unpacking tar archive at: b2g-inbound-4ed8e9fdc7cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:30.247298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:30.247643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:30.257552) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:30.257845) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 17:04:30.258260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-04 17:04:30.258551) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:04:30 INFO - MultiFileLogger online at 20160104 17:04:30 in /builds/slave/test-pgo 17:04:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 17:04:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:04:30 INFO - {'append_to_log': False, 17:04:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:04:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 17:04:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:04:30 INFO - 'branch': 'B2G-Inbound', 17:04:30 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:30 INFO - 'config_files': ('talos/linux_config.py',), 17:04:30 INFO - 'default_actions': ('clobber', 17:04:30 INFO - 'read-buildbot-config', 17:04:30 INFO - 'download-and-extract', 17:04:30 INFO - 'populate-webroot', 17:04:30 INFO - 'create-virtualenv', 17:04:30 INFO - 'install', 17:04:30 INFO - 'run-tests'), 17:04:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:30 INFO - 'download_minidump_stackwalk': True, 17:04:30 INFO - 'download_symbols': 'ondemand', 17:04:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:30 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:30 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:30 INFO - 'installer_path': 'installer.exe', 17:04:30 INFO - 'log_level': 'info', 17:04:30 INFO - 'log_name': 'talos', 17:04:30 INFO - 'log_to_console': True, 17:04:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:04:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:04:30 INFO - 'opt_config_files': (), 17:04:30 INFO - 'pip_index': False, 17:04:30 INFO - 'sps_profile': False, 17:04:30 INFO - 'sps_profile_interval': 0, 17:04:30 INFO - 'suite': 'dromaeojs', 17:04:30 INFO - 'system_bits': '32', 17:04:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:30 INFO - 'title': 'talos-linux64-ix-014', 17:04:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:30 INFO - 'use_talos_json': True, 17:04:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:04:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:30 INFO - 'work_dir': 'build'} 17:04:30 INFO - ##### 17:04:30 INFO - ##### Running clobber step. 17:04:30 INFO - ##### 17:04:30 INFO - Running pre-action listener: _resource_record_pre_action 17:04:30 INFO - Running main action method: clobber 17:04:30 INFO - rmtree: /builds/slave/test-pgo/build 17:04:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:04:31 INFO - Running post-action listener: _resource_record_post_action 17:04:31 INFO - ##### 17:04:31 INFO - ##### Running read-buildbot-config step. 17:04:31 INFO - ##### 17:04:31 INFO - Running pre-action listener: _resource_record_pre_action 17:04:31 INFO - Running main action method: read_buildbot_config 17:04:31 INFO - Using buildbot properties: 17:04:31 INFO - { 17:04:31 INFO - "project": "", 17:04:31 INFO - "product": "firefox", 17:04:31 INFO - "script_repo_revision": "production", 17:04:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:04:31 INFO - "repository": "", 17:04:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 17:04:31 INFO - "buildid": "20160104143010", 17:04:31 INFO - "pgo_build": "True", 17:04:31 INFO - "basedir": "/builds/slave/test-pgo", 17:04:31 INFO - "buildnumber": 179, 17:04:31 INFO - "slavename": "talos-linux64-ix-014", 17:04:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:04:31 INFO - "platform": "ubuntu64_hw", 17:04:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 17:04:31 INFO - "branch": "b2g-inbound", 17:04:31 INFO - "repo_path": "integration/b2g-inbound", 17:04:31 INFO - "revision": "4ed8e9fdc7cc0e4ef4530d6cb0745a8a12f631ef", 17:04:31 INFO - "stage_platform": "linux64-pgo", 17:04:31 INFO - "builduid": "aa37b6a0b34841d8b9b6e0d4297ee31d", 17:04:31 INFO - "slavebuilddir": "test" 17:04:31 INFO - } 17:04:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:04:31 INFO - Running post-action listener: _resource_record_post_action 17:04:31 INFO - ##### 17:04:31 INFO - ##### Running download-and-extract step. 17:04:31 INFO - ##### 17:04:31 INFO - Running pre-action listener: _resource_record_pre_action 17:04:31 INFO - Running main action method: download_and_extract 17:04:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:31 INFO - https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/test_packages.json 17:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/test_packages.json 17:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:04:32 INFO - Downloaded 1302 bytes. 17:04:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:04:32 INFO - Using the following test package requirements: 17:04:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:04:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'jsshell-linux-x86_64.zip'], 17:04:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:04:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:04:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:04:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:04:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:04:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:04: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')]} 17:04:32 INFO - https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:33 INFO - Downloaded 23197822 bytes. 17:04:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:04:34 INFO - Return code: 0 17:04:34 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 17:04:34 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')]} 17:04:34 INFO - https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:36 INFO - Downloaded 23197822 bytes. 17:04:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:04:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:04:37 INFO - Return code: 0 17:04: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')]} 17:04:37 INFO - https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:38 INFO - Downloaded 11132285 bytes. 17:04:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:04:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:04:38 INFO - Return code: 0 17:04:38 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')]} 17:04:38 INFO - https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Diw0ZTovTlK3acK2EqGiOw/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 17:04:40 INFO - Downloaded 54981697 bytes. 17:04:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:40 INFO - mkdir: /builds/slave/test-pgo/properties 17:04:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:04:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:04:40 INFO - Contents: 17:04:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:40 INFO - Running post-action listener: _resource_record_post_action 17:04:40 INFO - Running post-action listener: set_extra_try_arguments 17:04:40 INFO - ##### 17:04:40 INFO - ##### Running populate-webroot step. 17:04:40 INFO - ##### 17:04:40 INFO - Running pre-action listener: _resource_record_pre_action 17:04:40 INFO - Running main action method: populate_webroot 17:04:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:40 INFO - '--tppagecycles', 17:04:40 INFO - '7'], 17:04:40 INFO - 'tests': ['tsvgm']}}, 17:04:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'tests': ['damp', 'tps']}, 17:04:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['damp', 'tps']}, 17:04:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:40 INFO - 'other': {'tests': ['a11yr', 17:04:40 INFO - 'ts_paint', 17:04:40 INFO - 'tpaint', 17:04:40 INFO - 'sessionrestore', 17:04:40 INFO - 'sessionrestore_no_auto_restore']}, 17:04:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['a11yr', 17:04:40 INFO - 'ts_paint', 17:04:40 INFO - 'tpaint', 17:04:40 INFO - 'sessionrestore', 17:04:40 INFO - 'sessionrestore_no_auto_restore']}, 17:04:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['a11yr', 17:04:40 INFO - 'ts_paint', 17:04:40 INFO - 'tpaint', 17:04:40 INFO - 'sessionrestore', 17:04:40 INFO - 'sessionrestore_no_auto_restore']}, 17:04:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['a11yr', 17:04:40 INFO - 'ts_paint', 17:04:40 INFO - 'tpaint', 17:04:40 INFO - 'sessionrestore', 17:04:40 INFO - 'sessionrestore_no_auto_restore']}, 17:04:40 INFO - 'other_l64': {'tests': ['a11yr', 17:04:40 INFO - 'ts_paint', 17:04:40 INFO - 'tpaint', 17:04:40 INFO - 'sessionrestore', 17:04:40 INFO - 'sessionrestore_no_auto_restore']}, 17:04:40 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:40 INFO - 'ts_paint', 17:04:40 INFO - 'tpaint', 17:04:40 INFO - 'sessionrestore', 17:04:40 INFO - 'sessionrestore_no_auto_restore']}, 17:04:40 INFO - 'svgr': {'tests': ['tsvgx', 17:04:40 INFO - 'tsvgr_opacity', 17:04:40 INFO - 'tart', 17:04:40 INFO - 'tscrollx', 17:04:40 INFO - 'cart']}, 17:04:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['tsvgx', 17:04:40 INFO - 'tsvgr_opacity', 17:04:40 INFO - 'tart', 17:04:40 INFO - 'tscrollx', 17:04:40 INFO - 'cart']}, 17:04:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'tests': ['tp5o']}, 17:04:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'talos_options': ['--e10s'], 17:04:40 INFO - 'tests': ['tp5o']}, 17:04:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'talos_options': ['--xperf_path', 17:04:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:40 INFO - 'tests': ['tp5n']}, 17:04:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:40 INFO - 'talos_options': ['--e10s', 17:04:40 INFO - '--xperf_path', 17:04:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:40 INFO - 'tests': ['tp5n']}}, 17:04:40 INFO - 'talos.zip': {'path': '', 17:04:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:40 INFO - Running post-action listener: _resource_record_post_action 17:04:40 INFO - ##### 17:04:40 INFO - ##### Running create-virtualenv step. 17:04:40 INFO - ##### 17:04:40 INFO - Running pre-action listener: _resource_record_pre_action 17:04:40 INFO - Running main action method: create_virtualenv 17:04:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:04:40 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 17:04:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:04:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:40 INFO - Using real prefix '/usr' 17:04:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:04:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:43 INFO - Installing pip.................done. 17:04:43 INFO - Return code: 0 17:04:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:04:43 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')]} 17:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:43 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')]} 17:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:43 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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:43 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 17:04:43 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 17:04:43 INFO - Using env: {'DISPLAY': ':0', 17:04:43 INFO - 'HOME': '/home/cltbld', 17:04:43 INFO - 'LANG': 'en_US.UTF-8', 17:04:43 INFO - 'LANGUAGE': 'en_US:en', 17:04:43 INFO - 'LOGNAME': 'cltbld', 17:04:43 INFO - 'MAIL': '/var/mail/cltbld', 17:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:43 INFO - 'MOZ_NO_REMOTE': '1', 17:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:43 INFO - 'NO_EM_RESTART': '1', 17:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:43 INFO - 'SHELL': '/bin/bash', 17:04:43 INFO - 'SHLVL': '1', 17:04:43 INFO - 'TERM': 'linux', 17:04:43 INFO - 'TMOUT': '86400', 17:04:43 INFO - 'USER': 'cltbld', 17:04:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:43 INFO - '_': '/tools/buildbot/bin/python'} 17:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:43 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 17:04:43 INFO - Cleaning up... 17:04:43 INFO - Return code: 0 17:04:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:04:43 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')]} 17:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:43 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')]} 17:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:43 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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:43 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 17:04:43 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 17:04:43 INFO - Using env: {'DISPLAY': ':0', 17:04:43 INFO - 'HOME': '/home/cltbld', 17:04:43 INFO - 'LANG': 'en_US.UTF-8', 17:04:43 INFO - 'LANGUAGE': 'en_US:en', 17:04:43 INFO - 'LOGNAME': 'cltbld', 17:04:43 INFO - 'MAIL': '/var/mail/cltbld', 17:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:43 INFO - 'MOZ_NO_REMOTE': '1', 17:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:43 INFO - 'NO_EM_RESTART': '1', 17:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:43 INFO - 'SHELL': '/bin/bash', 17:04:43 INFO - 'SHLVL': '1', 17:04:43 INFO - 'TERM': 'linux', 17:04:43 INFO - 'TMOUT': '86400', 17:04:43 INFO - 'USER': 'cltbld', 17:04:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:43 INFO - '_': '/tools/buildbot/bin/python'} 17:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:43 INFO - Downloading/unpacking psutil>=0.7.1 17:04:43 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 17:04:43 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 17:04:43 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 17:04:43 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 17:04:43 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 17:04:43 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 17:04:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:04:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:04:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:45 INFO - Installing collected packages: psutil 17:04:45 INFO - Running setup.py install for psutil 17:04:45 INFO - building 'psutil._psutil_linux' extension 17:04:45 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 17:04:46 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 17:04:46 INFO - building 'psutil._psutil_posix' extension 17:04:46 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 17:04:46 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 17:04:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:46 INFO - Successfully installed psutil 17:04:46 INFO - Cleaning up... 17:04:46 INFO - Return code: 0 17:04:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:04:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:04:46 INFO - Using env: {'DISPLAY': ':0', 17:04:46 INFO - 'HOME': '/home/cltbld', 17:04:46 INFO - 'LANG': 'en_US.UTF-8', 17:04:46 INFO - 'LANGUAGE': 'en_US:en', 17:04:46 INFO - 'LOGNAME': 'cltbld', 17:04:46 INFO - 'MAIL': '/var/mail/cltbld', 17:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:46 INFO - 'MOZ_NO_REMOTE': '1', 17:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:46 INFO - 'NO_EM_RESTART': '1', 17:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:46 INFO - 'SHELL': '/bin/bash', 17:04:46 INFO - 'SHLVL': '1', 17:04:46 INFO - 'TERM': 'linux', 17:04:46 INFO - 'TMOUT': '86400', 17:04:46 INFO - 'USER': 'cltbld', 17:04:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:46 INFO - '_': '/tools/buildbot/bin/python'} 17:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:04:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:48 INFO - Installing collected packages: mozsystemmonitor 17:04:48 INFO - Running setup.py install for mozsystemmonitor 17:04:48 INFO - Successfully installed mozsystemmonitor 17:04:48 INFO - Cleaning up... 17:04:48 INFO - Return code: 0 17:04:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:48 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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:48 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 17:04:48 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 17:04:48 INFO - Using env: {'DISPLAY': ':0', 17:04:48 INFO - 'HOME': '/home/cltbld', 17:04:48 INFO - 'LANG': 'en_US.UTF-8', 17:04:48 INFO - 'LANGUAGE': 'en_US:en', 17:04:48 INFO - 'LOGNAME': 'cltbld', 17:04:48 INFO - 'MAIL': '/var/mail/cltbld', 17:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:48 INFO - 'MOZ_NO_REMOTE': '1', 17:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:48 INFO - 'NO_EM_RESTART': '1', 17:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:48 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:48 INFO - 'SHELL': '/bin/bash', 17:04:48 INFO - 'SHLVL': '1', 17:04:48 INFO - 'TERM': 'linux', 17:04:48 INFO - 'TMOUT': '86400', 17:04:48 INFO - 'USER': 'cltbld', 17:04:48 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:48 INFO - '_': '/tools/buildbot/bin/python'} 17:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:04:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:04:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:04:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:51 INFO - Downloading docopt-0.6.1.tar.gz 17:04:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:04:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:51 INFO - Running setup.py install for blobuploader 17:04:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:04:51 INFO - Running setup.py install for requests 17:04:51 INFO - Running setup.py install for docopt 17:04:51 INFO - Successfully installed blobuploader requests docopt 17:04:51 INFO - Cleaning up... 17:04:51 INFO - Return code: 0 17:04:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:51 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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:51 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 17:04:51 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 17:04:51 INFO - Using env: {'DISPLAY': ':0', 17:04:51 INFO - 'HOME': '/home/cltbld', 17:04:51 INFO - 'LANG': 'en_US.UTF-8', 17:04:51 INFO - 'LANGUAGE': 'en_US:en', 17:04:51 INFO - 'LOGNAME': 'cltbld', 17:04:51 INFO - 'MAIL': '/var/mail/cltbld', 17:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:51 INFO - 'MOZ_NO_REMOTE': '1', 17:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:51 INFO - 'NO_EM_RESTART': '1', 17:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:51 INFO - 'SHELL': '/bin/bash', 17:04:51 INFO - 'SHLVL': '1', 17:04:51 INFO - 'TERM': 'linux', 17:04:51 INFO - 'TMOUT': '86400', 17:04:51 INFO - 'USER': 'cltbld', 17:04:51 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:51 INFO - '_': '/tools/buildbot/bin/python'} 17:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:52 INFO - Running setup.py (path:/tmp/pip-5t_D9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:52 INFO - Running setup.py (path:/tmp/pip-t5PhLY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:52 INFO - Running setup.py (path:/tmp/pip-XwY_FI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:52 INFO - Running setup.py (path:/tmp/pip-fM4eyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:52 INFO - Running setup.py (path:/tmp/pip-bbhHTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:52 INFO - Running setup.py (path:/tmp/pip-R8kJHM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:52 INFO - Running setup.py (path:/tmp/pip-rBd7aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:52 INFO - Running setup.py (path:/tmp/pip-F0Y7vm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:52 INFO - Running setup.py (path:/tmp/pip-iwTde3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:52 INFO - Running setup.py (path:/tmp/pip-UVsyYf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:52 INFO - Running setup.py (path:/tmp/pip-Fb82Ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:52 INFO - Running setup.py (path:/tmp/pip-qkeexT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:52 INFO - Running setup.py (path:/tmp/pip-uPAHNd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:52 INFO - Running setup.py (path:/tmp/pip-2ePvLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:53 INFO - Running setup.py (path:/tmp/pip-WQw4q8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:53 INFO - Running setup.py (path:/tmp/pip-Qaw0UB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:53 INFO - Running setup.py (path:/tmp/pip-KfcaSr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:53 INFO - Running setup.py install for manifestparser 17:04:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Running setup.py install for mozcrash 17:04:53 INFO - Running setup.py install for mozdebug 17:04:53 INFO - Running setup.py install for mozdevice 17:04:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Running setup.py install for mozfile 17:04:53 INFO - Running setup.py install for mozhttpd 17:04:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Running setup.py install for mozinfo 17:04:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Running setup.py install for mozInstall 17:04:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:04:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Running setup.py install for mozleak 17:04:54 INFO - Running setup.py install for mozlog 17:04:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Running setup.py install for moznetwork 17:04:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Running setup.py install for mozprocess 17:04:54 INFO - Running setup.py install for mozprofile 17:04:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Running setup.py install for mozrunner 17:04:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Running setup.py install for mozscreenshot 17:04:54 INFO - Running setup.py install for moztest 17:04:54 INFO - Running setup.py install for mozversion 17:04:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:04:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:54 INFO - Cleaning up... 17:04:54 INFO - Return code: 0 17:04:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:54 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')]} 17:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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')]} 17:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:54 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 17:04:54 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 17:04:54 INFO - Using env: {'DISPLAY': ':0', 17:04:54 INFO - 'HOME': '/home/cltbld', 17:04:54 INFO - 'LANG': 'en_US.UTF-8', 17:04:54 INFO - 'LANGUAGE': 'en_US:en', 17:04:54 INFO - 'LOGNAME': 'cltbld', 17:04:54 INFO - 'MAIL': '/var/mail/cltbld', 17:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:54 INFO - 'MOZ_NO_REMOTE': '1', 17:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:54 INFO - 'NO_EM_RESTART': '1', 17:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:54 INFO - 'SHELL': '/bin/bash', 17:04:54 INFO - 'SHLVL': '1', 17:04:54 INFO - 'TERM': 'linux', 17:04:54 INFO - 'TMOUT': '86400', 17:04:54 INFO - 'USER': 'cltbld', 17:04:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:54 INFO - '_': '/tools/buildbot/bin/python'} 17:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:55 INFO - Running setup.py (path:/tmp/pip-Yz7IJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:55 INFO - Running setup.py (path:/tmp/pip-vnv9iN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:55 INFO - Running setup.py (path:/tmp/pip-_Gpdu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:55 INFO - Running setup.py (path:/tmp/pip-xuVRNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:55 INFO - Running setup.py (path:/tmp/pip-3hWy9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:55 INFO - Running setup.py (path:/tmp/pip-PxLjvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:55 INFO - Running setup.py (path:/tmp/pip-xMQ_tp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:55 INFO - Running setup.py (path:/tmp/pip-EP8t8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:55 INFO - Running setup.py (path:/tmp/pip-KbHu3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:55 INFO - Running setup.py (path:/tmp/pip-FNSJnP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:55 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)) 17:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:55 INFO - Running setup.py (path:/tmp/pip-TXGAcp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:56 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)) 17:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:56 INFO - Running setup.py (path:/tmp/pip-2QbeyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:56 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)) 17:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:56 INFO - Running setup.py (path:/tmp/pip-AoWd03-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:56 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)) 17:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:56 INFO - Running setup.py (path:/tmp/pip-V9B1WC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:56 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)) 17:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:56 INFO - Running setup.py (path:/tmp/pip-pmTtN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:56 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)) 17:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:56 INFO - Running setup.py (path:/tmp/pip-wlbZ41-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:56 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)) 17:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:56 INFO - Running setup.py (path:/tmp/pip-wGRt35-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:56 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)) 17:04:56 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)) 17:04:56 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)) 17:04:56 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)) 17:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:58 INFO - Downloading blessings-1.5.1.tar.gz 17:04:58 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 17:04:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:58 INFO - Installing collected packages: blessings 17:04:58 INFO - Running setup.py install for blessings 17:04:58 INFO - Successfully installed blessings 17:04:58 INFO - Cleaning up... 17:04:58 INFO - Return code: 0 17:04:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:04:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:58 INFO - Reading from file tmpfile_stdout 17:04:58 INFO - Current package versions: 17:04:58 INFO - argparse == 1.2.1 17:04:58 INFO - blessings == 1.5.1 17:04:58 INFO - blobuploader == 1.2.4 17:04:58 INFO - docopt == 0.6.1 17:04:58 INFO - manifestparser == 1.1 17:04:58 INFO - mozInstall == 1.12 17:04:58 INFO - mozcrash == 0.16 17:04:58 INFO - mozdebug == 0.1 17:04:58 INFO - mozdevice == 0.47 17:04:58 INFO - mozfile == 1.2 17:04:58 INFO - mozhttpd == 0.7 17:04:58 INFO - mozinfo == 0.9 17:04:58 INFO - mozleak == 0.1 17:04:58 INFO - mozlog == 3.1 17:04:58 INFO - moznetwork == 0.27 17:04:58 INFO - mozprocess == 0.22 17:04:58 INFO - mozprofile == 0.28 17:04:58 INFO - mozrunner == 6.11 17:04:58 INFO - mozscreenshot == 0.1 17:04:58 INFO - mozsystemmonitor == 0.0 17:04:58 INFO - moztest == 0.7 17:04:58 INFO - mozversion == 1.4 17:04:58 INFO - psutil == 3.1.1 17:04:58 INFO - requests == 1.2.3 17:04:58 INFO - wsgiref == 0.1.2 17:04:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:58 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 17:04:58 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 17:04:58 INFO - Using env: {'DISPLAY': ':0', 17:04:58 INFO - 'HOME': '/home/cltbld', 17:04:58 INFO - 'LANG': 'en_US.UTF-8', 17:04:58 INFO - 'LANGUAGE': 'en_US:en', 17:04:58 INFO - 'LOGNAME': 'cltbld', 17:04:58 INFO - 'MAIL': '/var/mail/cltbld', 17:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:58 INFO - 'MOZ_NO_REMOTE': '1', 17:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:58 INFO - 'NO_EM_RESTART': '1', 17:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:58 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:58 INFO - 'SHELL': '/bin/bash', 17:04:58 INFO - 'SHLVL': '1', 17:04:58 INFO - 'TERM': 'linux', 17:04:58 INFO - 'TMOUT': '86400', 17:04:58 INFO - 'USER': 'cltbld', 17:04:58 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:58 INFO - '_': '/tools/buildbot/bin/python'} 17:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 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)) 17:04:58 INFO - Cleaning up... 17:04:58 INFO - Return code: 0 17:04:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:04:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:04:58 INFO - Using env: {'DISPLAY': ':0', 17:04:58 INFO - 'HOME': '/home/cltbld', 17:04:58 INFO - 'LANG': 'en_US.UTF-8', 17:04:58 INFO - 'LANGUAGE': 'en_US:en', 17:04:58 INFO - 'LOGNAME': 'cltbld', 17:04:58 INFO - 'MAIL': '/var/mail/cltbld', 17:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:58 INFO - 'MOZ_NO_REMOTE': '1', 17:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:58 INFO - 'NO_EM_RESTART': '1', 17:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:58 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:58 INFO - 'SHELL': '/bin/bash', 17:04:58 INFO - 'SHLVL': '1', 17:04:58 INFO - 'TERM': 'linux', 17:04:58 INFO - 'TMOUT': '86400', 17:04:58 INFO - 'USER': 'cltbld', 17:04:58 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:58 INFO - '_': '/tools/buildbot/bin/python'} 17:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:59 INFO - Downloading/unpacking jsonschema 17:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:05:00 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 17:05:00 INFO - Downloading/unpacking functools32 (from jsonschema) 17:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:00 INFO - Downloading functools32-3.2.3-2.tar.gz 17:05:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:05:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:05:00 INFO - warning: no files found matching '*.txt' 17:05:00 INFO - no previously-included directories found matching 'build' 17:05:00 INFO - no previously-included directories found matching 'dist' 17:05:00 INFO - no previously-included directories found matching '.git*' 17:05:00 INFO - Installing collected packages: jsonschema, functools32 17:05:01 INFO - Running setup.py install for functools32 17:05:01 INFO - warning: no files found matching '*.txt' 17:05:01 INFO - no previously-included directories found matching 'build' 17:05:01 INFO - no previously-included directories found matching 'dist' 17:05:01 INFO - no previously-included directories found matching '.git*' 17:05:01 INFO - Successfully installed jsonschema functools32 17:05:01 INFO - Cleaning up... 17:05:01 INFO - Return code: 0 17:05:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:01 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 0x7f56e66e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', '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 17:05:01 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 17:05:01 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 17:05:01 INFO - Using env: {'DISPLAY': ':0', 17:05:01 INFO - 'HOME': '/home/cltbld', 17:05:01 INFO - 'LANG': 'en_US.UTF-8', 17:05:01 INFO - 'LANGUAGE': 'en_US:en', 17:05:01 INFO - 'LOGNAME': 'cltbld', 17:05:01 INFO - 'MAIL': '/var/mail/cltbld', 17:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:01 INFO - 'MOZ_NO_REMOTE': '1', 17:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:01 INFO - 'NO_EM_RESTART': '1', 17:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:01 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:01 INFO - 'SHELL': '/bin/bash', 17:05:01 INFO - 'SHLVL': '1', 17:05:01 INFO - 'TERM': 'linux', 17:05:01 INFO - 'TMOUT': '86400', 17:05:01 INFO - 'USER': 'cltbld', 17:05:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:01 INFO - '_': '/tools/buildbot/bin/python'} 17:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:01 INFO - Downloading/unpacking flake8 17:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:05:03 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 17:05:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:05:03 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 17:05:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:05:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:05:03 INFO - no previously-included directories found matching 'docs/_build' 17:05:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:05:03 INFO - Running setup.py install for pep8 17:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:05:03 INFO - no previously-included directories found matching 'docs/_build' 17:05:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:05:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:05:03 INFO - Cleaning up... 17:05:04 INFO - Return code: 0 17:05:04 INFO - Running post-action listener: _resource_record_post_action 17:05:04 INFO - Running post-action listener: _start_resource_monitoring 17:05:04 INFO - Starting resource monitoring. 17:05:04 INFO - ##### 17:05:04 INFO - ##### Running install step. 17:05:04 INFO - ##### 17:05:04 INFO - Running pre-action listener: _resource_record_pre_action 17:05:04 INFO - Running main action method: install 17:05:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:05:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:05:04 INFO - Reading from file tmpfile_stdout 17:05:04 INFO - Detecting whether we're running mozinstall >=1.0... 17:05:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:05:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:05:04 INFO - Reading from file tmpfile_stdout 17:05:04 INFO - Output received: 17:05:04 INFO - Usage: mozinstall [options] installer 17:05:04 INFO - Options: 17:05:04 INFO - -h, --help show this help message and exit 17:05:04 INFO - -d DEST, --destination=DEST 17:05:04 INFO - Directory to install application into. [default: 17:05:04 INFO - "/builds/slave/test-pgo"] 17:05:04 INFO - --app=APP Application being installed. [default: firefox] 17:05:04 INFO - mkdir: /builds/slave/test-pgo/build/application 17:05:04 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'] 17:05:04 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 17:05:20 INFO - Reading from file tmpfile_stdout 17:05:20 INFO - Output received: 17:05:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:05:20 INFO - Running post-action listener: _resource_record_post_action 17:05:20 INFO - ##### 17:05:20 INFO - ##### Running run-tests step. 17:05:20 INFO - ##### 17:05:20 INFO - Running pre-action listener: _resource_record_pre_action 17:05:20 INFO - Running main action method: run_tests 17:05:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:05:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:05:20 INFO - Python 2.7.3 17:05:20 INFO - Return code: 0 17:05:20 INFO - grabbing minidump binary from tooltool 17: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')]} 17:05:20 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 0x2150660>, '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 0x2151560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2151a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:05:20 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 17:05:20 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 17:05:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:20 INFO - Return code: 0 17:05:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:05:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:05:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:05:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:05:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:05:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:05:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:05:21 INFO - Return code: 0 17:05:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 17:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 17:05:21 INFO - Using env: {'DISPLAY': ':0', 17:05:21 INFO - 'HOME': '/home/cltbld', 17:05:21 INFO - 'LANG': 'en_US.UTF-8', 17:05:21 INFO - 'LANGUAGE': 'en_US:en', 17:05:21 INFO - 'LOGNAME': 'cltbld', 17:05:21 INFO - 'MAIL': '/var/mail/cltbld', 17:05:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:05:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:21 INFO - 'MOZ_NO_REMOTE': '1', 17:05:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:21 INFO - 'NO_EM_RESTART': '1', 17:05:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:05:21 INFO - 'SHELL': '/bin/bash', 17:05:21 INFO - 'SHLVL': '1', 17:05:21 INFO - 'TERM': 'linux', 17:05:21 INFO - 'TMOUT': '86400', 17:05:21 INFO - 'USER': 'cltbld', 17:05:21 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299', 17:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:21 INFO - '_': '/tools/buildbot/bin/python'} 17:05:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:05:21 INFO - mozversion application_buildid: 20160104143010 17:05:21 INFO - mozversion application_changeset: 4ed8e9fdc7cc0e4ef4530d6cb0745a8a12f631ef 17:05:21 INFO - mozversion application_display_name: Nightly 17:05:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:21 INFO - mozversion application_name: Firefox 17:05:21 INFO - mozversion application_remotingname: firefox 17:05:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:05:21 INFO - mozversion application_vendor: Mozilla 17:05:21 INFO - mozversion application_version: 46.0a1 17:05:21 INFO - mozversion platform_buildid: 20160104143010 17:05:21 INFO - mozversion platform_changeset: 4ed8e9fdc7cc0e4ef4530d6cb0745a8a12f631ef 17:05:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:05:21 INFO - mozversion platform_version: 46.0a1 17:05:21 INFO - using testdate: 1451955921 17:05:21 INFO - actual date: 1451955921 17:05:21 INFO - starting webserver on 'localhost:38604' 17:05:21 INFO - SUITE-START | Running 3 tests 17:05:21 INFO - TEST-START | dromaeo_css 17:05:21 INFO - operating with platform_type : linux_ 17:05:21 INFO - Initialising browser for dromaeo_css test... 17:05:21 INFO - TEST-INFO | started process 1449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQqlrWY/profile http://localhost:38604/getInfo.html) 17:05:25 INFO - PROCESS | 1449 | __metrics Screen width/height:1600/1200 17:05:25 INFO - PROCESS | 1449 | colorDepth:24 17:05:25 INFO - PROCESS | 1449 | Browser inner width/height: 1024/697 17:05:25 INFO - PROCESS | 1449 | __metrics 17:05:25 INFO - PROCESS | 1449 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:05:25 INFO - PROCESS | 1449 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:05:26 INFO - TEST-INFO | 1449: exit 0 17:05:26 INFO - Browser initialized. 17:05:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:26 INFO - TEST-INFO | started process 1543 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQqlrWY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:38 INFO - PROCESS | 1543 | RSS: Main: 150417408 17:05:38 INFO - PROCESS | 1543 | 17:06:29 INFO - PROCESS | 1543 | 1451955989637 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] 17:08:38 INFO - PROCESS | 1543 | Cycle 1(1): loaded http://localhost:38604/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38604/tests/dromaeo/cssquery-ext.html) 17:08:39 INFO - PROCESS | 1543 | RSS: Main: 250228736 17:08:39 INFO - PROCESS | 1543 | 17:11:41 INFO - PROCESS | 1543 | Cycle 1(1): loaded http://localhost:38604/tests/dromaeo/cssquery-ext.html (next: http://localhost:38604/tests/dromaeo/cssquery-jquery.html) 17:11:42 INFO - PROCESS | 1543 | RSS: Main: 225783808 17:11:42 INFO - PROCESS | 1543 | 17:14:43 INFO - PROCESS | 1543 | Cycle 1(1): loaded http://localhost:38604/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38604/tests/dromaeo/cssquery-mootools.html) 17:14:44 INFO - PROCESS | 1543 | RSS: Main: 227393536 17:14:44 INFO - PROCESS | 1543 | 17:17:46 INFO - PROCESS | 1543 | Cycle 1(1): loaded http://localhost:38604/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38604/tests/dromaeo/cssquery-prototype.html) 17:17:46 INFO - PROCESS | 1543 | RSS: Main: 210866176 17:17:46 INFO - PROCESS | 1543 | 17:20:49 INFO - PROCESS | 1543 | Cycle 1(1): loaded http://localhost:38604/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38604/tests/dromaeo/cssquery-yui.html) 17:20:50 INFO - PROCESS | 1543 | RSS: Main: 215064576 17:20:50 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | Cycle 1(1): loaded http://localhost:38604/tests/dromaeo/cssquery-yui.html (next: http://localhost:38604/tests/dromaeo/cssquery-dojo.html) 17:23:52 INFO - PROCESS | 1543 | RSS: Main: 297037824 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | __start_tp_report 17:23:52 INFO - PROCESS | 1543 | _x_x_mozilla_page_load 17:23:52 INFO - PROCESS | 1543 | _x_x_mozilla_page_load_details 17:23:52 INFO - PROCESS | 1543 | |i|pagename|runs| 17:23:52 INFO - PROCESS | 1543 | |0;dojo.html;3020.3959208158367;3073.4775088234996;3113;3117.06488053584;3141.921451963701;5161.612879034078;5340.4926531979445;5350.678959262447;5374.408815030349;5406.080966235744;5301.522862942344;5328.387235467922;5403.972980135104;5408.215808707735;5412.107002344608;4781.306710526971;4816.855494335158;4826.469088400273;4950.851474455754;5008.198688209887;4898.436679781835;4921.606271498272;4953.3560637117125;4964.950350496485;5049.3435853339015;4750.596199323045;4825.372701548794;4853.150698627744;4918.581920536759;4918.631102667314;4889.119958407486;4892.461829198785;4907.190313598252;4923.926141107886;4941.604671626261;4832.371791667096;4870.65905386623;4882.731449770261;4888.706677599355;4946.975265123688;5018.723970181639;5063.797448102072;5128.384593848725;5178.119719647669;5208.817691380784;5713.714314284311;5735.0823868181305;5738.626989245686;5747.195392645033;5750.913736293959;5770.6249093808765;5779.826605201851;5793.044147715622;5801.129830525413;5802.941970580282;5284;5291.100512912814;5375.516203541661;5386.245925570423;5426.945730542723;5794.652320860678;5814.563907706939;5843.474087332075;5855.59010869235;5860.179574859523;5520.171974203901;5539.058360078796;5551.916721249185;5554.361248456398;5561.110222364402;5473.917891231635;5594.440555944373;5599.552035837123;5607.186957891083;5657.12314591239;5675.31896172462;5800.187973683687;5800.448957349129;5806.390329015477;5813.970930145322;5712.542996560265;5731.656100633892;5740.1102829061565;5744.770209191669;5774.538036957033;4411.7573533455325;4418.60232579063;4425.159219748238;4427.46870375557;4463.062756821104;3812.5806161322234;3872.1287710264965;3927.509061367329;3946;3950.940735888964;5249.763760630781;5288.365396152486;5297.496737809979;5297.8145764898045;5344.064788661969;5699.401562835926;5701.828945131652;5702.572307076985;5708.828735137952;5711.114777209539;5115.2582875483595;5208.921866172011;5211.661242019257;5228.241904923841;5316.308879845673;4854.247591623304;4855.975720121447;4856.635752318591;4857.708537487762;4898.191798353232;5952.226210592596;5960.165576819249;5963.970180149072;5965.105234214816;5965.612235204784;5605.943940560705;5662.57530685192;5727.112297593713;5727.369989301257;5739.139129130664;5968.940310596839;5992.221011268682;5999.9100013498955;6000.759969601167;6048.334683184934;5609.887802244014;5622.634528755618;5625.662460252398;5630.85922851932;5634.183043458757;5637.8590535236945;5717.199592057199;5729.770809167753;5745.971270143623;5750.079987202028;5566.972165139148;5613.831585052455;5642.407547207484;5647.463490968352;5695.288088988877;5577.191307260344;5604.6917419542315;5605.5795815313195;5613.691246981455;5615.045442274904;5372.919406208832;5439.891202176013;5508.476694713996;5517.089680202722;5531.585131115263;5637.52081073097;5638.126090455986;5640.464155905182;5666.546676265806;5698.458646428583;5509.311336082989;5518.586106041983;5519.061759500814;5520.006398848246;5520.475554822286 17:23:52 INFO - PROCESS | 1543 | |1;ext.html;516.6719133350322;547.1928904865324;561.4217356123193;569.3793764796371;598.8023952095808;28092.438151236962;28620.570691439643;28749.85625071874;35982.100447488825;36270.81864590674;38473.42289865647;38890.222195556074;38891.805540972324;38920.610793892054;39020.41469377962;8424.199701028409;8593.871091933626;8594.570271486433;8598.78503037426;8603.48379097253;7566.054243219598;7719.150893401749;10089.344192627455;10240.180785537139;10252.436116013616;9861.408315501058;9999.450030248334;10013.649522266722;10020.198384129251;10023.44871032093;7560.6975720971095;7737.767866964;9897.4556399398;9993.250506212064;9998.200143988464;10056.748581285454;10252.846207306897;10264.79470410595;10265.127464165555;10267.281290309682;36423.4536481953;36707.26585468276;36851.44722829133;36856.26287474235;36881.631183688085;3267.9019629411155;3385.86456541738;3455.4989526518766;3672.669459748609;3699.186179040607;27969.860150699114;27978.3005424864;28385.432291354264;29666.25834354137;30360.392792144256;3907.5310962684375;3909.8810361783717;3941.527016757979;3982.6614737747327;4089.44792453018;279914;280077.59961200267;280096;280585;280677.1424428926;51357.48642513602;58774;59083.70458147768;59174.40825591775;59175.704121479976;46542;62633;63467.68266158732;63504.682476587324;63515;13792.241426721426;13952.232627205602;14047;14067.085639433404;14241.857581424054;11079.279846809932;11092.889071109186;11099.611513597147;11101.555937762561;11175.217734758651;19243.326483573008;19402.12690428934;19418.514537136685;19459.12433940476;19577.119029643414;7285.526440781332;7290.4167666586545;7460.589667568336;7479.587043644167;7515.924840751522;918.3861504977933;936.4381371177375;994.5623925472913;1012.8733908261468;1028.0850043461326;28322.85838570794;28333.29166770806;28440.513506498544;28797.856010720232;28860.422791544053;1007.450939238117;1039.7088815131624;1043.1706793099504;1065.5577935156823;1113.3153110836777;13639.386227619583;13700.93149534246;13809.378577964017;13814.240216788174;14022.018458707793;295447;309907;310505;312211;312676;46227.382041628385;48553.27170092452;48798.26802597964;48813.75593122012;48834;1308.7840506316352;1320.3266334169643;1325.787873940165;1327.595083499542;1330.9866901331056;24295.878520607283;25160.37099072538;25861.353466162745;26636.8668156658;28587.28531786722;41781;42207.788961055;42215.366769497865;42338.364924525544;42353.36469952892;243405;244321;244410;244759;245051;26082.73917260879;31129.844350779007;31141.8442907784;31363.529547057267;31475.685243147276;35860.462093069145;36072.4589131158;36410.08974775546;36748.81625591855;37087.072823178554;30097.247568810955;31715.682843171275;35002.474962876084;35897.820510897276;36244.81877590595;31829.681703182672;32314.192145196557;32775.836120819244;33111.50332744962;34261.65738342684;34455.138621534665;34707.47938780971;35417.645823542465;36147;36165.45751813777;28485.715142848305;29233.707662923098;30235.546466803455;30238.09285721432;30407.847960760053;22644.773552264265;22971.310860674206;23225.651615226125;23234;23268.418289542897 17:23:52 INFO - PROCESS | 1543 | |2;jquery.html;353.8814497143457;363.4856677800911;363.82900036982625;364.1751433004245;364.7300997262027;14202.573922782307;14215.502457413993;16309.266083026263;16609.83390166098;17223.224954877012;15897.52307430776;16274.83725162748;16596.50210493687;16710;16736.16319184042;5106.540411362986;5202.739863006854;5203.9219411708855;5215.191645294966;5223.2165175223645;4000.8599699010542;4092.6930480213955;5216.374035115791;5246.396664383607;5715.942840571583;5821.854453638672;5867.2372591563035;5871.266091738533;5910.645361278337;5910.852228694274;5735.397783232763;5928.644281343133;5928.851778705523;5938.851528711773;5945.405459454041;5157.8452646420665;5160.896782064376;5161.922571161435;5168.457311982263;5185.844424667266;19973.101210445566;20703.17187312506;20931;21876.343709688736;22052.11791528353;2190.113004233272;2248.5390494948497;2277.840551161419;2324.395657129142;2372.383180373098;12859.614211573667;13036.674083147902;13039.608811735663;13311.467541298336;13456;1732.2031865341958;1745.9127043647766;1762.5769815244378;1773.494554052089;1813.8186181381889;57567.71216143934;59757.804843903315;59898.700506497626;60063.69968150131;61859.69070154666;9518.143367096995;9706.466144362128;9823.36148150368;9838.754031149136;9897.406155630686;12772.297523636289;12799.552015679406;12810.295433751233;12827.935860320638;12857;7217;7290.088738907637;7475;7586.62066896653;7735.806604834924;7110.608916509642;7117.89323160153;7685.154632990367;7775.533467991939;7781.182975787574;5921.082232254007;5996.2504686914135;6000.579959402888;6005.39946005396;6047.879042419127;1640.1553200101957;1677.0859881364686;1677.8825482216128;1682.9074400908069;1703.4038086669814;924.7225832250433;954.2080073538946;975.4293738163254;1001.4542074569378;1043.546057465005;15835.68328633421;16393.016419014897;16929.238184281738;17775.73336399955;17850.464486065437;911.9908800911905;950;974.6247694637616;1018.765683892694;1032.6901929421144;8890.4665720057;8956.462612243286;9043.18611324984;9233.169014788702;9520.904790952001;411805;588582;603446;605843;606556;42594.78702606529;42716;42781;76237;76596.61701691567;1068.076114161245;1097.160672085855;1100.6147848253208;1101.7576133250673;1128.5655022816275;14450.205238711971;14841.85158148448;15052.54842354731;15241.23793810283;15401.305856356015;34189.658103418646;34637;34855;35321.470177947864;36067.63932360748;46794;47354.52645473501;47910;49708.25437618511;50524.24213636725;8946.418482798597;9223.953880230556;9306.255499559884;9324.766880828034;9345.626174952926;10975.890241097806;11158.218924675195;11168.832467512831;11182.552697892319;12269.754604907674;2903.3902880395353;12708.157317189141;13203.801942970671;14332.928335358256;14616.488422905148;13496.257705825881;13876.653083672989;14308.141511509342;14771.852281477048;14847.33187006609;13898.722025559635;14102.647433814236;14193.503227386991;14237.35931883047;14577.85422145765;9318.860217096613;9441.244700424088;9522.285828562746;9624.566894489904;9631.566579504079;13740.10689305192;13941.093828901088;14005.43978240859;14160;14430.350634221695 17:23:52 INFO - PROCESS | 1543 | |3;mootools.html;1308.4635299527197;1461.1160248049932;1470.0811992504684;1624.3177865296575;1808.8914665120094;6910.654467276641;7533.3596644285235;7644.770656880289;7677.808054798633;7686.615669216538;7448.590327531997;7664.616769161547;7670.96164519178;7682.769516914502;7683.308502234798;2283.4976305212826;2317.2353123469215;2318.5594737;2322.1059891941554;2324.1981516376823;2288.8626682399026;2307.042577330406;2345.0033735662273;2355.8233132515043;2360.480694247263;2264.2527965771337;2264.5923733727923;2300.96548551771;2307.573098976695;2313.7686231376897;2259.2092767531317;2278.7493375728573;2281.885905704708;2282.9771702282933;2289.1987804268456;2296.0700916128994;2314.618088015475;2319.5476882008015;2319.5824751544715;2319.7796209360085;7665.233476652346;7713.768586942345;7737.032870891138;7749.845003099963;7762.650680719381;4588.0365123324145;4653.488116307203;4684.859454216345;4687.062587482483;4697.342372067913;3078.5843911071943;3114.423831591163;3147.6380216275193;3157.6684448132846;3178.6503484616674;1011.549860312154;1030.8969103089705;1063.5639387850945;1078.9892101078967;1080.2924084724439;10809.081228095622;10821;10823.67528974132;10831.620893268777;10838.67483975482;4242.045539753531;4283.378910058086;4331.480222373335;4335.653147748172;4354.063876266555;9151.725448236564;9160.770980725536;9169.495677737788;9176.174144327042;9185.494797786052;4723.7874295656775;4724.503927087606;4734.857954261378;4736.597389221886;4741.075490279362;3827.349350610403;3888.066863952631;3937.9803100984313;4218.050938538804;4335.4363932689175;3596.2088340565033;3618.6924111450294;3624.836882340301;3640.890773276806;3660.633936606371;1190.9166358355005;1202.5310129049678;1205.5900993662196;1221.5052903574067;1223.9755204895853;988.6045581767207;1006.8389057750725;1007.4660429972126;1098.1434481104752;1280.4494067550856;6941;7002.439804815603;7062.329078737512;7071.823204419828;7072.080629518233;483.69285503704697;488.5505335091724;504.87630530520255;505.2043032224262;507.4975773983729;5396.784128634889;5461.617686761889;5470.8085217017215;5477.123660214346;5478.91781623268;9168.633254669872;9173.266138708887;9202.539873006323;9274.629014839331;9425.905740942502;9196.678116265899;9225.769355766159;9228.7692807679;9298.116678915492;9313.068693130634;7174.426045916314;7351.742689005859;7389.926100739031;7396.223396543393;7413.555186688816;6796.456283497408;6847.041414201916;6848.828779280558;6856.554323968926;6859.2454829969665;8239.835203296021;8304.916950830657;8496.447730897471;8509.064002959793;8513.06356300794;8497.617607207567;8600.39797214189;8685.174908383693;8794.296456283353;8795.560221989002;6084.604500707617;6203.503719702323;6207.782727604512;6550.541462097607;6563.671816409256;6863.897041544481;6912.930870691229;7092.25531319204;7265.564066156047;7308;6729.394354507922;6873.243943166148;6873.553219040747;7000.22997470288;7010.789676309719;6758.4931130166415;6774;6817.522773406013;6859.142607174103;6904.344087311697;6628.105205797348;6739.966300168468;6867.759628412981;6893.310668933066;6916.170059592881;6170.167027451236;6188.226471691039;6200.286966998672;6207.81376558704;6212.627242365473;6189.319174890668;6241.937580624136;6243.157173781481;6243.43809057187;6259.2488901332135 17:23:52 INFO - PROCESS | 1543 | |4;prototype.html;331.3323652839528;336.15960099750623;338.1647331092202;340.2158025750644;342.4725922079997;5770.365259821417;5906.4979476744475;5917.970410147954;5924.081767326066;5931.555133364998;5719.742611582478;5837.795677151301;5864.648121112737;5875.206847075643;5882.264716910387;4532.546745325474;4540.432445944257;4541.159885421192;4546.386237857896;4550.203714349992;4273.487181538219;4373.169097871394;4377.584129507692;4383.824647014116;4543.250363689987;4394.846180383687;4484.932726009112;4487.775611219442;4501.932471012938;4505.098980203956;4465.799039043251;4470.262406702906;4497.325401189848;4502.2571275739465;4512.300593407994;3973.9602603974167;3974.5429275633383;3976.906350753537;3979.383195604686;3985.1830374773103;5420.539254163401;5564.916526252109;5569.610127291091;5590.496855283044;5591.10542313228;5178.766955486974;5182.585393168538;5184.7148406837605;5185.118529849935;5188.273641690166;5895.911561326584;6212.316645169028;6224.253089629228;6236.844078898019;6237.812865614039;4182.059036716745;4342.934855977162;4411.492678342;4412.139632771611;4434.55876840025;6311.779087731953;6500.902486462707;6501.804945851632;6503.317151699051;6505.056766768792;4491.191585514639;4491.393661855673;4497.797599107983;4500.752458614742;4503.166914120898;4478.57453541913;4558.0655965526985;4565.543445655408;4570.520095389937;4577.06170235101;5237.973810130925;5239.502247286502;5243.606729495303;5245.501677340647;5255.211718242294;6235.220597425322;6258.655773932477;6271.717772700239;6274.1843560336865;6275.466585340298;1606.5019843848445;1625.8699304055647;1626.8454496822783;1628.5521481592657;1629.4296996051523;1098.1160166066234;1101.779644071189;1107.2858006585868;1125.1617544928918;1133.6485689436302;5865.560082993792;5878.853028674317;5883.61756485827;5884.146798714162;5885.735141918538;6369.745210191633;6382.457491113308;6387.808365749035;6391.2330520337855;6397.52018598607;5873.353931067579;5875.148103524965;5886.470217680429;5888.028475301613;5890.705464726747;3388.5764279465066;3483.407820670492;3485.0590340607896;3485.1461391959133;3492.231709024011;6749.831254218684;6767.898481522781;6779.0509328694025;6780.355866192704;6780.72877084911;6711.295313991961;6712.966435167793;6717.261101278856;6719.992001199859;6720.899186512206;6546.0835483032415;6737.124173857367;6740.090087838177;6747.122874026443;6752.155980502437;6208;6349.841253968688;6451.2903580607035;6459.709313081016;6468.838279043061;6285.371462853678;6416.197975253093;6419.454346380423;6423.100765892686;6444.355564443518;6701.463882889455;6708.496862735412;6712.83217919556;6714.932850671431;6727.428168605527;4294.1411717655965;4380.167768124174;4414.757188354672;4416.07262474871;4421.182081314967;6463.224413070461;6480.546361754632;6481.481481481376;6482.546221764431;6488.767134244478;6249.031400132987;6297.96851015742;6309.747610095545;6309.842253943688;6311.116443697978;6177.876442471215;6212.534059945432;6277.30949595535;6281.748730050746;6289.371062893674;6155.045967874987;6156.907646385218;6158.692065396802;6162.414570615784;6164.753409863555;6278;6288.685565721604;6293.811185664437;6300.338464461165;6304.243490781136;6057.394260573908;6124.510039196943;6133.815985520441;6138.386161383826;6144.262688477412 17:23:52 INFO - PROCESS | 1543 | |5;yui.html;762.2187258060486;831.629924683516;847.9279261262792;864.5849992003837;891.9152680495355;13294.867051329496;13501.662458438544;13510.054296199258;13518.797218041713;13520.526781562647;11864.644060678173;12044.819327710069;12092.879071209285;12112.636620901365;12123.393830308494;672.6804767735335;814.3363159025375;826.6404114210337;828.3662997806682;828.4904783558098;813.0487329824091;814.238686827815;822.0792712162356;822.313368337439;822.7449490657885;712.1952194020749;723.3995783499682;861.1431625532604;867.0419186798559;867.4274978514181;850.0394554153828;862.7972426479772;870.7474832298626;871.7689812199773;872.3239489395705;636.6084857812458;639.9520035997319;641.0160403780175;641.2241188162329;641.3009819296942;13108.2135071896;13158.21050736959;13164.14433061848;13211.273379964097;13235.933820330836;11802.881971180264;12224.511019559208;12280.570180043656;12434.62696119118;12543.686407839878;10025.19798416125;10289.691309260734;10375.740606484822;11093.889061109367;11250.606228782035;3639.581448133472;3648.525691660094;3665.193657395369;3680.613535578779;3808.771473711586;42750.358744618854;42810.57189428128;43022.35466468005;43135.56864431347;43777.12445751067;8999.910000900038;9391.953040234892;9794.853077203848;9890.65382711616;9894.406335619886;17927.820721792876;17977.820221797876;18041.09794510269;18103.275868965095;18116.547086322946;7628;7691.077070751546;7717.112532058773;7746.690132394641;7834.725784597512;4179.393987871802;4189.2668782962855;4220.303649897733;4256.2551553478015;4274.482410118413;3103.6896310369234;3124.9375012500077;3127.3901589190345;3130.280035591781;3133.5769671094113;565.6238601330069;571.7341436232172;580.2398857496693;587.8119001919345;592.2537602620729;539.5764325004931;560.3052215253139;569.3537834557807;588.9469947704728;657.2671471309455;8536.359773017048;9039.096090390909;9062.50156241413;9076.183143517115;9263.212626926786;558.6620094842643;573.5239751006654;604.3714536881594;621.9036049412348;629.4052120745943;3963.6432721055244;3978.244133614604;4005.315110098658;4025.255327764373;4042.3734321180264;50499.495005050216;52030;53253.46746532485;53323.20015199775;53774.731126344115;47923.76038119857;48275;48747;49316;50092.24861627079;43832.56167438285;44260.77869610631;44954;45404.54595454069;49162.99999999929;8473.95763021181;8551;9065.229455496357;9146.862797057916;9168.679096231866;33393.83303083469;33780.15549611279;34348.82825585856;34475.13812154716;34691.7959868052;38783.12168783212;39078.60921390863;39375.606243937196;42617;42685.359719603606;10362.948185259025;10422.654902646844;10774.353538787698;11128.38793866345;11255.437228138397;11445.25605835618;11492;11838.408079596158;12023.27860328383;12377.938110309391;11742;12051.75896482083;12154.209976351509;12293.75412491763;12410.379481025731;11332.206745527734;11826.52693892269;11849.05207583374;12182.451789669663;12285.877141228832;10820.67537973862;11121.388323642277;11125.276857004268;11159.10727141843;11368.335052034532;9160.816783664422;9366.484843333683;9427.905720942977;9562.99588543193;9618.474794660813;9243.676471323472;9340.626374944926;9464.589670932965;9670.75823104428;9678.17735492491 17:23:52 INFO - PROCESS | 1543 | __end_tp_report 17:23:52 INFO - PROCESS | 1543 | __start_cc_report 17:23:52 INFO - PROCESS | 1543 | _x_x_mozilla_cycle_collect,777 17:23:52 INFO - PROCESS | 1543 | __end_cc_report 17:23:52 INFO - PROCESS | 1543 | __startTimestamp1451957032871__endTimestamp 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | ------- Summary: start ------- 17:23:52 INFO - PROCESS | 1543 | Number of tests: 6 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | [#0] dojo.html Cycles:165 Average:5304.56 Median:5519.06 stddev:602.82 (10.9%) stddev-sans-first:577.42 17:23:52 INFO - PROCESS | 1543 | Values: 3020.4 3073.5 3113.0 3117.1 3141.9 5161.6 5340.5 5350.7 5374.4 5406.1 5301.5 5328.4 5404.0 5408.2 5412.1 4781.3 4816.9 4826.5 4950.9 5008.2 4898.4 4921.6 4953.4 4965.0 5049.3 4750.6 4825.4 4853.2 4918.6 4918.6 4889.1 4892.5 4907.2 4923.9 4941.6 4832.4 4870.7 4882.7 4888.7 4947.0 5018.7 5063.8 5128.4 5178.1 5208.8 5713.7 5735.1 5738.6 5747.2 5750.9 5770.6 5779.8 5793.0 5801.1 5802.9 5284.0 5291.1 5375.5 5386.2 5426.9 5794.7 5814.6 5843.5 5855.6 5860.2 5520.2 5539.1 5551.9 5554.4 5561.1 5473.9 5594.4 5599.6 5607.2 5657.1 5675.3 5800.2 5800.4 5806.4 5814.0 5712.5 5731.7 5740.1 5744.8 5774.5 4411.8 4418.6 4425.2 4427.5 4463.1 3812.6 3872.1 3927.5 3946.0 3950.9 5249.8 5288.4 5297.5 5297.8 5344.1 5699.4 5701.8 5702.6 5708.8 5711.1 5115.3 5208.9 5211.7 5228.2 5316.3 4854.2 4856.0 4856.6 4857.7 4898.2 5952.2 5960.2 5964.0 5965.1 5965.6 5605.9 5662.6 5727.1 5727.4 5739.1 5968.9 5992.2 5999.9 6000.8 6048.3 5609.9 5622.6 5625.7 5630.9 5634.2 5637.9 5717.2 5729.8 5746.0 5750.1 5567.0 5613.8 5642.4 5647.5 5695.3 5577.2 5604.7 5605.6 5613.7 5615.0 5372.9 5439.9 5508.5 5517.1 5531.6 5637.5 5638.1 5640.5 5666.5 5698.5 5509.3 5518.6 5519.1 5520.0 5520.5 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | [#1] ext.html Cycles:180 Average:43803.79 Median:31419.61 stddev:72855.94 (231.9%) stddev-sans-first:72987.82 17:23:52 INFO - PROCESS | 1543 | Values: 516.7 547.2 561.4 569.4 598.8 28092.4 28620.6 28749.9 35982.1 36270.8 38473.4 38890.2 38891.8 38920.6 39020.4 8424.2 8593.9 8594.6 8598.8 8603.5 7566.1 7719.2 10089.3 10240.2 10252.4 9861.4 9999.5 10013.6 10020.2 10023.4 7560.7 7737.8 9897.5 9993.3 9998.2 10056.7 10252.8 10264.8 10265.1 10267.3 36423.5 36707.3 36851.4 36856.3 36881.6 3267.9 3385.9 3455.5 3672.7 3699.2 27969.9 27978.3 28385.4 29666.3 30360.4 3907.5 3909.9 3941.5 3982.7 4089.4 279914.0 280077.6 280096.0 280585.0 280677.1 51357.5 58774.0 59083.7 59174.4 59175.7 46542.0 62633.0 63467.7 63504.7 63515.0 13792.2 13952.2 14047.0 14067.1 14241.9 11079.3 11092.9 11099.6 11101.6 11175.2 19243.3 19402.1 19418.5 19459.1 19577.1 7285.5 7290.4 7460.6 7479.6 7515.9 918.4 936.4 994.6 1012.9 1028.1 28322.9 28333.3 28440.5 28797.9 28860.4 1007.5 1039.7 1043.2 1065.6 1113.3 13639.4 13700.9 13809.4 13814.2 14022.0 295447.0 309907.0 310505.0 312211.0 312676.0 46227.4 48553.3 48798.3 48813.8 48834.0 1308.8 1320.3 1325.8 1327.6 1331.0 24295.9 25160.4 25861.4 26636.9 28587.3 41781.0 42207.8 42215.4 42338.4 42353.4 243405.0 244321.0 244410.0 244759.0 245051.0 26082.7 31129.8 31141.8 31363.5 31475.7 35860.5 36072.5 36410.1 36748.8 37087.1 30097.2 31715.7 35002.5 35897.8 36244.8 31829.7 32314.2 32775.8 33111.5 34261.7 34455.1 34707.5 35417.6 36147.0 36165.5 28485.7 29233.7 30235.5 30238.1 30407.8 22644.8 22971.3 23225.7 23234.0 23268.4 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | [#2] jquery.html Cycles:180 Average:28722.90 Median:363.66 stddev:92644.85 (25475.9%) stddev-sans-first:92880.26 17:23:52 INFO - PROCESS | 1543 | Values: 353.9 363.5 363.8 364.2 364.7 14202.6 14215.5 16309.3 16609.8 17223.2 15897.5 16274.8 16596.5 16710.0 16736.2 5106.5 5202.7 5203.9 5215.2 5223.2 4000.9 4092.7 5216.4 5246.4 5715.9 5821.9 5867.2 5871.3 5910.6 5910.9 5735.4 5928.6 5928.9 5938.9 5945.4 5157.8 5160.9 5161.9 5168.5 5185.8 19973.1 20703.2 20931.0 21876.3 22052.1 2190.1 2248.5 2277.8 2324.4 2372.4 12859.6 13036.7 13039.6 13311.5 13456.0 1732.2 1745.9 1762.6 1773.5 1813.8 57567.7 59757.8 59898.7 60063.7 61859.7 9518.1 9706.5 9823.4 9838.8 9897.4 12772.3 12799.6 12810.3 12827.9 12857.0 7217.0 7290.1 7475.0 7586.6 7735.8 7110.6 7117.9 7685.2 7775.5 7781.2 5921.1 5996.3 6000.6 6005.4 6047.9 1640.2 1677.1 1677.9 1682.9 1703.4 924.7 954.2 975.4 1001.5 1043.5 15835.7 16393.0 16929.2 17775.7 17850.5 912.0 950.0 974.6 1018.8 1032.7 8890.5 8956.5 9043.2 9233.2 9520.9 411805.0 588582.0 603446.0 605843.0 606556.0 42594.8 42716.0 42781.0 76237.0 76596.6 1068.1 1097.2 1100.6 1101.8 1128.6 14450.2 14841.9 15052.5 15241.2 15401.3 34189.7 34637.0 34855.0 35321.5 36067.6 46794.0 47354.5 47910.0 49708.3 50524.2 8946.4 9224.0 9306.3 9324.8 9345.6 10975.9 11158.2 11168.8 11182.6 12269.8 2903.4 12708.2 13203.8 14332.9 14616.5 13496.3 13876.7 14308.1 14771.9 14847.3 13898.7 14102.6 14193.5 14237.4 14577.9 9318.9 9441.2 9522.3 9624.6 9631.6 13740.1 13941.1 14005.4 14160.0 14430.4 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | [#3] mootools.html Cycles:180 Average:5357.78 Median:6179.20 stddev:2807.70 (45.4%) stddev-sans-first:2799.08 17:23:52 INFO - PROCESS | 1543 | Values: 1308.5 1461.1 1470.1 1624.3 1808.9 6910.7 7533.4 7644.8 7677.8 7686.6 7448.6 7664.6 7671.0 7682.8 7683.3 2283.5 2317.2 2318.6 2322.1 2324.2 2288.9 2307.0 2345.0 2355.8 2360.5 2264.3 2264.6 2301.0 2307.6 2313.8 2259.2 2278.7 2281.9 2283.0 2289.2 2296.1 2314.6 2319.5 2319.6 2319.8 7665.2 7713.8 7737.0 7749.8 7762.7 4588.0 4653.5 4684.9 4687.1 4697.3 3078.6 3114.4 3147.6 3157.7 3178.7 1011.5 1030.9 1063.6 1079.0 1080.3 10809.1 10821.0 10823.7 10831.6 10838.7 4242.0 4283.4 4331.5 4335.7 4354.1 9151.7 9160.8 9169.5 9176.2 9185.5 4723.8 4724.5 4734.9 4736.6 4741.1 3827.3 3888.1 3938.0 4218.1 4335.4 3596.2 3618.7 3624.8 3640.9 3660.6 1190.9 1202.5 1205.6 1221.5 1224.0 988.6 1006.8 1007.5 1098.1 1280.4 6941.0 7002.4 7062.3 7071.8 7072.1 483.7 488.6 504.9 505.2 507.5 5396.8 5461.6 5470.8 5477.1 5478.9 9168.6 9173.3 9202.5 9274.6 9425.9 9196.7 9225.8 9228.8 9298.1 9313.1 7174.4 7351.7 7389.9 7396.2 7413.6 6796.5 6847.0 6848.8 6856.6 6859.2 8239.8 8304.9 8496.4 8509.1 8513.1 8497.6 8600.4 8685.2 8794.3 8795.6 6084.6 6203.5 6207.8 6550.5 6563.7 6863.9 6912.9 7092.3 7265.6 7308.0 6729.4 6873.2 6873.6 7000.2 7010.8 6758.5 6774.0 6817.5 6859.1 6904.3 6628.1 6740.0 6867.8 6893.3 6916.2 6170.2 6188.2 6200.3 6207.8 6212.6 6189.3 6241.9 6243.2 6243.4 6259.2 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | [#4] prototype.html Cycles:180 Average:5228.59 Median:5883.88 stddev:1569.18 (26.7%) stddev-sans-first:1529.92 17:23:52 INFO - PROCESS | 1543 | Values: 331.3 336.2 338.2 340.2 342.5 5770.4 5906.5 5918.0 5924.1 5931.6 5719.7 5837.8 5864.6 5875.2 5882.3 4532.5 4540.4 4541.2 4546.4 4550.2 4273.5 4373.2 4377.6 4383.8 4543.3 4394.8 4484.9 4487.8 4501.9 4505.1 4465.8 4470.3 4497.3 4502.3 4512.3 3974.0 3974.5 3976.9 3979.4 3985.2 5420.5 5564.9 5569.6 5590.5 5591.1 5178.8 5182.6 5184.7 5185.1 5188.3 5895.9 6212.3 6224.3 6236.8 6237.8 4182.1 4342.9 4411.5 4412.1 4434.6 6311.8 6500.9 6501.8 6503.3 6505.1 4491.2 4491.4 4497.8 4500.8 4503.2 4478.6 4558.1 4565.5 4570.5 4577.1 5238.0 5239.5 5243.6 5245.5 5255.2 6235.2 6258.7 6271.7 6274.2 6275.5 1606.5 1625.9 1626.8 1628.6 1629.4 1098.1 1101.8 1107.3 1125.2 1133.6 5865.6 5878.9 5883.6 5884.1 5885.7 6369.7 6382.5 6387.8 6391.2 6397.5 5873.4 5875.1 5886.5 5888.0 5890.7 3388.6 3483.4 3485.1 3485.1 3492.2 6749.8 6767.9 6779.1 6780.4 6780.7 6711.3 6713.0 6717.3 6720.0 6720.9 6546.1 6737.1 6740.1 6747.1 6752.2 6208.0 6349.8 6451.3 6459.7 6468.8 6285.4 6416.2 6419.5 6423.1 6444.4 6701.5 6708.5 6712.8 6714.9 6727.4 4294.1 4380.2 4414.8 4416.1 4421.2 6463.2 6480.5 6481.5 6482.5 6488.8 6249.0 6298.0 6309.7 6309.8 6311.1 6177.9 6212.5 6277.3 6281.7 6289.4 6155.0 6156.9 6158.7 6162.4 6164.8 6278.0 6288.7 6293.8 6300.3 6304.2 6057.4 6124.5 6133.8 6138.4 6144.3 17:23:52 INFO - PROCESS | 1543 | 17:23:52 INFO - PROCESS | 1543 | [#5] yui.html Cycles:180 Average:13270.53 Median:44046.67 stddev:14825.14 (33.7%) stddev-sans-first:14836.96 17:23:52 INFO - PROCESS | 1543 | Values: 762.2 831.6 847.9 864.6 891.9 13294.9 13501.7 13510.1 13518.8 13520.5 11864.6 12044.8 12092.9 12112.6 12123.4 672.7 814.3 826.6 828.4 828.5 813.0 814.2 822.1 822.3 822.7 712.2 723.4 861.1 867.0 867.4 850.0 862.8 870.7 871.8 872.3 636.6 640.0 641.0 641.2 641.3 13108.2 13158.2 13164.1 13211.3 13235.9 11802.9 12224.5 12280.6 12434.6 12543.7 10025.2 10289.7 10375.7 11093.9 11250.6 3639.6 3648.5 3665.2 3680.6 3808.8 42750.4 42810.6 43022.4 43135.6 43777.1 8999.9 9392.0 9794.9 9890.7 9894.4 17927.8 17977.8 18041.1 18103.3 18116.5 7628.0 7691.1 7717.1 7746.7 7834.7 4179.4 4189.3 4220.3 4256.3 4274.5 3103.7 3124.9 3127.4 3130.3 3133.6 565.6 571.7 580.2 587.8 592.3 539.6 560.3 569.4 588.9 657.3 8536.4 9039.1 9062.5 9076.2 9263.2 558.7 573.5 604.4 621.9 629.4 3963.6 3978.2 4005.3 4025.3 4042.4 50499.5 52030.0 53253.5 53323.2 53774.7 47923.8 48275.0 48747.0 49316.0 50092.2 43832.6 44260.8 44954.0 45404.5 49163.0 8474.0 8551.0 9065.2 9146.9 9168.7 33393.8 33780.2 34348.8 34475.1 34691.8 38783.1 39078.6 39375.6 42617.0 42685.4 10362.9 10422.7 10774.4 11128.4 11255.4 11445.3 11492.0 11838.4 12023.3 12377.9 11742.0 12051.8 12154.2 12293.8 12410.4 11332.2 11826.5 11849.1 12182.5 12285.9 10820.7 11121.4 11125.3 11159.1 11368.3 9160.8 9366.5 9427.9 9563.0 9618.5 9243.7 9340.6 9464.6 9670.8 9678.2 17:23:52 INFO - PROCESS | 1543 | -------- Summary: end -------- 17:23:52 INFO - PROCESS | 1543 | 17:23:53 INFO - TEST-INFO | 1543: exit 0 17:23:53 INFO - TEST-OK | dromaeo_css | took 1112217ms 17:23:53 INFO - TEST-START | kraken 17:23:53 INFO - operating with platform_type : linux_ 17:23:53 INFO - Initialising browser for kraken test... 17:23:53 INFO - TEST-INFO | started process 1742 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi6v5NH/profile http://localhost:38604/getInfo.html) 17:23:57 INFO - PROCESS | 1742 | __metrics Screen width/height:1600/1200 17:23:57 INFO - PROCESS | 1742 | colorDepth:24 17:23:57 INFO - PROCESS | 1742 | Browser inner width/height: 1024/697 17:23:57 INFO - PROCESS | 1742 | __metrics 17:23:57 INFO - PROCESS | 1742 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:57 INFO - PROCESS | 1742 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:23:58 INFO - TEST-INFO | 1742: exit 0 17:23:58 INFO - Browser initialized. 17:23:58 INFO - Running cycle 1/1 for kraken test... 17:23:58 INFO - TEST-INFO | started process 1826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi6v5NH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:10 INFO - PROCESS | 1826 | RSS: Main: 150327296 17:24:10 INFO - PROCESS | 1826 | 17:24:12 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38604/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:13 INFO - PROCESS | 1826 | RSS: Main: 184225792 17:24:13 INFO - PROCESS | 1826 | 17:24:16 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38604/tests/kraken/driver.html?testName=audio-dft) 17:24:16 INFO - PROCESS | 1826 | RSS: Main: 174301184 17:24:16 INFO - PROCESS | 1826 | 17:24:19 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38604/tests/kraken/driver.html?testName=audio-fft) 17:24:19 INFO - PROCESS | 1826 | RSS: Main: 160915456 17:24:19 INFO - PROCESS | 1826 | 17:24:21 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38604/tests/kraken/driver.html?testName=audio-oscillator) 17:24:22 INFO - PROCESS | 1826 | RSS: Main: 163438592 17:24:22 INFO - PROCESS | 1826 | 17:24:24 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38604/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:25 INFO - PROCESS | 1826 | RSS: Main: 165343232 17:24:25 INFO - PROCESS | 1826 | 17:24:28 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38604/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:28 INFO - PROCESS | 1826 | RSS: Main: 165257216 17:24:28 INFO - PROCESS | 1826 | 17:24:32 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38604/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:32 INFO - PROCESS | 1826 | RSS: Main: 166522880 17:24:32 INFO - PROCESS | 1826 | 17:24:35 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38604/tests/kraken/driver.html?testName=json-parse-financial) 17:24:36 INFO - PROCESS | 1826 | RSS: Main: 166010880 17:24:36 INFO - PROCESS | 1826 | 17:24:37 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38604/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:38 INFO - PROCESS | 1826 | RSS: Main: 176033792 17:24:38 INFO - PROCESS | 1826 | 17:24:39 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:40 INFO - PROCESS | 1826 | RSS: Main: 173998080 17:24:40 INFO - PROCESS | 1826 | 17:24:42 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:43 INFO - PROCESS | 1826 | RSS: Main: 186245120 17:24:43 INFO - PROCESS | 1826 | 17:24:45 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:46 INFO - PROCESS | 1826 | RSS: Main: 194764800 17:24:46 INFO - PROCESS | 1826 | 17:24:48 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:49 INFO - PROCESS | 1826 | RSS: Main: 192286720 17:24:49 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:38604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38604/tests/kraken/driver.html?testName=ai-astar) 17:24:51 INFO - PROCESS | 1826 | RSS: Main: 250011648 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | __start_tp_report 17:24:51 INFO - PROCESS | 1826 | _x_x_mozilla_page_load 17:24:51 INFO - PROCESS | 1826 | _x_x_mozilla_page_load_details 17:24:51 INFO - PROCESS | 1826 | |i|pagename|runs| 17:24:51 INFO - PROCESS | 1826 | |0;ai-astar;110;111;104;109;110;111;98;110;111;114 17:24:51 INFO - PROCESS | 1826 | |1;audio-beat-detection;155;129;152;162;125;150;149;123;162;123 17:24:51 INFO - PROCESS | 1826 | |2;audio-dft;162;161;161;161;162;163;160;161;161;161 17:24:51 INFO - PROCESS | 1826 | |3;audio-fft;71;73;87;96;73;73;71;112;91;71 17:24:51 INFO - PROCESS | 1826 | |4;audio-oscillator;96;98;137;96;96;96;144;96;98;138 17:24:51 INFO - PROCESS | 1826 | |5;imaging-gaussian-blur;109;110;109;109;109;110;109;109;109;110 17:24:51 INFO - PROCESS | 1826 | |6;imaging-darkroom;145;146;145;146;146;146;146;146;146;146 17:24:51 INFO - PROCESS | 1826 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;96 17:24:51 INFO - PROCESS | 1826 | |8;json-parse-financial;56;57;58;56;57;56;55;65;54;54 17:24:51 INFO - PROCESS | 1826 | |9;json-stringify-tinderbox;67;67;68;67;67;68;67;69;68;67 17:24:51 INFO - PROCESS | 1826 | |10;stanford-crypto-aes;85;94;87;86;85;85;85;93;90;93 17:24:51 INFO - PROCESS | 1826 | |11;stanford-crypto-ccm;116;126;120;114;116;114;124;119;116;116 17:24:51 INFO - PROCESS | 1826 | |12;stanford-crypto-pbkdf2;149;169;153;154;165;155;155;154;155;142 17:24:51 INFO - PROCESS | 1826 | |13;stanford-crypto-sha256-iterative;68;67;71;68;69;68;67;69;69;68 17:24:51 INFO - PROCESS | 1826 | __end_tp_report 17:24:51 INFO - PROCESS | 1826 | __start_cc_report 17:24:51 INFO - PROCESS | 1826 | _x_x_mozilla_cycle_collect,910 17:24:51 INFO - PROCESS | 1826 | __end_cc_report 17:24:51 INFO - PROCESS | 1826 | __startTimestamp1451957091355__endTimestamp 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | ------- Summary: start ------- 17:24:51 INFO - PROCESS | 1826 | Number of tests: 14 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.54 (4.1%) stddev-sans-first:4.80 17:24:51 INFO - PROCESS | 1826 | Values: 110.0 111.0 104.0 109.0 110.0 111.0 98.0 110.0 111.0 114.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:151.00 stddev:16.17 (10.7%) stddev-sans-first:16.55 17:24:51 INFO - PROCESS | 1826 | Values: 155.0 129.0 152.0 162.0 125.0 150.0 149.0 123.0 162.0 123.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 17:24:51 INFO - PROCESS | 1826 | Values: 162.0 161.0 161.0 161.0 162.0 163.0 160.0 161.0 161.0 161.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#3] audio-fft Cycles:10 Average:81.80 Median:73.00 stddev:14.17 (19.4%) stddev-sans-first:14.48 17:24:51 INFO - PROCESS | 1826 | Values: 71.0 73.0 87.0 96.0 73.0 73.0 71.0 112.0 91.0 71.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:20.91 (21.8%) stddev-sans-first:21.60 17:24:51 INFO - PROCESS | 1826 | Values: 96.0 98.0 137.0 96.0 96.0 96.0 144.0 96.0 98.0 138.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:24:51 INFO - PROCESS | 1826 | Values: 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 17:24:51 INFO - PROCESS | 1826 | Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:24:51 INFO - PROCESS | 1826 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.16 (5.6%) stddev-sans-first:3.33 17:24:51 INFO - PROCESS | 1826 | Values: 56.0 57.0 58.0 56.0 57.0 56.0 55.0 65.0 54.0 54.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 17:24:51 INFO - PROCESS | 1826 | Values: 67.0 67.0 68.0 67.0 67.0 68.0 67.0 69.0 68.0 67.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.50 stddev:3.80 (4.3%) stddev-sans-first:3.84 17:24:51 INFO - PROCESS | 1826 | Values: 85.0 94.0 87.0 86.0 85.0 85.0 85.0 93.0 90.0 93.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:117.50 stddev:4.12 (3.5%) stddev-sans-first:4.30 17:24:51 INFO - PROCESS | 1826 | Values: 116.0 126.0 120.0 114.0 116.0 114.0 124.0 119.0 116.0 116.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.00 stddev:7.50 (4.8%) stddev-sans-first:7.63 17:24:51 INFO - PROCESS | 1826 | Values: 149.0 169.0 153.0 154.0 165.0 155.0 155.0 154.0 155.0 142.0 17:24:51 INFO - PROCESS | 1826 | 17:24:51 INFO - PROCESS | 1826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.24 17:24:51 INFO - PROCESS | 1826 | Values: 68.0 67.0 71.0 68.0 69.0 68.0 67.0 69.0 69.0 68.0 17:24:51 INFO - PROCESS | 1826 | -------- Summary: end -------- 17:24:51 INFO - PROCESS | 1826 | 17:24:52 INFO - TEST-INFO | 1826: exit 0 17:24:52 INFO - TEST-OK | kraken | took 58665ms 17:24:52 INFO - TEST-START | v8_7 17:24:52 INFO - operating with platform_type : linux_ 17:24:52 INFO - Initialising browser for v8_7 test... 17:24:52 INFO - TEST-INFO | started process 2078 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ7UakL/profile http://localhost:38604/getInfo.html) 17:24:55 INFO - PROCESS | 2078 | __metrics Screen width/height:1600/1200 17:24:55 INFO - PROCESS | 2078 | colorDepth:24 17:24:55 INFO - PROCESS | 2078 | Browser inner width/height: 1024/697 17:24:55 INFO - PROCESS | 2078 | __metrics 17:24:56 INFO - PROCESS | 2078 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:24:56 INFO - PROCESS | 2078 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:24:57 INFO - TEST-INFO | 2078: exit 0 17:24:57 INFO - Browser initialized. 17:24:57 INFO - Running cycle 1/1 for v8_7 test... 17:24:57 INFO - TEST-INFO | started process 2162 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ7UakL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:08 INFO - PROCESS | 2162 | RSS: Main: 149909504 17:25:08 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | Cycle 1(1): loaded http://localhost:38604/tests/v8_7/run.html (next: http://localhost:38604/tests/v8_7/run.html) 17:25:30 INFO - PROCESS | 2162 | RSS: Main: 499466240 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | __start_tp_report 17:25:30 INFO - PROCESS | 2162 | _x_x_mozilla_page_load 17:25:30 INFO - PROCESS | 2162 | _x_x_mozilla_page_load_details 17:25:30 INFO - PROCESS | 2162 | |i|pagename|runs| 17:25:30 INFO - PROCESS | 2162 | |0;Richards;168.03898504453034 17:25:30 INFO - PROCESS | 2162 | |1;DeltaBlue;191.05846388995033 17:25:30 INFO - PROCESS | 2162 | |2;Encrypt;280.0336040324839 17:25:30 INFO - PROCESS | 2162 | |3;Decrypt;5273.684210526316 17:25:30 INFO - PROCESS | 2162 | |4;RayTrace;1097.694840834248 17:25:30 INFO - PROCESS | 2162 | |5;Earley;787.4015748031496 17:25:30 INFO - PROCESS | 2162 | |6;Boyer;12219.512195121952 17:25:30 INFO - PROCESS | 2162 | |7;RegExp;26256.410256410258 17:25:30 INFO - PROCESS | 2162 | |8;Splay;571.671388101983 17:25:30 INFO - PROCESS | 2162 | |9;NavierStokes;4835.748792270531 17:25:30 INFO - PROCESS | 2162 | __end_tp_report 17:25:30 INFO - PROCESS | 2162 | __startTimestamp1451957130547__endTimestamp 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | ------- Summary: start ------- 17:25:30 INFO - PROCESS | 2162 | Number of tests: 10 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 168.0 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 191.1 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 280.0 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 5273.7 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 1097.7 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 787.4 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 12219.5 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 26256.4 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#8] Splay Cycles:1 Average:571.67 Median:571.67 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 571.7 17:25:30 INFO - PROCESS | 2162 | 17:25:30 INFO - PROCESS | 2162 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:25:30 INFO - PROCESS | 2162 | Values: 4835.7 17:25:30 INFO - PROCESS | 2162 | -------- Summary: end -------- 17:25:30 INFO - PROCESS | 2162 | 17:25:31 INFO - TEST-INFO | 2162: exit 0 17:25:31 INFO - TEST-OK | v8_7 | took 39136ms 17:25:31 INFO - SUITE-END | took 1210s 17:25:31 INFO - Completed test suite (00:20:10) 17:25:31 INFO - Working with test: dromaeo_css 17:25:31 INFO - Generating results file: dromaeo_css 17:25:31 INFO - Working with test: kraken 17:25:31 INFO - Generating results file: kraken 17:25:31 INFO - javascript benchmark 17:25:31 INFO - Working with test: v8_7 17:25:31 INFO - Generating results file: v8_7 17:25:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:25:31 INFO - process_Request line: dromaeo_css 6863.52 graph.html#tests=[[72,201,35]] 17:25:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:31 INFO - process_Request line: kraken 1509.60 graph.html#tests=[[232,201,35]] 17:25:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:31 INFO - process_Request line: v8_7 21059.02 graph.html#tests=[[230,201,35]] 17:25:31 INFO - RETURN: dromaeo_css: 6863.52 17:25:31 INFO - RETURN: kraken: 1509.60 17:25:31 INFO - RETURN: v8_7: 21059.02 17:25:31 INFO - javascript benchmark 17:25:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3020.3959208158367, 3073.4775088234996, 3113.0, 3117.06488053584, 3141.921451963701, 5161.612879034078, 5340.4926531979445, 5350.678959262447, 5374.408815030349, 5406.080966235744, 5301.522862942344, 5328.387235467922, 5403.972980135104, 5408.215808707735, 5412.107002344608, 4781.306710526971, 4816.855494335158, 4826.469088400273, 4950.851474455754, 5008.198688209887, 4898.436679781835, 4921.606271498272, 4953.3560637117125, 4964.950350496485, 5049.3435853339015, 4750.596199323045, 4825.372701548794, 4853.150698627744, 4918.581920536759, 4918.631102667314, 4889.119958407486, 4892.461829198785, 4907.190313598252, 4923.926141107886, 4941.604671626261, 4832.371791667096, 4870.65905386623, 4882.731449770261, 4888.706677599355, 4946.975265123688, 5018.723970181639, 5063.797448102072, 5128.384593848725, 5178.119719647669, 5208.817691380784, 5713.714314284311, 5735.0823868181305, 5738.626989245686, 5747.195392645033, 5750.913736293959, 5770.6249093808765, 5779.826605201851, 5793.044147715622, 5801.129830525413, 5802.941970580282, 5284.0, 5291.100512912814, 5375.516203541661, 5386.245925570423, 5426.945730542723, 5794.652320860678, 5814.563907706939, 5843.474087332075, 5855.59010869235, 5860.179574859523, 5520.171974203901, 5539.058360078796, 5551.916721249185, 5554.361248456398, 5561.110222364402, 5473.917891231635, 5594.440555944373, 5599.552035837123, 5607.186957891083, 5657.12314591239, 5675.31896172462, 5800.187973683687, 5800.448957349129, 5806.390329015477, 5813.970930145322, 5712.542996560265, 5731.656100633892, 5740.1102829061565, 5744.770209191669, 5774.538036957033, 4411.7573533455325, 4418.60232579063, 4425.159219748238, 4427.46870375557, 4463.062756821104, 3812.5806161322234, 3872.1287710264965, 3927.509061367329, 3946.0, 3950.940735888964, 5249.763760630781, 5288.365396152486, 5297.496737809979, 5297.8145764898045, 5344.064788661969, 5699.401562835926, 5701.828945131652, 5702.572307076985, 5708.828735137952, 5711.114777209539, 5115.2582875483595, 5208.921866172011, 5211.661242019257, 5228.241904923841, 5316.308879845673, 4854.247591623304, 4855.975720121447, 4856.635752318591, 4857.708537487762, 4898.191798353232, 5952.226210592596, 5960.165576819249, 5963.970180149072, 5965.105234214816, 5965.612235204784, 5605.943940560705, 5662.57530685192, 5727.112297593713, 5727.369989301257, 5739.139129130664, 5968.940310596839, 5992.221011268682, 5999.9100013498955, 6000.759969601167, 6048.334683184934, 5609.887802244014, 5622.634528755618, 5625.662460252398, 5630.85922851932, 5634.183043458757, 5637.8590535236945, 5717.199592057199, 5729.770809167753, 5745.971270143623, 5750.079987202028, 5566.972165139148, 5613.831585052455, 5642.407547207484, 5647.463490968352, 5695.288088988877, 5577.191307260344, 5604.6917419542315, 5605.5795815313195, 5613.691246981455, 5615.045442274904, 5372.919406208832, 5439.891202176013, 5508.476694713996, 5517.089680202722, 5531.585131115263, 5637.52081073097, 5638.126090455986, 5640.464155905182, 5666.546676265806, 5698.458646428583, 5509.311336082989, 5518.586106041983, 5519.061759500814, 5520.006398848246, 5520.475554822286], "unit": "score", "name": "dojo.html", "value": 5263.970574246406}, {"lowerIsBetter": false, "replicates": [516.6719133350322, 547.1928904865324, 561.4217356123193, 569.3793764796371, 598.8023952095808, 28092.438151236962, 28620.570691439643, 28749.85625071874, 35982.100447488825, 36270.81864590674, 38473.42289865647, 38890.222195556074, 38891.805540972324, 38920.610793892054, 39020.41469377962, 8424.199701028409, 8593.871091933626, 8594.570271486433, 8598.78503037426, 8603.48379097253, 7566.054243219598, 7719.150893401749, 10089.344192627455, 10240.180785537139, 10252.436116013616, 9861.408315501058, 9999.450030248334, 10013.649522266722, 10020.198384129251, 10023.44871032093, 7560.6975720971095, 7737.767866964, 9897.4556399398, 9993.250506212064, 9998.200143988464, 10056.748581285454, 10252.846207306897, 10264.79470410595, 10265.127464165555, 10267.281290309682, 36423.4536481953, 36707.26585468276, 36851.44722829133, 36856.26287474235, 36881.631183688085, 3267.9019629411155, 3385.86456541738, 3455.4989526518766, 3672.669459748609, 3699.186179040607, 27969.860150699114, 27978.3005424864, 28385.432291354264, 29666.25834354137, 30360.392792144256, 3907.5310962684375, 3909.8810361783717, 3941.527016757979, 3982.6614737747327, 4089.44792453018, 279914.0, 280077.59961200267, 280096.0, 280585.0, 280677.1424428926, 51357.48642513602, 58774.0, 59083.70458147768, 59174.40825591775, 59175.704121479976, 46542.0, 62633.0, 63467.68266158732, 63504.682476587324, 63515.0, 13792.241426721426, 13952.232627205602, 14047.0, 14067.085639433404, 14241.857581424054, 11079.279846809932, 11092.889071109186, 11099.611513597147, 11101.555937762561, 11175.217734758651, 19243.326483573008, 19402.12690428934, 19418.514537136685, 19459.12433940476, 19577.119029643414, 7285.526440781332, 7290.4167666586545, 7460.589667568336, 7479.587043644167, 7515.924840751522, 918.3861504977933, 936.4381371177375, 994.5623925472913, 1012.8733908261468, 1028.0850043461326, 28322.85838570794, 28333.29166770806, 28440.513506498544, 28797.856010720232, 28860.422791544053, 1007.450939238117, 1039.7088815131624, 1043.1706793099504, 1065.5577935156823, 1113.3153110836777, 13639.386227619583, 13700.93149534246, 13809.378577964017, 13814.240216788174, 14022.018458707793, 295447.0, 309907.0, 310505.0, 312211.0, 312676.0, 46227.382041628385, 48553.27170092452, 48798.26802597964, 48813.75593122012, 48834.0, 1308.7840506316352, 1320.3266334169643, 1325.787873940165, 1327.595083499542, 1330.9866901331056, 24295.878520607283, 25160.37099072538, 25861.353466162745, 26636.8668156658, 28587.28531786722, 41781.0, 42207.788961055, 42215.366769497865, 42338.364924525544, 42353.36469952892, 243405.0, 244321.0, 244410.0, 244759.0, 245051.0, 26082.73917260879, 31129.844350779007, 31141.8442907784, 31363.529547057267, 31475.685243147276, 35860.462093069145, 36072.4589131158, 36410.08974775546, 36748.81625591855, 37087.072823178554, 30097.247568810955, 31715.682843171275, 35002.474962876084, 35897.820510897276, 36244.81877590595, 31829.681703182672, 32314.192145196557, 32775.836120819244, 33111.50332744962, 34261.65738342684, 34455.138621534665, 34707.47938780971, 35417.645823542465, 36147.0, 36165.45751813777, 28485.715142848305, 29233.707662923098, 30235.546466803455, 30238.09285721432, 30407.847960760053, 22644.773552264265, 22971.310860674206, 23225.651615226125, 23234.0, 23268.418289542897], "unit": "score", "name": "ext.html", "value": 17788.272688391804}, {"lowerIsBetter": false, "replicates": [353.8814497143457, 363.4856677800911, 363.82900036982625, 364.1751433004245, 364.7300997262027, 14202.573922782307, 14215.502457413993, 16309.266083026263, 16609.83390166098, 17223.224954877012, 15897.52307430776, 16274.83725162748, 16596.50210493687, 16710.0, 16736.16319184042, 5106.540411362986, 5202.739863006854, 5203.9219411708855, 5215.191645294966, 5223.2165175223645, 4000.8599699010542, 4092.6930480213955, 5216.374035115791, 5246.396664383607, 5715.942840571583, 5821.854453638672, 5867.2372591563035, 5871.266091738533, 5910.645361278337, 5910.852228694274, 5735.397783232763, 5928.644281343133, 5928.851778705523, 5938.851528711773, 5945.405459454041, 5157.8452646420665, 5160.896782064376, 5161.922571161435, 5168.457311982263, 5185.844424667266, 19973.101210445566, 20703.17187312506, 20931.0, 21876.343709688736, 22052.11791528353, 2190.113004233272, 2248.5390494948497, 2277.840551161419, 2324.395657129142, 2372.383180373098, 12859.614211573667, 13036.674083147902, 13039.608811735663, 13311.467541298336, 13456.0, 1732.2031865341958, 1745.9127043647766, 1762.5769815244378, 1773.494554052089, 1813.8186181381889, 57567.71216143934, 59757.804843903315, 59898.700506497626, 60063.69968150131, 61859.69070154666, 9518.143367096995, 9706.466144362128, 9823.36148150368, 9838.754031149136, 9897.406155630686, 12772.297523636289, 12799.552015679406, 12810.295433751233, 12827.935860320638, 12857.0, 7217.0, 7290.088738907637, 7475.0, 7586.62066896653, 7735.806604834924, 7110.608916509642, 7117.89323160153, 7685.154632990367, 7775.533467991939, 7781.182975787574, 5921.082232254007, 5996.2504686914135, 6000.579959402888, 6005.39946005396, 6047.879042419127, 1640.1553200101957, 1677.0859881364686, 1677.8825482216128, 1682.9074400908069, 1703.4038086669814, 924.7225832250433, 954.2080073538946, 975.4293738163254, 1001.4542074569378, 1043.546057465005, 15835.68328633421, 16393.016419014897, 16929.238184281738, 17775.73336399955, 17850.464486065437, 911.9908800911905, 950.0, 974.6247694637616, 1018.765683892694, 1032.6901929421144, 8890.4665720057, 8956.462612243286, 9043.18611324984, 9233.169014788702, 9520.904790952001, 411805.0, 588582.0, 603446.0, 605843.0, 606556.0, 42594.78702606529, 42716.0, 42781.0, 76237.0, 76596.61701691567, 1068.076114161245, 1097.160672085855, 1100.6147848253208, 1101.7576133250673, 1128.5655022816275, 14450.205238711971, 14841.85158148448, 15052.54842354731, 15241.23793810283, 15401.305856356015, 34189.658103418646, 34637.0, 34855.0, 35321.470177947864, 36067.63932360748, 46794.0, 47354.52645473501, 47910.0, 49708.25437618511, 50524.24213636725, 8946.418482798597, 9223.953880230556, 9306.255499559884, 9324.766880828034, 9345.626174952926, 10975.890241097806, 11158.218924675195, 11168.832467512831, 11182.552697892319, 12269.754604907674, 2903.3902880395353, 12708.157317189141, 13203.801942970671, 14332.928335358256, 14616.488422905148, 13496.257705825881, 13876.653083672989, 14308.141511509342, 14771.852281477048, 14847.33187006609, 13898.722025559635, 14102.647433814236, 14193.503227386991, 14237.35931883047, 14577.85422145765, 9318.860217096613, 9441.244700424088, 9522.285828562746, 9624.566894489904, 9631.566579504079, 13740.10689305192, 13941.093828901088, 14005.43978240859, 14160.0, 14430.350634221695], "unit": "score", "name": "jquery.html", "value": 8761.599836701253}, {"lowerIsBetter": false, "replicates": [1308.4635299527197, 1461.1160248049932, 1470.0811992504684, 1624.3177865296575, 1808.8914665120094, 6910.654467276641, 7533.3596644285235, 7644.770656880289, 7677.808054798633, 7686.615669216538, 7448.590327531997, 7664.616769161547, 7670.96164519178, 7682.769516914502, 7683.308502234798, 2283.4976305212826, 2317.2353123469215, 2318.5594737, 2322.1059891941554, 2324.1981516376823, 2288.8626682399026, 2307.042577330406, 2345.0033735662273, 2355.8233132515043, 2360.480694247263, 2264.2527965771337, 2264.5923733727923, 2300.96548551771, 2307.573098976695, 2313.7686231376897, 2259.2092767531317, 2278.7493375728573, 2281.885905704708, 2282.9771702282933, 2289.1987804268456, 2296.0700916128994, 2314.618088015475, 2319.5476882008015, 2319.5824751544715, 2319.7796209360085, 7665.233476652346, 7713.768586942345, 7737.032870891138, 7749.845003099963, 7762.650680719381, 4588.0365123324145, 4653.488116307203, 4684.859454216345, 4687.062587482483, 4697.342372067913, 3078.5843911071943, 3114.423831591163, 3147.6380216275193, 3157.6684448132846, 3178.6503484616674, 1011.549860312154, 1030.8969103089705, 1063.5639387850945, 1078.9892101078967, 1080.2924084724439, 10809.081228095622, 10821.0, 10823.67528974132, 10831.620893268777, 10838.67483975482, 4242.045539753531, 4283.378910058086, 4331.480222373335, 4335.653147748172, 4354.063876266555, 9151.725448236564, 9160.770980725536, 9169.495677737788, 9176.174144327042, 9185.494797786052, 4723.7874295656775, 4724.503927087606, 4734.857954261378, 4736.597389221886, 4741.075490279362, 3827.349350610403, 3888.066863952631, 3937.9803100984313, 4218.050938538804, 4335.4363932689175, 3596.2088340565033, 3618.6924111450294, 3624.836882340301, 3640.890773276806, 3660.633936606371, 1190.9166358355005, 1202.5310129049678, 1205.5900993662196, 1221.5052903574067, 1223.9755204895853, 988.6045581767207, 1006.8389057750725, 1007.4660429972126, 1098.1434481104752, 1280.4494067550856, 6941.0, 7002.439804815603, 7062.329078737512, 7071.823204419828, 7072.080629518233, 483.69285503704697, 488.5505335091724, 504.87630530520255, 505.2043032224262, 507.4975773983729, 5396.784128634889, 5461.617686761889, 5470.8085217017215, 5477.123660214346, 5478.91781623268, 9168.633254669872, 9173.266138708887, 9202.539873006323, 9274.629014839331, 9425.905740942502, 9196.678116265899, 9225.769355766159, 9228.7692807679, 9298.116678915492, 9313.068693130634, 7174.426045916314, 7351.742689005859, 7389.926100739031, 7396.223396543393, 7413.555186688816, 6796.456283497408, 6847.041414201916, 6848.828779280558, 6856.554323968926, 6859.2454829969665, 8239.835203296021, 8304.916950830657, 8496.447730897471, 8509.064002959793, 8513.06356300794, 8497.617607207567, 8600.39797214189, 8685.174908383693, 8794.296456283353, 8795.560221989002, 6084.604500707617, 6203.503719702323, 6207.782727604512, 6550.541462097607, 6563.671816409256, 6863.897041544481, 6912.930870691229, 7092.25531319204, 7265.564066156047, 7308.0, 6729.394354507922, 6873.243943166148, 6873.553219040747, 7000.22997470288, 7010.789676309719, 6758.4931130166415, 6774.0, 6817.522773406013, 6859.142607174103, 6904.344087311697, 6628.105205797348, 6739.966300168468, 6867.759628412981, 6893.310668933066, 6916.170059592881, 6170.167027451236, 6188.226471691039, 6200.286966998672, 6207.81376558704, 6212.627242365473, 6189.319174890668, 6241.937580624136, 6243.157173781481, 6243.43809057187, 6259.2488901332135], "unit": "score", "name": "mootools.html", "value": 4337.922802429024}, {"lowerIsBetter": false, "replicates": [331.3323652839528, 336.15960099750623, 338.1647331092202, 340.2158025750644, 342.4725922079997, 5770.365259821417, 5906.4979476744475, 5917.970410147954, 5924.081767326066, 5931.555133364998, 5719.742611582478, 5837.795677151301, 5864.648121112737, 5875.206847075643, 5882.264716910387, 4532.546745325474, 4540.432445944257, 4541.159885421192, 4546.386237857896, 4550.203714349992, 4273.487181538219, 4373.169097871394, 4377.584129507692, 4383.824647014116, 4543.250363689987, 4394.846180383687, 4484.932726009112, 4487.775611219442, 4501.932471012938, 4505.098980203956, 4465.799039043251, 4470.262406702906, 4497.325401189848, 4502.2571275739465, 4512.300593407994, 3973.9602603974167, 3974.5429275633383, 3976.906350753537, 3979.383195604686, 3985.1830374773103, 5420.539254163401, 5564.916526252109, 5569.610127291091, 5590.496855283044, 5591.10542313228, 5178.766955486974, 5182.585393168538, 5184.7148406837605, 5185.118529849935, 5188.273641690166, 5895.911561326584, 6212.316645169028, 6224.253089629228, 6236.844078898019, 6237.812865614039, 4182.059036716745, 4342.934855977162, 4411.492678342, 4412.139632771611, 4434.55876840025, 6311.779087731953, 6500.902486462707, 6501.804945851632, 6503.317151699051, 6505.056766768792, 4491.191585514639, 4491.393661855673, 4497.797599107983, 4500.752458614742, 4503.166914120898, 4478.57453541913, 4558.0655965526985, 4565.543445655408, 4570.520095389937, 4577.06170235101, 5237.973810130925, 5239.502247286502, 5243.606729495303, 5245.501677340647, 5255.211718242294, 6235.220597425322, 6258.655773932477, 6271.717772700239, 6274.1843560336865, 6275.466585340298, 1606.5019843848445, 1625.8699304055647, 1626.8454496822783, 1628.5521481592657, 1629.4296996051523, 1098.1160166066234, 1101.779644071189, 1107.2858006585868, 1125.1617544928918, 1133.6485689436302, 5865.560082993792, 5878.853028674317, 5883.61756485827, 5884.146798714162, 5885.735141918538, 6369.745210191633, 6382.457491113308, 6387.808365749035, 6391.2330520337855, 6397.52018598607, 5873.353931067579, 5875.148103524965, 5886.470217680429, 5888.028475301613, 5890.705464726747, 3388.5764279465066, 3483.407820670492, 3485.0590340607896, 3485.1461391959133, 3492.231709024011, 6749.831254218684, 6767.898481522781, 6779.0509328694025, 6780.355866192704, 6780.72877084911, 6711.295313991961, 6712.966435167793, 6717.261101278856, 6719.992001199859, 6720.899186512206, 6546.0835483032415, 6737.124173857367, 6740.090087838177, 6747.122874026443, 6752.155980502437, 6208.0, 6349.841253968688, 6451.2903580607035, 6459.709313081016, 6468.838279043061, 6285.371462853678, 6416.197975253093, 6419.454346380423, 6423.100765892686, 6444.355564443518, 6701.463882889455, 6708.496862735412, 6712.83217919556, 6714.932850671431, 6727.428168605527, 4294.1411717655965, 4380.167768124174, 4414.757188354672, 4416.07262474871, 4421.182081314967, 6463.224413070461, 6480.546361754632, 6481.481481481376, 6482.546221764431, 6488.767134244478, 6249.031400132987, 6297.96851015742, 6309.747610095545, 6309.842253943688, 6311.116443697978, 6177.876442471215, 6212.534059945432, 6277.30949595535, 6281.748730050746, 6289.371062893674, 6155.045967874987, 6156.907646385218, 6158.692065396802, 6162.414570615784, 6164.753409863555, 6278.0, 6288.685565721604, 6293.811185664437, 6300.338464461165, 6304.243490781136, 6057.394260573908, 6124.510039196943, 6133.815985520441, 6138.386161383826, 6144.262688477412], "unit": "score", "name": "prototype.html", "value": 4725.73336133177}, {"lowerIsBetter": false, "replicates": [762.2187258060486, 831.629924683516, 847.9279261262792, 864.5849992003837, 891.9152680495355, 13294.867051329496, 13501.662458438544, 13510.054296199258, 13518.797218041713, 13520.526781562647, 11864.644060678173, 12044.819327710069, 12092.879071209285, 12112.636620901365, 12123.393830308494, 672.6804767735335, 814.3363159025375, 826.6404114210337, 828.3662997806682, 828.4904783558098, 813.0487329824091, 814.238686827815, 822.0792712162356, 822.313368337439, 822.7449490657885, 712.1952194020749, 723.3995783499682, 861.1431625532604, 867.0419186798559, 867.4274978514181, 850.0394554153828, 862.7972426479772, 870.7474832298626, 871.7689812199773, 872.3239489395705, 636.6084857812458, 639.9520035997319, 641.0160403780175, 641.2241188162329, 641.3009819296942, 13108.2135071896, 13158.21050736959, 13164.14433061848, 13211.273379964097, 13235.933820330836, 11802.881971180264, 12224.511019559208, 12280.570180043656, 12434.62696119118, 12543.686407839878, 10025.19798416125, 10289.691309260734, 10375.740606484822, 11093.889061109367, 11250.606228782035, 3639.581448133472, 3648.525691660094, 3665.193657395369, 3680.613535578779, 3808.771473711586, 42750.358744618854, 42810.57189428128, 43022.35466468005, 43135.56864431347, 43777.12445751067, 8999.910000900038, 9391.953040234892, 9794.853077203848, 9890.65382711616, 9894.406335619886, 17927.820721792876, 17977.820221797876, 18041.09794510269, 18103.275868965095, 18116.547086322946, 7628.0, 7691.077070751546, 7717.112532058773, 7746.690132394641, 7834.725784597512, 4179.393987871802, 4189.2668782962855, 4220.303649897733, 4256.2551553478015, 4274.482410118413, 3103.6896310369234, 3124.9375012500077, 3127.3901589190345, 3130.280035591781, 3133.5769671094113, 565.6238601330069, 571.7341436232172, 580.2398857496693, 587.8119001919345, 592.2537602620729, 539.5764325004931, 560.3052215253139, 569.3537834557807, 588.9469947704728, 657.2671471309455, 8536.359773017048, 9039.096090390909, 9062.50156241413, 9076.183143517115, 9263.212626926786, 558.6620094842643, 573.5239751006654, 604.3714536881594, 621.9036049412348, 629.4052120745943, 3963.6432721055244, 3978.244133614604, 4005.315110098658, 4025.255327764373, 4042.3734321180264, 50499.495005050216, 52030.0, 53253.46746532485, 53323.20015199775, 53774.731126344115, 47923.76038119857, 48275.0, 48747.0, 49316.0, 50092.24861627079, 43832.56167438285, 44260.77869610631, 44954.0, 45404.54595454069, 49162.99999999929, 8473.95763021181, 8551.0, 9065.229455496357, 9146.862797057916, 9168.679096231866, 33393.83303083469, 33780.15549611279, 34348.82825585856, 34475.13812154716, 34691.7959868052, 38783.12168783212, 39078.60921390863, 39375.606243937196, 42617.0, 42685.359719603606, 10362.948185259025, 10422.654902646844, 10774.353538787698, 11128.38793866345, 11255.437228138397, 11445.25605835618, 11492.0, 11838.408079596158, 12023.27860328383, 12377.938110309391, 11742.0, 12051.75896482083, 12154.209976351509, 12293.75412491763, 12410.379481025731, 11332.206745527734, 11826.52693892269, 11849.05207583374, 12182.451789669663, 12285.877141228832, 10820.67537973862, 11121.388323642277, 11125.276857004268, 11159.10727141843, 11368.335052034532, 9160.816783664422, 9366.484843333683, 9427.905720942977, 9562.99588543193, 9618.474794660813, 9243.676471323472, 9340.626374944926, 9464.589670932965, 9670.75823104428, 9678.17735492491], "unit": "score", "name": "yui.html", "value": 6215.28325068853}], "name": "dromaeo_css", "value": 6863.5197215748585}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 109.0, 110.0, 111.0, 98.0, 110.0, 111.0, 114.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 152.0, 162.0, 125.0, 150.0, 149.0, 123.0, 162.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 163.0, 160.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 87.0, 96.0, 73.0, 73.0, 71.0, 112.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 137.0, 96.0, 96.0, 96.0, 144.0, 96.0, 98.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 57.0, 56.0, 55.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 69.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 94.0, 87.0, 86.0, 85.0, 85.0, 85.0, 93.0, 90.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [116.0, 126.0, 120.0, 114.0, 116.0, 114.0, 124.0, 119.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [149.0, 169.0, 153.0, 154.0, 165.0, 155.0, 155.0, 154.0, 155.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 71.0, 68.0, 69.0, 68.0, 67.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1509.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [191.05846388995033], "unit": "score", "name": "DeltaBlue", "value": 346.061612}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1097.694840834248], "unit": "score", "name": "RayTrace", "value": 674.1299790000003}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [571.671388101983], "unit": "score", "name": "Splay", "value": 142.54867690782953}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21059.02292286375}]} 17:25:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21059.02"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1509.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6863.52"}}} 17:25:31 INFO - Return code: 0 17:25:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:25:31 INFO - # TBPL SUCCESS # 17:25:31 INFO - Running post-action listener: _resource_record_post_action 17:25:31 INFO - Running post-run listener: _resource_record_post_run 17:25:32 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 557514752; Read time: 0; Write time: 516060 17:25:32 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244686848; Read time: 0; Write time: 297204 17:25:32 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 308817920; Read time: 0; Write time: 218496 17:25:32 INFO - Running post-run listener: _upload_blobber_files 17:25:32 INFO - Blob upload gear active. 17:25:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:25:32 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 17:25:32 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:25:32 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:25:33 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:25:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:34 INFO - (blobuploader) - INFO - Done attempting. 17:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:35 INFO - (blobuploader) - INFO - Done attempting. 17:25:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:35 INFO - Return code: 0 17:25:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:25:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91caba48d8d4a9a1b8654601d67d2eb45e95d575384ada6d181a4f0e41d2848babfb8e98d104bf040630224de2bf6e1a6395751ee3f5398f8e5b5d3a82feca9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1353856ee68073d2d4b6bacc7a2ba66979da9daa578d1875e414158844c251f619f928e6729f3953d5a313bdc38e8cf5d4c933f54f8acefecc45bde0ee6f606"} 17:25:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:25:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:25:35 INFO - Contents: 17:25:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91caba48d8d4a9a1b8654601d67d2eb45e95d575384ada6d181a4f0e41d2848babfb8e98d104bf040630224de2bf6e1a6395751ee3f5398f8e5b5d3a82feca9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1353856ee68073d2d4b6bacc7a2ba66979da9daa578d1875e414158844c251f619f928e6729f3953d5a313bdc38e8cf5d4c933f54f8acefecc45bde0ee6f606"} 17:25:35 INFO - Copying logs to upload dir... 17:25:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.697279 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-04 17:25:34.971057) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:25:34.974832) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91caba48d8d4a9a1b8654601d67d2eb45e95d575384ada6d181a4f0e41d2848babfb8e98d104bf040630224de2bf6e1a6395751ee3f5398f8e5b5d3a82feca9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1353856ee68073d2d4b6bacc7a2ba66979da9daa578d1875e414158844c251f619f928e6729f3953d5a313bdc38e8cf5d4c933f54f8acefecc45bde0ee6f606"} build_url:https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/Diw0ZTovTlK3acK2EqGiOw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91caba48d8d4a9a1b8654601d67d2eb45e95d575384ada6d181a4f0e41d2848babfb8e98d104bf040630224de2bf6e1a6395751ee3f5398f8e5b5d3a82feca9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1353856ee68073d2d4b6bacc7a2ba66979da9daa578d1875e414158844c251f619f928e6729f3953d5a313bdc38e8cf5d4c933f54f8acefecc45bde0ee6f606"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:25:35.000026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:25:35.000360) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1451954065.506086-1828622299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:25:35.084584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:25:35.084952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:25:35.085281) ========= ========= Total master_lag: 0.23 =========