builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1450486297.53 results: success (0) buildid: 20151218143002 builduid: 433503bc87184dbd9df3ac2187e8a476 revision: 53556a49e56e2965e69153e41c57b5b1a182a8b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.532639) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.533304) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.533674) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006344 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.557661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.557999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.622366) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.622680) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.676484) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.676812) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.677199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.677506) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 16:51:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.9M=0.001s 2015-12-18 16:51:37 (16.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.892980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.893316) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084216 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:37.997810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 16:51:37.998284) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 53556a49e56e2965e69153e41c57b5b1a182a8b6 --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 53556a49e56e2965e69153e41c57b5b1a182a8b6 --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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 16:51:38,135 truncating revision to first 12 chars 2015-12-18 16:51:38,135 Setting DEBUG logging. 2015-12-18 16:51:38,135 attempt 1/10 2015-12-18 16:51:38,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/53556a49e56e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 16:51:39,258 unpacking tar archive at: b2g-inbound-53556a49e56e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 16:51:39.406738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:39.407119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:39.415699) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:39.416060) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 16:51:39.416491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-18 16:51:39.416780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --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', '--system-bits', '64', '--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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:51:39 INFO - MultiFileLogger online at 20151218 16:51:39 in /builds/slave/test-pgo 16:51:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 16:51:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:51:39 INFO - {'append_to_log': False, 16:51:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:51:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:51:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:51:39 INFO - 'branch': 'B2G-Inbound', 16:51:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:51:39 INFO - 'config_files': ('talos/linux_config.py',), 16:51:39 INFO - 'default_actions': ('clobber', 16:51:39 INFO - 'read-buildbot-config', 16:51:39 INFO - 'download-and-extract', 16:51:39 INFO - 'populate-webroot', 16:51:39 INFO - 'create-virtualenv', 16:51:39 INFO - 'install', 16:51:39 INFO - 'run-tests'), 16:51:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:51:39 INFO - 'download_minidump_stackwalk': True, 16:51:39 INFO - 'download_symbols': 'ondemand', 16:51:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:51:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:51:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:51:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:51:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:51:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:51:39 INFO - 'installer_path': 'installer.exe', 16:51:39 INFO - 'log_level': 'info', 16:51:39 INFO - 'log_name': 'talos', 16:51:39 INFO - 'log_to_console': True, 16:51:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:51:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:51:39 INFO - 'opt_config_files': (), 16:51:39 INFO - 'pip_index': False, 16:51:39 INFO - 'sps_profile': False, 16:51:39 INFO - 'sps_profile_interval': 0, 16:51:39 INFO - 'suite': 'dromaeojs', 16:51:39 INFO - 'system_bits': '64', 16:51:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:51:39 INFO - 'title': 'talos-linux64-ix-058', 16:51:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:51:39 INFO - 'use_talos_json': True, 16:51:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:51:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:51:39 INFO - 'work_dir': 'build'} 16:51:39 INFO - ##### 16:51:39 INFO - ##### Running clobber step. 16:51:39 INFO - ##### 16:51:39 INFO - Running pre-action listener: _resource_record_pre_action 16:51:39 INFO - Running main action method: clobber 16:51:39 INFO - rmtree: /builds/slave/test-pgo/build 16:51:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:51:40 INFO - Running post-action listener: _resource_record_post_action 16:51:40 INFO - ##### 16:51:40 INFO - ##### Running read-buildbot-config step. 16:51:40 INFO - ##### 16:51:40 INFO - Running pre-action listener: _resource_record_pre_action 16:51:40 INFO - Running main action method: read_buildbot_config 16:51:40 INFO - Using buildbot properties: 16:51:40 INFO - { 16:51:40 INFO - "project": "", 16:51:40 INFO - "product": "firefox", 16:51:40 INFO - "script_repo_revision": "production", 16:51:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:51:40 INFO - "repository": "", 16:51:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:51:40 INFO - "buildid": "20151218143002", 16:51:40 INFO - "pgo_build": "True", 16:51:40 INFO - "basedir": "/builds/slave/test-pgo", 16:51:40 INFO - "buildnumber": 1069, 16:51:40 INFO - "slavename": "talos-linux64-ix-058", 16:51:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:51:40 INFO - "platform": "ubuntu64_hw", 16:51:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:51:40 INFO - "branch": "b2g-inbound", 16:51:40 INFO - "repo_path": "integration/b2g-inbound", 16:51:40 INFO - "revision": "53556a49e56e2965e69153e41c57b5b1a182a8b6", 16:51:40 INFO - "stage_platform": "linux64-pgo", 16:51:40 INFO - "builduid": "433503bc87184dbd9df3ac2187e8a476", 16:51:40 INFO - "slavebuilddir": "test" 16:51:40 INFO - } 16:51:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:51:40 INFO - Running post-action listener: _resource_record_post_action 16:51:40 INFO - ##### 16:51:40 INFO - ##### Running download-and-extract step. 16:51:40 INFO - ##### 16:51:40 INFO - Running pre-action listener: _resource_record_pre_action 16:51:40 INFO - Running main action method: download_and_extract 16:51:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:40 INFO - https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/test_packages.json 16:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/test_packages.json 16:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:51:41 INFO - Downloaded 1302 bytes. 16:51:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:51:41 INFO - Using the following test package requirements: 16:51:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:51:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'jsshell-linux-x86_64.zip'], 16:51:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:51:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:51:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:51:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:51:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:51:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:51:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:51:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:41 INFO - https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:42 INFO - Downloaded 23121911 bytes. 16:51:42 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 16:51:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:42 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 16:51:43 INFO - Return code: 0 16:51:43 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 16:51: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')]} 16:51:43 INFO - https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:47 INFO - Downloaded 23121911 bytes. 16:51:47 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 16:51:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:51:47 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 16:51:48 INFO - Return code: 0 16:51: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')]} 16:51:48 INFO - https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:49 INFO - Downloaded 11132039 bytes. 16:51:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:51:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:51:49 INFO - Return code: 0 16:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:49 INFO - https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/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 16:51:51 INFO - Downloaded 54648172 bytes. 16:51:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:51 INFO - mkdir: /builds/slave/test-pgo/properties 16:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:51:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:51:51 INFO - Contents: 16:51:51 INFO - build_url:https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:51:51 INFO - Running post-action listener: _resource_record_post_action 16:51:51 INFO - Running post-action listener: set_extra_try_arguments 16:51:51 INFO - ##### 16:51:51 INFO - ##### Running populate-webroot step. 16:51:51 INFO - ##### 16:51:51 INFO - Running pre-action listener: _resource_record_pre_action 16:51:51 INFO - Running main action method: populate_webroot 16:51:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:51:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:51:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:51:51 INFO - '--tppagecycles', 16:51:51 INFO - '7'], 16:51:51 INFO - 'tests': ['tsvgm']}}, 16:51:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:51:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:51:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:51:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'tests': ['damp', 'tps']}, 16:51:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['damp', 'tps']}, 16:51:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:51:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:51 INFO - 'other': {'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_no_auto_restore']}, 16:51:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_no_auto_restore']}, 16:51:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_no_auto_restore']}, 16:51:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_no_auto_restore']}, 16:51:51 INFO - 'other_l64': {'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_no_auto_restore']}, 16:51:51 INFO - 'other_nol64': {'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_no_auto_restore']}, 16:51:51 INFO - 'svgr': {'tests': ['tsvgx', 16:51:51 INFO - 'tsvgr_opacity', 16:51:51 INFO - 'tart', 16:51:51 INFO - 'tscrollx', 16:51:51 INFO - 'cart']}, 16:51:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['tsvgx', 16:51:51 INFO - 'tsvgr_opacity', 16:51:51 INFO - 'tart', 16:51:51 INFO - 'tscrollx', 16:51:51 INFO - 'cart']}, 16:51:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'tests': ['tp5o']}, 16:51:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'talos_options': ['--e10s'], 16:51:51 INFO - 'tests': ['tp5o']}, 16:51:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'talos_options': ['--xperf_path', 16:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:51 INFO - 'tests': ['tp5n']}, 16:51:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:51:51 INFO - 'talos_options': ['--e10s', 16:51:51 INFO - '--xperf_path', 16:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:51 INFO - 'tests': ['tp5n']}}, 16:51:51 INFO - 'talos.zip': {'path': '', 16:51:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:51:51 INFO - Running post-action listener: _resource_record_post_action 16:51:51 INFO - ##### 16:51:51 INFO - ##### Running create-virtualenv step. 16:51:51 INFO - ##### 16:51:51 INFO - Running pre-action listener: _resource_record_pre_action 16:51:51 INFO - Running main action method: create_virtualenv 16:51:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:51:51 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 16:51:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:51:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:51 INFO - Using real prefix '/usr' 16:51:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:51:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:54 INFO - Installing pip.................done. 16:51:54 INFO - Return code: 0 16:51:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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', '--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 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:51:54 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 16:51:54 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 16:51:54 INFO - Using env: {'DISPLAY': ':0', 16:51:54 INFO - 'HOME': '/home/cltbld', 16:51:54 INFO - 'LANG': 'en_US.UTF-8', 16:51:54 INFO - 'LANGUAGE': 'en_US:en', 16:51:54 INFO - 'LOGNAME': 'cltbld', 16:51:54 INFO - 'MAIL': '/var/mail/cltbld', 16:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:54 INFO - 'MOZ_NO_REMOTE': '1', 16:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:54 INFO - 'NO_EM_RESTART': '1', 16:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:54 INFO - 'SHELL': '/bin/bash', 16:51:54 INFO - 'SHLVL': '1', 16:51:54 INFO - 'TERM': 'linux', 16:51:54 INFO - 'TMOUT': '86400', 16:51:54 INFO - 'USER': 'cltbld', 16:51:54 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:54 INFO - '_': '/tools/buildbot/bin/python'} 16:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:54 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 16:51:54 INFO - Cleaning up... 16:51:54 INFO - Return code: 0 16:51:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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', '--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 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:51:54 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 16:51:54 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 16:51:54 INFO - Using env: {'DISPLAY': ':0', 16:51:54 INFO - 'HOME': '/home/cltbld', 16:51:54 INFO - 'LANG': 'en_US.UTF-8', 16:51:54 INFO - 'LANGUAGE': 'en_US:en', 16:51:54 INFO - 'LOGNAME': 'cltbld', 16:51:54 INFO - 'MAIL': '/var/mail/cltbld', 16:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:54 INFO - 'MOZ_NO_REMOTE': '1', 16:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:54 INFO - 'NO_EM_RESTART': '1', 16:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:54 INFO - 'SHELL': '/bin/bash', 16:51:54 INFO - 'SHLVL': '1', 16:51:54 INFO - 'TERM': 'linux', 16:51:54 INFO - 'TMOUT': '86400', 16:51:54 INFO - 'USER': 'cltbld', 16:51:54 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:54 INFO - '_': '/tools/buildbot/bin/python'} 16:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:54 INFO - Downloading/unpacking psutil>=0.7.1 16:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:56 INFO - Installing collected packages: psutil 16:51:56 INFO - Running setup.py install for psutil 16:51:56 INFO - building 'psutil._psutil_linux' extension 16:51:56 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 16:51:56 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 16:51:56 INFO - building 'psutil._psutil_posix' extension 16:51:56 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 16:51:56 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 16:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:56 INFO - Successfully installed psutil 16:51:56 INFO - Cleaning up... 16:51:56 INFO - Return code: 0 16:51:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:51:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:51:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:51:56 INFO - Using env: {'DISPLAY': ':0', 16:51:56 INFO - 'HOME': '/home/cltbld', 16:51:56 INFO - 'LANG': 'en_US.UTF-8', 16:51:56 INFO - 'LANGUAGE': 'en_US:en', 16:51:56 INFO - 'LOGNAME': 'cltbld', 16:51:56 INFO - 'MAIL': '/var/mail/cltbld', 16:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:56 INFO - 'MOZ_NO_REMOTE': '1', 16:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:56 INFO - 'NO_EM_RESTART': '1', 16:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:56 INFO - 'SHELL': '/bin/bash', 16:51:56 INFO - 'SHLVL': '1', 16:51:56 INFO - 'TERM': 'linux', 16:51:56 INFO - 'TMOUT': '86400', 16:51:56 INFO - 'USER': 'cltbld', 16:51:56 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:56 INFO - '_': '/tools/buildbot/bin/python'} 16:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:51:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:51:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:51:58 INFO - Installing collected packages: mozsystemmonitor 16:51:58 INFO - Running setup.py install for mozsystemmonitor 16:51:58 INFO - Successfully installed mozsystemmonitor 16:51:58 INFO - Cleaning up... 16:51:58 INFO - Return code: 0 16:51:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:51:58 INFO - Using env: {'DISPLAY': ':0', 16:51:58 INFO - 'HOME': '/home/cltbld', 16:51:58 INFO - 'LANG': 'en_US.UTF-8', 16:51:58 INFO - 'LANGUAGE': 'en_US:en', 16:51:58 INFO - 'LOGNAME': 'cltbld', 16:51:58 INFO - 'MAIL': '/var/mail/cltbld', 16:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:58 INFO - 'MOZ_NO_REMOTE': '1', 16:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:58 INFO - 'NO_EM_RESTART': '1', 16:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:58 INFO - 'SHELL': '/bin/bash', 16:51:58 INFO - 'SHLVL': '1', 16:51:58 INFO - 'TERM': 'linux', 16:51:58 INFO - 'TMOUT': '86400', 16:51:58 INFO - 'USER': 'cltbld', 16:51:58 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:58 INFO - '_': '/tools/buildbot/bin/python'} 16:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:52:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:01 INFO - Downloading docopt-0.6.1.tar.gz 16:52:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:01 INFO - Running setup.py install for blobuploader 16:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:52:01 INFO - Running setup.py install for requests 16:52:01 INFO - Running setup.py install for docopt 16:52:02 INFO - Successfully installed blobuploader requests docopt 16:52:02 INFO - Cleaning up... 16:52:02 INFO - Return code: 0 16:52:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:52:02 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')]} 16:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:02 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')]} 16:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:02 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 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:52:02 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 16:52:02 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 16:52:02 INFO - Using env: {'DISPLAY': ':0', 16:52:02 INFO - 'HOME': '/home/cltbld', 16:52:02 INFO - 'LANG': 'en_US.UTF-8', 16:52:02 INFO - 'LANGUAGE': 'en_US:en', 16:52:02 INFO - 'LOGNAME': 'cltbld', 16:52:02 INFO - 'MAIL': '/var/mail/cltbld', 16:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:02 INFO - 'MOZ_NO_REMOTE': '1', 16:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:02 INFO - 'NO_EM_RESTART': '1', 16:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:02 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:02 INFO - 'SHELL': '/bin/bash', 16:52:02 INFO - 'SHLVL': '1', 16:52:02 INFO - 'TERM': 'linux', 16:52:02 INFO - 'TMOUT': '86400', 16:52:02 INFO - 'USER': 'cltbld', 16:52:02 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:02 INFO - '_': '/tools/buildbot/bin/python'} 16:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:52:02 INFO - Running setup.py (path:/tmp/pip-tqePs7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:52:02 INFO - Running setup.py (path:/tmp/pip-7GtoaZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:52:02 INFO - Running setup.py (path:/tmp/pip-UcHbST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:52:02 INFO - Running setup.py (path:/tmp/pip-w3urAV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:52:02 INFO - Running setup.py (path:/tmp/pip-7XU83O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:52:02 INFO - Running setup.py (path:/tmp/pip-w9Lyhz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:52:02 INFO - Running setup.py (path:/tmp/pip-zcVNMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:52:02 INFO - Running setup.py (path:/tmp/pip-voWADk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:52:02 INFO - Running setup.py (path:/tmp/pip-GHFXJl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:52:02 INFO - Running setup.py (path:/tmp/pip-ww0VMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:52:03 INFO - Running setup.py (path:/tmp/pip-qhDPG4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:52:03 INFO - Running setup.py (path:/tmp/pip-Udk7G7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:52:03 INFO - Running setup.py (path:/tmp/pip-I2d7U_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:52:03 INFO - Running setup.py (path:/tmp/pip-RNQOfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:52:03 INFO - Running setup.py (path:/tmp/pip-lx5NBQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:52:03 INFO - Running setup.py (path:/tmp/pip-QebMBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:52:03 INFO - Running setup.py (path:/tmp/pip-8PqqfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:52:03 INFO - Running setup.py install for manifestparser 16:52:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:52:03 INFO - Running setup.py install for mozcrash 16:52:03 INFO - Running setup.py install for mozdebug 16:52:03 INFO - Running setup.py install for mozdevice 16:52:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:52:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:52:03 INFO - Running setup.py install for mozfile 16:52:04 INFO - Running setup.py install for mozhttpd 16:52:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Running setup.py install for mozinfo 16:52:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Running setup.py install for mozInstall 16:52:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Running setup.py install for mozleak 16:52:04 INFO - Running setup.py install for mozlog 16:52:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Running setup.py install for moznetwork 16:52:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Running setup.py install for mozprocess 16:52:04 INFO - Running setup.py install for mozprofile 16:52:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:52:04 INFO - Running setup.py install for mozrunner 16:52:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:52:05 INFO - Running setup.py install for mozscreenshot 16:52:05 INFO - Running setup.py install for moztest 16:52:05 INFO - Running setup.py install for mozversion 16:52:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:52:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:52:05 INFO - Cleaning up... 16:52:05 INFO - Return code: 0 16:52:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:05 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 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:52:05 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 16:52:05 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 16:52:05 INFO - Using env: {'DISPLAY': ':0', 16:52:05 INFO - 'HOME': '/home/cltbld', 16:52:05 INFO - 'LANG': 'en_US.UTF-8', 16:52:05 INFO - 'LANGUAGE': 'en_US:en', 16:52:05 INFO - 'LOGNAME': 'cltbld', 16:52:05 INFO - 'MAIL': '/var/mail/cltbld', 16:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:05 INFO - 'MOZ_NO_REMOTE': '1', 16:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:05 INFO - 'NO_EM_RESTART': '1', 16:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:05 INFO - 'SHELL': '/bin/bash', 16:52:05 INFO - 'SHLVL': '1', 16:52:05 INFO - 'TERM': 'linux', 16:52:05 INFO - 'TMOUT': '86400', 16:52:05 INFO - 'USER': 'cltbld', 16:52:05 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:05 INFO - '_': '/tools/buildbot/bin/python'} 16:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:52:05 INFO - Running setup.py (path:/tmp/pip-ELuuBS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:52:05 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)) 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:52:05 INFO - Running setup.py (path:/tmp/pip-a4H09E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:52:05 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)) 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:52:05 INFO - Running setup.py (path:/tmp/pip-M63RDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:52:05 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)) 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:52:05 INFO - Running setup.py (path:/tmp/pip-HFeXgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:52:05 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)) 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:52:05 INFO - Running setup.py (path:/tmp/pip-pwefvT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:52:05 INFO - Running setup.py (path:/tmp/pip-Ma6RtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:52:05 INFO - Running setup.py (path:/tmp/pip-7QovRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:52:06 INFO - Running setup.py (path:/tmp/pip-54C3pw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:52:06 INFO - Running setup.py (path:/tmp/pip-_4T0XT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:52:06 INFO - Running setup.py (path:/tmp/pip-fHvvDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:52:06 INFO - Running setup.py (path:/tmp/pip-B1npvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:52:06 INFO - Running setup.py (path:/tmp/pip-W_CCJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:52:06 INFO - Running setup.py (path:/tmp/pip-KSdYPa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:52:06 INFO - Running setup.py (path:/tmp/pip-oFIXIP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:52:06 INFO - Running setup.py (path:/tmp/pip-w5wVOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:52:06 INFO - Running setup.py (path:/tmp/pip-zhxQ3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:52:06 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)) 16:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:52:06 INFO - Running setup.py (path:/tmp/pip-O76Fry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:08 INFO - Downloading blessings-1.5.1.tar.gz 16:52:08 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 16:52:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:52:08 INFO - Installing collected packages: blessings 16:52:08 INFO - Running setup.py install for blessings 16:52:08 INFO - Successfully installed blessings 16:52:08 INFO - Cleaning up... 16:52:08 INFO - Return code: 0 16:52:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:52:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:52:08 INFO - Reading from file tmpfile_stdout 16:52:08 INFO - Current package versions: 16:52:08 INFO - argparse == 1.2.1 16:52:08 INFO - blessings == 1.5.1 16:52:08 INFO - blobuploader == 1.2.4 16:52:08 INFO - docopt == 0.6.1 16:52:08 INFO - manifestparser == 1.1 16:52:08 INFO - mozInstall == 1.12 16:52:08 INFO - mozcrash == 0.16 16:52:08 INFO - mozdebug == 0.1 16:52:08 INFO - mozdevice == 0.47 16:52:08 INFO - mozfile == 1.2 16:52:08 INFO - mozhttpd == 0.7 16:52:08 INFO - mozinfo == 0.9 16:52:08 INFO - mozleak == 0.1 16:52:08 INFO - mozlog == 3.1 16:52:08 INFO - moznetwork == 0.27 16:52:08 INFO - mozprocess == 0.22 16:52:08 INFO - mozprofile == 0.27 16:52:08 INFO - mozrunner == 6.11 16:52:08 INFO - mozscreenshot == 0.1 16:52:08 INFO - mozsystemmonitor == 0.0 16:52:08 INFO - moztest == 0.7 16:52:08 INFO - mozversion == 1.4 16:52:08 INFO - psutil == 3.1.1 16:52:08 INFO - requests == 1.2.3 16:52:08 INFO - wsgiref == 0.1.2 16:52:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:52:08 INFO - Using env: {'DISPLAY': ':0', 16:52:08 INFO - 'HOME': '/home/cltbld', 16:52:08 INFO - 'LANG': 'en_US.UTF-8', 16:52:08 INFO - 'LANGUAGE': 'en_US:en', 16:52:08 INFO - 'LOGNAME': 'cltbld', 16:52:08 INFO - 'MAIL': '/var/mail/cltbld', 16:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:08 INFO - 'MOZ_NO_REMOTE': '1', 16:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:08 INFO - 'NO_EM_RESTART': '1', 16:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:08 INFO - 'SHELL': '/bin/bash', 16:52:08 INFO - 'SHLVL': '1', 16:52:08 INFO - 'TERM': 'linux', 16:52:08 INFO - 'TMOUT': '86400', 16:52:08 INFO - 'USER': 'cltbld', 16:52:08 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:08 INFO - '_': '/tools/buildbot/bin/python'} 16:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:09 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 1)) 16:52:09 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 2)) 16:52:09 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 3)) 16:52:09 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 4)) 16:52:09 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 5)) 16:52:09 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 6)) 16:52:09 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 7)) 16:52:09 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 8)) 16:52:09 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:52:09 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 3)) 16:52:09 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:52:09 INFO - Cleaning up... 16:52:09 INFO - Return code: 0 16:52:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:52:09 INFO - Using env: {'DISPLAY': ':0', 16:52:09 INFO - 'HOME': '/home/cltbld', 16:52:09 INFO - 'LANG': 'en_US.UTF-8', 16:52:09 INFO - 'LANGUAGE': 'en_US:en', 16:52:09 INFO - 'LOGNAME': 'cltbld', 16:52:09 INFO - 'MAIL': '/var/mail/cltbld', 16:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:09 INFO - 'MOZ_NO_REMOTE': '1', 16:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:09 INFO - 'NO_EM_RESTART': '1', 16:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:09 INFO - 'SHELL': '/bin/bash', 16:52:09 INFO - 'SHLVL': '1', 16:52:09 INFO - 'TERM': 'linux', 16:52:09 INFO - 'TMOUT': '86400', 16:52:09 INFO - 'USER': 'cltbld', 16:52:09 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:09 INFO - '_': '/tools/buildbot/bin/python'} 16:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:09 INFO - Downloading/unpacking jsonschema 16:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:52:11 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 16:52:11 INFO - Downloading/unpacking functools32 (from jsonschema) 16:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:52:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:52:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:52:11 INFO - warning: no files found matching '*.txt' 16:52:11 INFO - no previously-included directories found matching 'build' 16:52:11 INFO - no previously-included directories found matching 'dist' 16:52:11 INFO - no previously-included directories found matching '.git*' 16:52:11 INFO - Installing collected packages: jsonschema, functools32 16:52:11 INFO - Running setup.py install for functools32 16:52:11 INFO - warning: no files found matching '*.txt' 16:52:11 INFO - no previously-included directories found matching 'build' 16:52:11 INFO - no previously-included directories found matching 'dist' 16:52:11 INFO - no previously-included directories found matching '.git*' 16:52:11 INFO - Successfully installed jsonschema functools32 16:52:11 INFO - Cleaning up... 16:52:11 INFO - Return code: 0 16:52:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:52:11 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')]} 16:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:11 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')]} 16:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:11 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 0x7fed1e93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', '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 16:52:11 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 16:52:11 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 16:52:11 INFO - Using env: {'DISPLAY': ':0', 16:52:11 INFO - 'HOME': '/home/cltbld', 16:52:11 INFO - 'LANG': 'en_US.UTF-8', 16:52:11 INFO - 'LANGUAGE': 'en_US:en', 16:52:11 INFO - 'LOGNAME': 'cltbld', 16:52:11 INFO - 'MAIL': '/var/mail/cltbld', 16:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:11 INFO - 'MOZ_NO_REMOTE': '1', 16:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:11 INFO - 'NO_EM_RESTART': '1', 16:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:11 INFO - 'SHELL': '/bin/bash', 16:52:11 INFO - 'SHLVL': '1', 16:52:11 INFO - 'TERM': 'linux', 16:52:11 INFO - 'TMOUT': '86400', 16:52:11 INFO - 'USER': 'cltbld', 16:52:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:11 INFO - '_': '/tools/buildbot/bin/python'} 16:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:11 INFO - Downloading/unpacking flake8 16:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:52:13 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 16:52:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:52:13 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 16:52:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 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 16:52:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:52:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:52:14 INFO - no previously-included directories found matching 'docs/_build' 16:52:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:52:14 INFO - Running setup.py install for pep8 16:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:52:14 INFO - no previously-included directories found matching 'docs/_build' 16:52:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:52:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:52:14 INFO - Cleaning up... 16:52:14 INFO - Return code: 0 16:52:14 INFO - Running post-action listener: _resource_record_post_action 16:52:14 INFO - Running post-action listener: _start_resource_monitoring 16:52:14 INFO - Starting resource monitoring. 16:52:14 INFO - ##### 16:52:14 INFO - ##### Running install step. 16:52:14 INFO - ##### 16:52:14 INFO - Running pre-action listener: _resource_record_pre_action 16:52:14 INFO - Running main action method: install 16:52:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:52:14 INFO - Reading from file tmpfile_stdout 16:52:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:52:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:52:14 INFO - Reading from file tmpfile_stdout 16:52:14 INFO - Output received: 16:52:14 INFO - Usage: mozinstall [options] installer 16:52:14 INFO - Options: 16:52:14 INFO - -h, --help show this help message and exit 16:52:14 INFO - -d DEST, --destination=DEST 16:52:14 INFO - Directory to install application into. [default: 16:52:14 INFO - "/builds/slave/test-pgo"] 16:52:14 INFO - --app=APP Application being installed. [default: firefox] 16:52:14 INFO - mkdir: /builds/slave/test-pgo/build/application 16:52:14 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'] 16:52:14 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 16:52:30 INFO - Reading from file tmpfile_stdout 16:52:30 INFO - Output received: 16:52:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:52:30 INFO - Running post-action listener: _resource_record_post_action 16:52:30 INFO - ##### 16:52:30 INFO - ##### Running run-tests step. 16:52:30 INFO - ##### 16:52:30 INFO - Running pre-action listener: _resource_record_pre_action 16:52:30 INFO - Running main action method: run_tests 16:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:52:30 INFO - Python 2.7.3 16:52:30 INFO - Return code: 0 16:52:30 INFO - grabbing minidump binary from tooltool 16:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:30 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 0xe85350>, '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 0xe86250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe866e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:52:30 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 16:52:30 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 16:52:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:52:30 INFO - Return code: 0 16:52:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:52:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:52:31 INFO - Return code: 0 16:52:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:52:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 16:52:31 INFO - Using env: {'DISPLAY': ':0', 16:52:31 INFO - 'HOME': '/home/cltbld', 16:52:31 INFO - 'LANG': 'en_US.UTF-8', 16:52:31 INFO - 'LANGUAGE': 'en_US:en', 16:52:31 INFO - 'LOGNAME': 'cltbld', 16:52:31 INFO - 'MAIL': '/var/mail/cltbld', 16:52:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:52:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:31 INFO - 'MOZ_NO_REMOTE': '1', 16:52:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:31 INFO - 'NO_EM_RESTART': '1', 16:52:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:52:31 INFO - 'SHELL': '/bin/bash', 16:52:31 INFO - 'SHLVL': '1', 16:52:31 INFO - 'TERM': 'linux', 16:52:31 INFO - 'TMOUT': '86400', 16:52:31 INFO - 'USER': 'cltbld', 16:52:31 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581', 16:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:31 INFO - '_': '/tools/buildbot/bin/python'} 16:52:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 16:52:31 INFO - mozversion INFO | application_buildid: 20151218143002 16:52:31 INFO - mozversion INFO | application_changeset: 53556a49e56e2965e69153e41c57b5b1a182a8b6 16:52:31 INFO - mozversion INFO | application_display_name: Nightly 16:52:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:52:31 INFO - mozversion INFO | application_name: Firefox 16:52:31 INFO - mozversion INFO | application_remotingname: firefox 16:52:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:52:31 INFO - mozversion INFO | application_vendor: Mozilla 16:52:31 INFO - mozversion INFO | application_version: 46.0a1 16:52:31 INFO - mozversion INFO | platform_buildid: 20151218143002 16:52:31 INFO - mozversion INFO | platform_changeset: 53556a49e56e2965e69153e41c57b5b1a182a8b6 16:52:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:52:31 INFO - mozversion INFO | platform_version: 46.0a1 16:52:31 INFO - 2015-12-18 16:52:31,528 DEBUG : using testdate: 1450486351 16:52:31 INFO - 2015-12-18 16:52:31,528 DEBUG : actual date: 1450486351 16:52:31 INFO - 2015-12-18 16:52:31,536 INFO : starting webserver on 'localhost:50745' 16:52:31 INFO - 2015-12-18 16:52:31,537 INFO : Starting test suite talos-linux64-ix-058 16:52:31 INFO - 2015-12-18 16:52:31,537 INFO : Starting test dromaeo_css 16:52:31 INFO - 2015-12-18 16:52:31,537 DEBUG : operating with platform_type : linux_ 16:52:31 INFO - 2015-12-18 16:52:31,538 INFO : Initialising browser for dromaeo_css test... 16:52:31 INFO - 2015-12-18 16:52:31,554 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNLnwXv/profile http://localhost:50745/getInfo.html 16:52:35 INFO - 2015-12-18 16:52:35,368 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:52:35 INFO - 2015-12-18 16:52:35,369 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:52:35 INFO - 2015-12-18 16:52:35,369 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:52:35 INFO - 2015-12-18 16:52:35,369 DEBUG : BROWSER_OUTPUT: __metrics 16:52:35 INFO - 2015-12-18 16:52:35,453 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:52:35 INFO - 2015-12-18 16:52:35,509 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:36 INFO - 2015-12-18 16:52:36,722 INFO : Browser initialized. 16:52:36 INFO - 2015-12-18 16:52:36,723 INFO : Running cycle 1/1 for dromaeo_css test... 16:52:36 INFO - 2015-12-18 16:52:36,723 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNLnwXv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:52:48 INFO - 2015-12-18 16:52:48,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 150274048 16:52:48 INFO - 2015-12-18 16:52:48,479 DEBUG : BROWSER_OUTPUT: 16:53:40 INFO - 2015-12-18 16:53:40,145 DEBUG : BROWSER_OUTPUT: 1450486420142 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] 16:55:48 INFO - 2015-12-18 16:55:48,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50745/tests/dromaeo/cssquery-ext.html) 16:55:49 INFO - 2015-12-18 16:55:49,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 235765760 16:55:49 INFO - 2015-12-18 16:55:49,843 DEBUG : BROWSER_OUTPUT: 16:58:52 INFO - 2015-12-18 16:58:52,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/dromaeo/cssquery-ext.html (next: http://localhost:50745/tests/dromaeo/cssquery-jquery.html) 16:58:52 INFO - 2015-12-18 16:58:52,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 234704896 16:58:52 INFO - 2015-12-18 16:58:52,689 DEBUG : BROWSER_OUTPUT: 17:01:54 INFO - 2015-12-18 17:01:54,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50745/tests/dromaeo/cssquery-mootools.html) 17:01:55 INFO - 2015-12-18 17:01:55,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 227713024 17:01:55 INFO - 2015-12-18 17:01:55,265 DEBUG : BROWSER_OUTPUT: 17:04:57 INFO - 2015-12-18 17:04:57,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50745/tests/dromaeo/cssquery-prototype.html) 17:04:57 INFO - 2015-12-18 17:04:57,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 206569472 17:04:57 INFO - 2015-12-18 17:04:57,718 DEBUG : BROWSER_OUTPUT: 17:08:00 INFO - 2015-12-18 17:08:00,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50745/tests/dromaeo/cssquery-yui.html) 17:08:00 INFO - 2015-12-18 17:08:00,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 216465408 17:08:00 INFO - 2015-12-18 17:08:00,752 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/dromaeo/cssquery-yui.html (next: http://localhost:50745/tests/dromaeo/cssquery-dojo.html) 17:11:03 INFO - 2015-12-18 17:11:03,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 306020352 17:11:03 INFO - 2015-12-18 17:11:03,551 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:11:03 INFO - 2015-12-18 17:11:03,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:11:03 INFO - 2015-12-18 17:11:03,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:11:03 INFO - 2015-12-18 17:11:03,552 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:11:03 INFO - 2015-12-18 17:11:03,553 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3075.47716888129;3143.685631436855;3201.5677883485723;3203.3593281343724;3228.3866065447555;5165.81919632813;5295.549878260343;5349.866253343668;5375.892482150354;5401.972990135044;5193.298904647881;5262.184361423976;5312.335958005249;5312.867178320544;5321.654092483986;4812.807487700487;4859.392575928009;4873.610111191114;4934.6299027572895;4992.026554821811;4731.5268473152755;4975.577075948549;4993.550580447759;4999.850004499871;5052.0906236877345;4852.369192005034;4854.441739200002;4930.950690493085;4941.579965702919;4949.628777841676;4836.854894353175;4841.080194762983;4850.563449289581;4855.830045948375;4877.902441951177;4758.1673207188605;4830;4833.057553777015;4862.1491239033385;4886.169351210267;5050.39395272566;5130.025295193938;5135.306733590992;5159.2003239497935;5180.6891586504935;5694.800681976152;5704.971475142639;5713.485786279255;5718.256626638552;5719.370869204384;5510.6969116698565;5645.407232240596;5726.284214473191;5728.369879313273;5728.570357223183;5323.627346085776;5389.380221274525;5408.810691625853;5409.83770486886;5459.863503412406;5766.452187042224;5769.307683078057;5773.134029895466;5776.913346299809;5779.2775903012125;5498.45015498447;5591.888162236733;5592.5805564582815;5598.608097433222;5615.410381909923;5590.8043218487155;5649.915251271234;5650.7174641267775;5652.349979752299;5707.942920570741;5623.0721930880945;5672.773089076473;5673.631213971079;5675.120356344691;5677.687727175045;5555;5563.944360556424;5667.688277144796;5690.174924635905;5703.515201207943;4415.028693687384;4431.379606855043;4437.622802061796;4443.6889417741095;4481.619062379669;3933.174033453007;3942;3970.4838371011583;3991.022199561126;4007.278689835799;5234.633575649668;5304.681719096867;5338.652987555796;5382.111951527954;5421.891562168735;5638.182463542763;5782;5787.074068149076;5810.622309549865;5813.244278243886;5417.5395091416885;5432.076546987022;5432.75552600134;5437.673739575638;5440.591955603346;4843.104025755176;4890.902181956341;4903.264510323409;4922.950770492249;5028.723420211923;5892.469677729025;5921.644701317935;5925.081612350093;5927.288725352985;5928.199693041471;5766.5675074368755;5783.19035335045;5793.739281732248;5799.391063938226;5804.100364443518;5764.942350576608;5786.161006653927;5845.678487683218;5856.795012174553;5926.318473375444;5658.603897727119;5660.264165658438;5663.66018038919;5666.263385759825;5676.091825307931;5704.971475142598;5744.080947048452;5750;5752.9712351437975;5766.308043034863;5363.651362661414;5395.81114660985;5438.537724293479;5519.254900588369;5532.419095995024;5589.161625756169;5590.161475778503;5592.916106258328;5595.804146854841;5596.888062238814;5494.2033405155225;5509.393966663744;5511.118221084607;5514;5563.388027317073;5459.890802184013;5513.917291240555;5572.582056345709;5602.607817452902;5687.544996400361;5527.585431092603;5530.115181570929;5540.279763630702;5550.084236100998;5592.468715472024 17:11:03 INFO - 2015-12-18 17:11:03,555 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.7477972302325;578.4620303118102;581.1950448628648;582.6591444005255;590.1884908251154;29599.26001849955;38745.61254387455;39279.60720392795;39306;39377.40933885991;42805.57194428055;42873.35689964653;43326.783366083124;43435.131297374035;43469.30510906577;7517.586532740697;7625.8474830503355;8632.741017769462;8804.075572064938;8811.030786613468;10487.108595769369;10734.248602597821;10756.300840445347;10760.192985526117;10760.623378181765;10435.530401131968;10545;10551.683449496528;10551.73620659482;10559.208059395538;7757.301842834116;7949.72175973844;10384.584616615364;10547.314424562379;10851.891481085246;10177.287589868713;10361.326513776581;10372.688819335432;10377.740556486073;10379.532921018572;40490;40838.79580602078;40908;40956.38565421521;40997;3092.443360195164;3253.024092772159;3402.3025279817825;3472.808995505246;3910.4720862683457;29590;29614.25964350887;30058.54912176319;30262.54606180887;30353.544696829566;3592.7125829933543;3660.7254455915913;3661.2311414602964;3685.262947410502;3764.726856735347;243197;243319.78340108364;244359;244834;245989;54191.72904135454;55195.17207241894;55223.723881380334;59368.70315648394;59788.701056494436;48340.27489587659;70449;71710.64144679243;71865;71875;16050.598735031484;16199.352025919066;16311.429099981444;16320.347186112422;16323.836761632232;12398.938005309916;12476.563320283927;12476.81284780729;12480.063995200397;12481.56314528987;20396.388108356772;20441.26249268799;20747.1701131953;20776.896115519325;20809.479763006046;7897.131315555284;8055.5972201389695;8147.959260203779;8174.182581741898;8191.549464779494;897.3897749530382;936.765808547863;999.5102399824034;1026.1329176845554;1038.0138868075207;28861.268323900633;31342.37315253682;32357.19107022296;32423.35153296921;32584.76748990639;934.1965909317981;962.9951850240705;1007.2093406675871;1026.3533973596586;1107.5901916291025;14625.926870365793;14781.05353896153;14820.3330850112;14844.703105938037;14893.627659308604;699340;709672;715103;715944;717220;54667.72666136644;55270;55298.17052744212;55356.16965745517;55367.169492457644;1344.509254122258;1354.3160703844692;1365.4196966289287;1367.8358596968428;1380.675541247806;27978.300542485787;29003.564946525395;29244.853775730986;29466.852665736533;29471.55792663069;46674;47243.763781180875;47258.763706182624;47281.52718472771;47406.76296618495;287619;291763;294914;295182;394943;31849.8407507961;31916.84041579777;31967.520487192247;32137.839310803298;32148.678513215506;42340;42768.57231427646;43127.13745725131;43869.78065109654;44128.77935610301;36096.27807443889;36361.818190908874;36508.63491365052;36535;37480.250394992494;36061.45907811332;36694.08264793402;36820.07949801169;36987.81506092452;37121.81439092787;35322;36061.45907811332;36331.63668363282;36377.636223637426;36582;29903.401931960805;30016.099517014525;33086;33365;33392.332153356314;24675;24789.25632231036;24846.875765621055;24869.378265543506;25148.874255628605 17:11:03 INFO - 2015-12-18 17:11:03,556 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.6177109607172;360.46650956584256;360.5295089907673;361.4469861112497;362.6373626373626;13658.38537265823;13770.518031868887;16462.670746585078;16696.83303166968;17251.654966900653;13377.331133443313;13933.860661393383;15933.20333983302;16179.35282588698;16286;5243.2659427680155;5408.567314614841;5417.864553386177;5418.376886658026;5425.891482170354;3655.1775850433573;3726.7763934164036;5178.844634660966;5307.708076055835;5351.598630102739;5370.113931201347;5513.393526712059;5522.22688823565;5533.916991245134;5534.833954981357;5369.677819330833;5497.202905578689;5515.338159420875;5939.792107276267;5951.6726580038085;5264.763085661116;5328.893422131575;5335.466453354672;5338.679679219221;5341.4658534146665;12756.362181890869;12817.67955801103;13302.068855180141;13329;13383.19700817954;1861.748663930379;1900.7719073711105;1957.3442896629647;1962.0876292523901;2034.8270397016124;9536.332456728032;9607.4715890626;9809.264305177068;9852.261080418997;9890.703278901572;1790.239148361954;1820.335577514211;1832.4502649205185;1835.8347748702681;1885.5568941298784;58982;59011;59824.40175598232;60256;62025.37974620286;9734.561944712505;10154.695359139238;10185.490725463846;10240.48797560119;10247.180225581935;13303.66740831487;13400;13444.798328025088;13454.394552245172;13473.461061557427;7767.961160194162;7794.298513133732;7811.218878112143;7848.882266766003;7856.214378562098;7596.126445458733;7612.657430415645;7617.047869016373;7657.693692252359;7668.427972265672;4369;4401.735895846259;4411.602955733935;4436.711613745097;4460.04109116535;1676.4551520755804;1736.2447335409138;1783.8929664220188;1819.8999055051834;1850.6113716119496;806.395203597302;883.4169448164181;952.5046975572802;954.9924829305149;1045.7960697663882;15142;15625.453109141126;15927.203639817963;15941.362345506283;16018.279177437043;803.6704950970075;851.948883067018;879.6745204274459;889.4352086425166;896.5696465696502;8652.740417787476;8877.156670116328;9070.54647267634;9352.719418417459;9717.854232186522;520554;550517;555053;581640;587337.9496537776;81443.59278203572;83438;83561.58219208865;83880.58059709784;83973.58013209894;1139.4132022008507;1158.5887010111458;1169.2341516306833;1178.8938995490446;1183.1540448579308;15134.470293539673;15201.77197342063;15327.846721533087;15361.692766144391;15619.21903904823;36081.45877811783;36165.819170903975;36624.63375366212;36670.266594667424;38432.423513647875;47810.76094619644;48585;52824.735876320374;54079.459205407446;55548.44451555433;8584.613692383733;9029.593668284811;9049.411788233743;9085.545722713705;9157.175854173156;10741.785164296514;10815.945920270347;11971.760564788481;17119.400820971205;17617;13744.312784360942;13879.306034698428;13886.166829990232;14018.439262429389;14054.297285135906;13834.515791947233;14077.436902523785;14447.205403702897;14557.781633275721;14645.780313295096;10460.372377657364;10747.193960453154;13735.725285494435;14096.647583810076;14413.423463061361;8948.865767013369;9017.233535149586;9042.231410330196;9150.63397464094;9200.815983680155;13395.665108372368;13553.661158471117;13620.04659673853;13822.308884555932;14166.150030998173 17:11:03 INFO - 2015-12-18 17:11:03,557 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1417.9078359906607;1475.0633347824132;1515;1578.7237233484138;1742.5904912345597;6547.901781473276;7154;7508.587027713474;7539.9246007539905;7543.811404714885;7348.485606007582;7472.663730132143;7493.250674932504;7511.962440187805;7515.098188217408;1941.3884626342656;1968.8621796474254;1971.3888694504749;2203.3610253026645;2250.797428231459;2019.9495012624654;2173.3588591365583;2226.944326391845;2228.0419419649543;2230.9107635694554;2191.605511008018;2219.323106452531;2224.443889027743;2226.3543572363997;2248.561530501545;2233.944151396212;2254.954900901973;2257.582347265753;2258.706368172127;2259.2092767531317;2152.332776839185;2187.5187458759046;2187.56248750249;2191.2768786300644;2193.1885202475028;7478.476506644537;7538.246175382473;7548.886766698504;7565.546067235929;7570.659320330598;4444.466664000308;4455.131249406367;4471.351654010183;4501.369808226851;4510.616597589209;2988.148377712363;3012.698730126992;3017.3814368054714;3024.017194411803;3034.3931213757114;971.4910102314522;972.4457059476101;978.505854543451;988.569972062148;1010.2170817616333;10006.399616022989;10054.899451005469;10117.797644047152;10126.493675316206;10135.138513226384;4013.3177359848896;4027.2549578328103;4052.8986775330263;4079.286699586181;4091.6931230157857;8457.53483558398;8529.701460448854;8553.101924297984;8554.700585479603;8580.313574913991;4472.284434490466;4499.055198408306;4500.459944806644;4508.954910450919;4514.0971805639;4123.814428350732;4135.937960930589;4158.563350848118;4174.707770456039;4182.372644103409;3342.632310445849;3515.876944306937;3518.20840310928;3531.5585551806025;3572.035550401377;1073.355986408149;1082.9566817327377;1106.397013627575;1109.589451902801;1132.128261238858;925.167349385545;930.5440334236175;994.751312171957;1001.0090010889168;1277.8722127787146;6685.364890335411;6724.3948044675235;6726.428253598499;6732.730690772314;6735.932640673628;1091.7052395853075;1093.6609651008214;1099.8735145458375;1106.0543235533664;1108.2020944919645;5251.6061295403;5268.552173065333;5294.682319060792;5302.496262855023;5312.150055991023;8631.6978905738;8786.780330491789;8936.41913275635;9066.592003359732;9124.543772811332;8905.910940890508;8933.553322333857;8938.284937205008;8944.329175311877;8952.731418057469;6635.668216589248;6979.511434199558;7002.544834585736;7035.613041282779;7059.929400705927;6720.495962802907;6727;6760.898586521108;6775.898361524482;6778.084958530535;7622.885656715264;7844.84310313802;7851.332636725942;7988.84022319562;8017.318527925192;8008.479448835807;8169.55067471271;8174.959125204336;8282.668693252203;8321.334293256647;6207.255129384323;6248.218972628421;6289.49684025286;6298.433141017331;6320.146780184617;6300.495960323072;6491.545591808528;7090.220075791555;7146.499745017799;7156.534825236343;6353.523485738496;6372.171617689671;6638.83402914931;6683;6774.051632771318;6614.206295244409;6726.3273672634305;6735.225449073419;6771.898421523582;6778.525503214728;5947.286325640951;6253.187085679015;6262.123302737711;6263.96868015657;6275.6548389839;5743.282089738783;5989.401059893976;5996.760129594942;5998.280206375263;6005.129256257731;5936.7922122725495;5994.400559943971;5994.88010239784;6066.757329706938;6074.817755467343 17:11:03 INFO - 2015-12-18 17:11:03,559 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.99342013159753;336.2468071519796;340.25993464215327;342.9194139377246;353.04325278495276;5796.594238403313;5877.853053673661;5887.705614719268;5892.499137573301;5946.494547963417;5648.491635752782;5785.479306862381;5802.941970580293;5803.970980145104;5805;4446.933296000562;4541.318802179667;4550.795214215352;4586.3808385867815;4595.747233902134;4541.864533866534;4556.84051058213;4562.543745625428;4564.5435456454425;4570.223062079438;4387.736735795863;4437.156940181371;4480.14877173336;4532.070925460289;4536.432945881765;4547.408836851188;4548.135854187693;4560.794764235618;4570.154521413516;4574.4510658721;4043;4045.37296719009;4046.6560342370935;4047.8868311214355;4055.513338399411;5630.577706672016;5633.352164501053;5636.464535869086;5638.069718496443;5639.520640745542;5105.310783044316;5250.553702935255;5288.65623734456;5313.229581710669;5325.520703136736;6233.937660623381;6240.063990401431;6240.251169859646;6241.032639940817;6242.781502647431;4413.029133590605;4419.292913133915;4421.027373977719;4422.977885110586;4427.5572442755465;6348.079528468393;6456.225252969627;6504.642244676541;6519.282878883319;6539.64031978241;4488.820447182142;4507.256302710081;4507.5267096955;4508.752018639007;4510.481294651091;4551.203539380595;4553.408056952575;4554;4554.4990051094355;4555.954440455553;5225.947740522546;5230.241614965808;5237.240600112962;5239.476052394806;5239.816606418757;6155.10750941111;6274.121622972787;6289.7484100636375;6294.150289710922;6304.3695630437505;1588.801399825022;1613.782139411188;1614.8465895739887;1615.0874755762957;1615.6284054667492;1043.3583346242158;1062.8830828608848;1070.1973519860105;1074.1889873145724;1077.1436707817304;6031.4270144336215;6048.516118710492;6066.939330606638;6067.332593414721;6067.634782174064;6516.413522782877;6517.185351831021;6524.217093948661;6526.412622863965;6530.444912182423;5856.853578660568;5908;6059.7273122709585;6076.969615151896;6077.696115194222;3473.4095203815414;3488.337215928965;3512.841922113511;3513.578370595545;3514.24443744591;6733.831654208684;6736.5958042517605;6738.932610673831;6741.528093033538;6745.5952642841585;6556.508261880378;6754.425873800684;6754.797356079325;6762.526623136431;6767.323267673193;6720.630365329954;6728.730850766013;6735.6295403753265;6736.730530778714;6738.090357801634;6544.116544266463;6561.278259391559;6569.178852643419;6573;6575.539712220098;6291.339409361951;6459.418652321314;6467;6467.741290348334;6483.902741458787;6609.173853268341;6616.305287944697;6641;6706.83232919181;6710.496712746466;4458.665600080072;4498.3252512123445;4516.661250406299;4520.141173177086;4522.29904364824;6378.77674281398;6514.446272066927;6550.246721626883;6555.2789193187755;6558.409743123142;6402.839929001626;6403.327650596807;6406.775762848278;6407.391297826699;6410.294867564658;6388.201474815648;6391.360863913757;6391.552591318563;6396.520260980352;6396.584222025554;6128.387161283836;6255.061740738925;6256.249250090018;6278.277998030285;6279.96860015697;6409.487241020801;6412.839679008062;6413.518986075969;6417.679116044085;6421.357864213542;6255.124282600348;6263.404976527223;6264.498840092872;6265.686715664107;6282.623042617458 17:11:03 INFO - 2015-12-18 17:11:03,560 DEBUG : BROWSER_OUTPUT: |5;yui.html;847.5677404523695;852.2925971443702;857.3612658569365;860.7073594977707;888.0453512474091;13756.724865502696;13997.930010349959;13999.510017149389;14001.159930404183;14041.859581404184;12215.877841221585;12303.815442768344;12312.076594255423;12323.075769317315;12347.876521234784;690.647769637486;691.2327316678483;833.6332013913889;833.9416240863158;848.859938110211;835.3150416658343;836.3894357119307;844.3371953016883;844.6874656377149;845.5222799118509;865.904750477447;872.2324354568003;877.4428238068808;878.2227728460294;879.4020066354876;706.650208146968;707.6992278281709;848.2916764501648;859.5831021954347;861.2248975921658;641.5861769158867;641.9518536109811;642.1748053750907;642.354433794034;642.4603333200134;13100.672483187902;13168.473261069546;13210.273434961073;13217.801732974012;13249.271290079041;11899.226550274205;12663.746725065539;12711.300878451682;13032.348382580833;13054.934725326408;9994;10290.588376464932;10295.536700848479;10609.522571484302;10803.891961080446;3552.236269202108;3622.0763705255254;3654.232611151635;3696.002079438563;3703.6481534254203;49312.260316095286;49375;49949.25076123861;50020;50032.24951625729;9731.805363892825;9990.650327238513;10071.14395276395;10077.848832267522;10457.267991240693;17687.380941667237;17703.20335584876;17709.822901771076;17722.379716709853;17727.822721772875;7305.634718264066;7584.886226706604;7653.655585498666;7723.536587804638;7739.380849532024;4240.300350442204;4336.284513055373;4358.411614432074;4384.605385515319;4423.159599676052;3064.846757662108;3085.506318988951;3087.382523495265;3089.382123575294;3093.1030001299373;554.365251786702;556.6576555418388;561.7809054468761;564.6724899558246;573.7332140554662;569.5272923473507;590.5806877117209;595.7825393731257;617.1303439008557;618.9412005859436;7399.4450416219;7604.771856844303;7617.428692848059;7815.4529182957785;7859.921400786034;466.5800779298658;513.2352794336412;516.5841497594472;525.6294312509672;526.9367675878842;3357.261402491448;3461.9826900865837;3471.3057388522398;3565.3938830398893;3684.502592150079;52428.68928276824;53319.46680533145;53353.73323133437;53380;53429.46570534245;50647;50926;51248;51298.97402051938;51814.74092629588;45607;45842.541574584495;46235.53764462379;47015;47317.76341118272;7319.304666056716;7360.963195184204;7368.778936631909;7440.479166458296;7650.273224043707;33499.83250083734;34076.488852667724;34151.46318415627;34446.311073777884;34527.65472345345;42793.57206427896;44266.3360049606;44767.776161118985;44964;45253;9888.555015024485;10038.598456061967;10051.296409251283;10211.540480678239;10252.589896404359;10576.4711764413;10694.786104277715;11125.44372781374;11317;11378.203525753117;8817.651211581939;8829.779255518664;8988.640454381752;9088.227500662519;9122.5438728062;10526.894731052898;10916.56333746673;11034.668959931216;11082.722931926766;11300.321980681185;9590.616375344907;9730.464824434725;9833.60665573369;9897;9956.55195516189;8986.68546600866;9164.908350916672;9228.40015398997;9394.812103758024;9523.095305945924;8033.297609849619;8120.187981201832;8440.535770532433;8612.138786121337;8636.740897773077 17:11:03 INFO - 2015-12-18 17:11:03,560 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: __startTimestamp1450487463551__endTimestamp 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:11:03 INFO - 2015-12-18 17:11:03,561 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:11:03 INFO - 2015-12-18 17:11:03,562 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,562 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5300.29 Median:5510.70 stddev:576.67 (10.5%) stddev-sans-first:551.39 17:11:03 INFO - 2015-12-18 17:11:03,563 DEBUG : BROWSER_OUTPUT: Values: 3075.5 3143.7 3201.6 3203.4 3228.4 5165.8 5295.5 5349.9 5375.9 5402.0 5193.3 5262.2 5312.3 5312.9 5321.7 4812.8 4859.4 4873.6 4934.6 4992.0 4731.5 4975.6 4993.6 4999.9 5052.1 4852.4 4854.4 4931.0 4941.6 4949.6 4836.9 4841.1 4850.6 4855.8 4877.9 4758.2 4830.0 4833.1 4862.1 4886.2 5050.4 5130.0 5135.3 5159.2 5180.7 5694.8 5705.0 5713.5 5718.3 5719.4 5510.7 5645.4 5726.3 5728.4 5728.6 5323.6 5389.4 5408.8 5409.8 5459.9 5766.5 5769.3 5773.1 5776.9 5779.3 5498.5 5591.9 5592.6 5598.6 5615.4 5590.8 5649.9 5650.7 5652.3 5707.9 5623.1 5672.8 5673.6 5675.1 5677.7 5555.0 5563.9 5667.7 5690.2 5703.5 4415.0 4431.4 4437.6 4443.7 4481.6 3933.2 3942.0 3970.5 3991.0 4007.3 5234.6 5304.7 5338.7 5382.1 5421.9 5638.2 5782.0 5787.1 5810.6 5813.2 5417.5 5432.1 5432.8 5437.7 5440.6 4843.1 4890.9 4903.3 4923.0 5028.7 5892.5 5921.6 5925.1 5927.3 5928.2 5766.6 5783.2 5793.7 5799.4 5804.1 5764.9 5786.2 5845.7 5856.8 5926.3 5658.6 5660.3 5663.7 5666.3 5676.1 5705.0 5744.1 5750.0 5753.0 5766.3 5363.7 5395.8 5438.5 5519.3 5532.4 5589.2 5590.2 5592.9 5595.8 5596.9 5494.2 5509.4 5511.1 5514.0 5563.4 5459.9 5513.9 5572.6 5602.6 5687.5 5527.6 5530.1 5540.3 5550.1 5592.5 17:11:03 INFO - 2015-12-18 17:11:03,564 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,564 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57793.89 Median:3437.56 stddev:126862.38 (3690.5%) stddev-sans-first:127145.50 17:11:03 INFO - 2015-12-18 17:11:03,565 DEBUG : BROWSER_OUTPUT: Values: 566.7 578.5 581.2 582.7 590.2 29599.3 38745.6 39279.6 39306.0 39377.4 42805.6 42873.4 43326.8 43435.1 43469.3 7517.6 7625.8 8632.7 8804.1 8811.0 10487.1 10734.2 10756.3 10760.2 10760.6 10435.5 10545.0 10551.7 10551.7 10559.2 7757.3 7949.7 10384.6 10547.3 10851.9 10177.3 10361.3 10372.7 10377.7 10379.5 40490.0 40838.8 40908.0 40956.4 40997.0 3092.4 3253.0 3402.3 3472.8 3910.5 29590.0 29614.3 30058.5 30262.5 30353.5 3592.7 3660.7 3661.2 3685.3 3764.7 243197.0 243319.8 244359.0 244834.0 245989.0 54191.7 55195.2 55223.7 59368.7 59788.7 48340.3 70449.0 71710.6 71865.0 71875.0 16050.6 16199.4 16311.4 16320.3 16323.8 12398.9 12476.6 12476.8 12480.1 12481.6 20396.4 20441.3 20747.2 20776.9 20809.5 7897.1 8055.6 8148.0 8174.2 8191.5 897.4 936.8 999.5 1026.1 1038.0 28861.3 31342.4 32357.2 32423.4 32584.8 934.2 963.0 1007.2 1026.4 1107.6 14625.9 14781.1 14820.3 14844.7 14893.6 699340.0 709672.0 715103.0 715944.0 717220.0 54667.7 55270.0 55298.2 55356.2 55367.2 1344.5 1354.3 1365.4 1367.8 1380.7 27978.3 29003.6 29244.9 29466.9 29471.6 46674.0 47243.8 47258.8 47281.5 47406.8 287619.0 291763.0 294914.0 295182.0 394943.0 31849.8 31916.8 31967.5 32137.8 32148.7 42340.0 42768.6 43127.1 43869.8 44128.8 36096.3 36361.8 36508.6 36535.0 37480.3 36061.5 36694.1 36820.1 36987.8 37121.8 35322.0 36061.5 36331.6 36377.6 36582.0 29903.4 30016.1 33086.0 33365.0 33392.3 24675.0 24789.3 24846.9 24869.4 25148.9 17:11:03 INFO - 2015-12-18 17:11:03,565 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,565 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29158.87 Median:21079.60 stddev:91548.82 (434.3%) stddev-sans-first:91780.09 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: Values: 355.6 360.5 360.5 361.4 362.6 13658.4 13770.5 16462.7 16696.8 17251.7 13377.3 13933.9 15933.2 16179.4 16286.0 5243.3 5408.6 5417.9 5418.4 5425.9 3655.2 3726.8 5178.8 5307.7 5351.6 5370.1 5513.4 5522.2 5533.9 5534.8 5369.7 5497.2 5515.3 5939.8 5951.7 5264.8 5328.9 5335.5 5338.7 5341.5 12756.4 12817.7 13302.1 13329.0 13383.2 1861.7 1900.8 1957.3 1962.1 2034.8 9536.3 9607.5 9809.3 9852.3 9890.7 1790.2 1820.3 1832.5 1835.8 1885.6 58982.0 59011.0 59824.4 60256.0 62025.4 9734.6 10154.7 10185.5 10240.5 10247.2 13303.7 13400.0 13444.8 13454.4 13473.5 7768.0 7794.3 7811.2 7848.9 7856.2 7596.1 7612.7 7617.0 7657.7 7668.4 4369.0 4401.7 4411.6 4436.7 4460.0 1676.5 1736.2 1783.9 1819.9 1850.6 806.4 883.4 952.5 955.0 1045.8 15142.0 15625.5 15927.2 15941.4 16018.3 803.7 851.9 879.7 889.4 896.6 8652.7 8877.2 9070.5 9352.7 9717.9 520554.0 550517.0 555053.0 581640.0 587337.9 81443.6 83438.0 83561.6 83880.6 83973.6 1139.4 1158.6 1169.2 1178.9 1183.2 15134.5 15201.8 15327.8 15361.7 15619.2 36081.5 36165.8 36624.6 36670.3 38432.4 47810.8 48585.0 52824.7 54079.5 55548.4 8584.6 9029.6 9049.4 9085.5 9157.2 10741.8 10815.9 11971.8 17119.4 17617.0 13744.3 13879.3 13886.2 14018.4 14054.3 13834.5 14077.4 14447.2 14557.8 14645.8 10460.4 10747.2 13735.7 14096.6 14413.4 8948.9 9017.2 9042.2 9150.6 9200.8 13395.7 13553.7 13620.0 13822.3 14166.2 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5150.14 Median:6001.70 stddev:2647.56 (44.1%) stddev-sans-first:2640.12 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: Values: 1417.9 1475.1 1515.0 1578.7 1742.6 6547.9 7154.0 7508.6 7539.9 7543.8 7348.5 7472.7 7493.3 7512.0 7515.1 1941.4 1968.9 1971.4 2203.4 2250.8 2019.9 2173.4 2226.9 2228.0 2230.9 2191.6 2219.3 2224.4 2226.4 2248.6 2233.9 2255.0 2257.6 2258.7 2259.2 2152.3 2187.5 2187.6 2191.3 2193.2 7478.5 7538.2 7548.9 7565.5 7570.7 4444.5 4455.1 4471.4 4501.4 4510.6 2988.1 3012.7 3017.4 3024.0 3034.4 971.5 972.4 978.5 988.6 1010.2 10006.4 10054.9 10117.8 10126.5 10135.1 4013.3 4027.3 4052.9 4079.3 4091.7 8457.5 8529.7 8553.1 8554.7 8580.3 4472.3 4499.1 4500.5 4509.0 4514.1 4123.8 4135.9 4158.6 4174.7 4182.4 3342.6 3515.9 3518.2 3531.6 3572.0 1073.4 1083.0 1106.4 1109.6 1132.1 925.2 930.5 994.8 1001.0 1277.9 6685.4 6724.4 6726.4 6732.7 6735.9 1091.7 1093.7 1099.9 1106.1 1108.2 5251.6 5268.6 5294.7 5302.5 5312.2 8631.7 8786.8 8936.4 9066.6 9124.5 8905.9 8933.6 8938.3 8944.3 8952.7 6635.7 6979.5 7002.5 7035.6 7059.9 6720.5 6727.0 6760.9 6775.9 6778.1 7622.9 7844.8 7851.3 7988.8 8017.3 8008.5 8169.6 8175.0 8282.7 8321.3 6207.3 6248.2 6289.5 6298.4 6320.1 6300.5 6491.5 7090.2 7146.5 7156.5 6353.5 6372.2 6638.8 6683.0 6774.1 6614.2 6726.3 6735.2 6771.9 6778.5 5947.3 6253.2 6262.1 6264.0 6275.7 5743.3 5989.4 5996.8 5998.3 6005.1 5936.8 5994.4 5994.9 6066.8 6074.8 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5280.26 Median:5927.25 stddev:1587.03 (26.8%) stddev-sans-first:1547.35 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: Values: 329.0 336.2 340.3 342.9 353.0 5796.6 5877.9 5887.7 5892.5 5946.5 5648.5 5785.5 5802.9 5804.0 5805.0 4446.9 4541.3 4550.8 4586.4 4595.7 4541.9 4556.8 4562.5 4564.5 4570.2 4387.7 4437.2 4480.1 4532.1 4536.4 4547.4 4548.1 4560.8 4570.2 4574.5 4043.0 4045.4 4046.7 4047.9 4055.5 5630.6 5633.4 5636.5 5638.1 5639.5 5105.3 5250.6 5288.7 5313.2 5325.5 6233.9 6240.1 6240.3 6241.0 6242.8 4413.0 4419.3 4421.0 4423.0 4427.6 6348.1 6456.2 6504.6 6519.3 6539.6 4488.8 4507.3 4507.5 4508.8 4510.5 4551.2 4553.4 4554.0 4554.5 4556.0 5225.9 5230.2 5237.2 5239.5 5239.8 6155.1 6274.1 6289.7 6294.2 6304.4 1588.8 1613.8 1614.8 1615.1 1615.6 1043.4 1062.9 1070.2 1074.2 1077.1 6031.4 6048.5 6066.9 6067.3 6067.6 6516.4 6517.2 6524.2 6526.4 6530.4 5856.9 5908.0 6059.7 6077.0 6077.7 3473.4 3488.3 3512.8 3513.6 3514.2 6733.8 6736.6 6738.9 6741.5 6745.6 6556.5 6754.4 6754.8 6762.5 6767.3 6720.6 6728.7 6735.6 6736.7 6738.1 6544.1 6561.3 6569.2 6573.0 6575.5 6291.3 6459.4 6467.0 6467.7 6483.9 6609.2 6616.3 6641.0 6706.8 6710.5 4458.7 4498.3 4516.7 4520.1 4522.3 6378.8 6514.4 6550.2 6555.3 6558.4 6402.8 6403.3 6406.8 6407.4 6410.3 6388.2 6391.4 6391.6 6396.5 6396.6 6128.4 6255.1 6256.2 6278.3 6280.0 6409.5 6412.8 6413.5 6417.7 6421.4 6255.1 6263.4 6264.5 6265.7 6282.6 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: 17:11:03 INFO - 2015-12-18 17:11:03,567 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13377.09 Median:25906.10 stddev:15752.82 (60.8%) stddev-sans-first:15768.92 17:11:03 INFO - 2015-12-18 17:11:03,569 DEBUG : BROWSER_OUTPUT: Values: 847.6 852.3 857.4 860.7 888.0 13756.7 13997.9 13999.5 14001.2 14041.9 12215.9 12303.8 12312.1 12323.1 12347.9 690.6 691.2 833.6 833.9 848.9 835.3 836.4 844.3 844.7 845.5 865.9 872.2 877.4 878.2 879.4 706.7 707.7 848.3 859.6 861.2 641.6 642.0 642.2 642.4 642.5 13100.7 13168.5 13210.3 13217.8 13249.3 11899.2 12663.7 12711.3 13032.3 13054.9 9994.0 10290.6 10295.5 10609.5 10803.9 3552.2 3622.1 3654.2 3696.0 3703.6 49312.3 49375.0 49949.3 50020.0 50032.2 9731.8 9990.7 10071.1 10077.8 10457.3 17687.4 17703.2 17709.8 17722.4 17727.8 7305.6 7584.9 7653.7 7723.5 7739.4 4240.3 4336.3 4358.4 4384.6 4423.2 3064.8 3085.5 3087.4 3089.4 3093.1 554.4 556.7 561.8 564.7 573.7 569.5 590.6 595.8 617.1 618.9 7399.4 7604.8 7617.4 7815.5 7859.9 466.6 513.2 516.6 525.6 526.9 3357.3 3462.0 3471.3 3565.4 3684.5 52428.7 53319.5 53353.7 53380.0 53429.5 50647.0 50926.0 51248.0 51299.0 51814.7 45607.0 45842.5 46235.5 47015.0 47317.8 7319.3 7361.0 7368.8 7440.5 7650.3 33499.8 34076.5 34151.5 34446.3 34527.7 42793.6 44266.3 44767.8 44964.0 45253.0 9888.6 10038.6 10051.3 10211.5 10252.6 10576.5 10694.8 11125.4 11317.0 11378.2 8817.7 8829.8 8988.6 9088.2 9122.5 10526.9 10916.6 11034.7 11082.7 11300.3 9590.6 9730.5 9833.6 9897.0 9956.6 8986.7 9164.9 9228.4 9394.8 9523.1 8033.3 8120.2 8440.5 8612.1 8636.7 17:11:03 INFO - 2015-12-18 17:11:03,569 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:11:03 INFO - 2015-12-18 17:11:03,569 DEBUG : BROWSER_OUTPUT: 17:11:04 INFO - 2015-12-18 17:11:04,241 INFO : Browser exited with error code: 0 17:11:04 INFO - 2015-12-18 17:11:04,258 INFO : Completed test dromaeo_css (00:18:32) 17:11:04 INFO - 2015-12-18 17:11:04,258 INFO : Starting test kraken 17:11:04 INFO - 2015-12-18 17:11:04,258 DEBUG : operating with platform_type : linux_ 17:11:04 INFO - 2015-12-18 17:11:04,258 INFO : Initialising browser for kraken test... 17:11:04 INFO - 2015-12-18 17:11:04,264 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMrFm7K/profile http://localhost:50745/getInfo.html 17:11:08 INFO - 2015-12-18 17:11:08,442 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:11:08 INFO - 2015-12-18 17:11:08,442 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:11:08 INFO - 2015-12-18 17:11:08,442 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:11:08 INFO - 2015-12-18 17:11:08,442 DEBUG : BROWSER_OUTPUT: __metrics 17:11:08 INFO - 2015-12-18 17:11:08,547 DEBUG : BROWSER_OUTPUT: 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:11:08 INFO - 2015-12-18 17:11:08,611 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:09 INFO - 2015-12-18 17:11:09,383 INFO : Browser initialized. 17:11:09 INFO - 2015-12-18 17:11:09,383 INFO : Running cycle 1/1 for kraken test... 17:11:09 INFO - 2015-12-18 17:11:09,384 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMrFm7K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:11:21 INFO - 2015-12-18 17:11:21,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 149884928 17:11:21 INFO - 2015-12-18 17:11:21,137 DEBUG : BROWSER_OUTPUT: 17:11:23 INFO - 2015-12-18 17:11:23,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50745/tests/kraken/driver.html?testName=audio-beat-detection) 17:11:24 INFO - 2015-12-18 17:11:24,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 186408960 17:11:24 INFO - 2015-12-18 17:11:24,199 DEBUG : BROWSER_OUTPUT: 17:11:26 INFO - 2015-12-18 17:11:26,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50745/tests/kraken/driver.html?testName=audio-dft) 17:11:27 INFO - 2015-12-18 17:11:27,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 176394240 17:11:27 INFO - 2015-12-18 17:11:27,357 DEBUG : BROWSER_OUTPUT: 17:11:30 INFO - 2015-12-18 17:11:30,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50745/tests/kraken/driver.html?testName=audio-fft) 17:11:30 INFO - 2015-12-18 17:11:30,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 160940032 17:11:30 INFO - 2015-12-18 17:11:30,801 DEBUG : BROWSER_OUTPUT: 17:11:32 INFO - 2015-12-18 17:11:32,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50745/tests/kraken/driver.html?testName=audio-oscillator) 17:11:33 INFO - 2015-12-18 17:11:33,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 163426304 17:11:33 INFO - 2015-12-18 17:11:33,346 DEBUG : BROWSER_OUTPUT: 17:11:35 INFO - 2015-12-18 17:11:35,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:36 INFO - 2015-12-18 17:11:36,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 164589568 17:11:36 INFO - 2015-12-18 17:11:36,135 DEBUG : BROWSER_OUTPUT: 17:11:39 INFO - 2015-12-18 17:11:39,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50745/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:39 INFO - 2015-12-18 17:11:39,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 164093952 17:11:39 INFO - 2015-12-18 17:11:39,594 DEBUG : BROWSER_OUTPUT: 17:11:42 INFO - 2015-12-18 17:11:42,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50745/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:43 INFO - 2015-12-18 17:11:43,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 164548608 17:11:43 INFO - 2015-12-18 17:11:43,504 DEBUG : BROWSER_OUTPUT: 17:11:46 INFO - 2015-12-18 17:11:46,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50745/tests/kraken/driver.html?testName=json-parse-financial) 17:11:46 INFO - 2015-12-18 17:11:46,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 165875712 17:11:46 INFO - 2015-12-18 17:11:46,795 DEBUG : BROWSER_OUTPUT: 17:11:48 INFO - 2015-12-18 17:11:48,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:48 INFO - 2015-12-18 17:11:48,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 177704960 17:11:48 INFO - 2015-12-18 17:11:48,914 DEBUG : BROWSER_OUTPUT: 17:11:50 INFO - 2015-12-18 17:11:50,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:51 INFO - 2015-12-18 17:11:51,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 173727744 17:11:51 INFO - 2015-12-18 17:11:51,350 DEBUG : BROWSER_OUTPUT: 17:11:53 INFO - 2015-12-18 17:11:53,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:54 INFO - 2015-12-18 17:11:54,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 187240448 17:11:54 INFO - 2015-12-18 17:11:54,004 DEBUG : BROWSER_OUTPUT: 17:11:56 INFO - 2015-12-18 17:11:56,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:57 INFO - 2015-12-18 17:11:57,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 193048576 17:11:57 INFO - 2015-12-18 17:11:57,005 DEBUG : BROWSER_OUTPUT: 17:11:59 INFO - 2015-12-18 17:11:59,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:00 INFO - 2015-12-18 17:12:00,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 189861888 17:12:00 INFO - 2015-12-18 17:12:00,190 DEBUG : BROWSER_OUTPUT: 17:12:01 INFO - 2015-12-18 17:12:01,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50745/tests/kraken/driver.html?testName=ai-astar) 17:12:02 INFO - 2015-12-18 17:12:02,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 249004032 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;119;106;111;111;111;100;111;111;117 17:12:02 INFO - 2015-12-18 17:12:02,130 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;124;150;161;125;154;148;126;167;125 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;159;160;162;160;161;162 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;82;93;71;72;72;109;87;71 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;142;94;94;95;138;95;95;137 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;109;110;110;111;110;111 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;145;144;146;145;145;145;145 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;95;96;95;95 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;60;59;59;57;58;69;56;56 17:12:02 INFO - 2015-12-18 17:12:02,131 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;69;68;68;68;68;69;67;70 17:12:02 INFO - 2015-12-18 17:12:02,132 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;84;86;85;86;85;85;86;87 17:12:02 INFO - 2015-12-18 17:12:02,132 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;117;122;127;114;117;120;118;124;113 17:12:02 INFO - 2015-12-18 17:12:02,132 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;154;152;160;153;139;152;163;151;142 17:12:02 INFO - 2015-12-18 17:12:02,132 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;69;69;69;67;66;67;66;68;69 17:12:02 INFO - 2015-12-18 17:12:02,132 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:12:02 INFO - 2015-12-18 17:12:02,132 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:12:02 INFO - 2015-12-18 17:12:02,133 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 17:12:02 INFO - 2015-12-18 17:12:02,133 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:12:02 INFO - 2015-12-18 17:12:02,133 DEBUG : BROWSER_OUTPUT: __startTimestamp1450487522124__endTimestamp 17:12:02 INFO - 2015-12-18 17:12:02,133 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,133 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:12:02 INFO - 2015-12-18 17:12:02,133 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:12:02 INFO - 2015-12-18 17:12:02,134 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,134 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:5.25 (4.7%) stddev-sans-first:5.54 17:12:02 INFO - 2015-12-18 17:12:02,135 DEBUG : BROWSER_OUTPUT: Values: 109.0 119.0 106.0 111.0 111.0 111.0 100.0 111.0 111.0 117.0 17:12:02 INFO - 2015-12-18 17:12:02,135 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,135 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:151.50 stddev:16.64 (11.0%) stddev-sans-first:17.28 17:12:02 INFO - 2015-12-18 17:12:02,135 DEBUG : BROWSER_OUTPUT: Values: 153.0 124.0 150.0 161.0 125.0 154.0 148.0 126.0 167.0 125.0 17:12:02 INFO - 2015-12-18 17:12:02,136 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,136 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 17:12:02 INFO - 2015-12-18 17:12:02,136 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 159.0 160.0 162.0 160.0 161.0 162.0 17:12:02 INFO - 2015-12-18 17:12:02,136 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,136 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:12.70 (17.4%) stddev-sans-first:13.11 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 82.0 93.0 71.0 72.0 72.0 109.0 87.0 71.0 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.00 stddev:21.57 (22.9%) stddev-sans-first:22.29 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 142.0 94.0 94.0 95.0 138.0 95.0 95.0 137.0 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 109.0 110.0 110.0 111.0 110.0 111.0 17:12:02 INFO - 2015-12-18 17:12:02,137 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,138 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:3.77 (6.4%) stddev-sans-first:4.00 17:12:02 INFO - 2015-12-18 17:12:02,139 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 60.0 59.0 59.0 57.0 58.0 69.0 56.0 56.0 17:12:02 INFO - 2015-12-18 17:12:02,139 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,139 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 17:12:02 INFO - 2015-12-18 17:12:02,139 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 67.0 70.0 17:12:02 INFO - 2015-12-18 17:12:02,139 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,139 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 84.0 86.0 85.0 86.0 85.0 85.0 86.0 87.0 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.00 stddev:4.34 (3.6%) stddev-sans-first:4.59 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: Values: 120.0 117.0 122.0 127.0 114.0 117.0 120.0 118.0 124.0 113.0 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:152.50 stddev:7.15 (4.7%) stddev-sans-first:7.58 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: Values: 152.0 154.0 152.0 160.0 153.0 139.0 152.0 163.0 151.0 142.0 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 69.0 67.0 66.0 67.0 66.0 68.0 69.0 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:12:02 INFO - 2015-12-18 17:12:02,140 DEBUG : BROWSER_OUTPUT: 17:12:02 INFO - 2015-12-18 17:12:02,974 INFO : Browser exited with error code: 0 17:12:03 INFO - 2015-12-18 17:12:03,027 INFO : Completed test kraken (00:00:58) 17:12:03 INFO - 2015-12-18 17:12:03,028 INFO : Starting test v8_7 17:12:03 INFO - 2015-12-18 17:12:03,028 DEBUG : operating with platform_type : linux_ 17:12:03 INFO - 2015-12-18 17:12:03,028 INFO : Initialising browser for v8_7 test... 17:12:03 INFO - 2015-12-18 17:12:03,034 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJg5LFZ/profile http://localhost:50745/getInfo.html 17:12:06 INFO - 2015-12-18 17:12:06,853 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:12:06 INFO - 2015-12-18 17:12:06,853 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:12:06 INFO - 2015-12-18 17:12:06,853 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:12:06 INFO - 2015-12-18 17:12:06,853 DEBUG : BROWSER_OUTPUT: __metrics 17:12:06 INFO - 2015-12-18 17:12:06,934 DEBUG : BROWSER_OUTPUT: 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:12:06 INFO - 2015-12-18 17:12:06,995 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:08 INFO - 2015-12-18 17:12:08,153 INFO : Browser initialized. 17:12:08 INFO - 2015-12-18 17:12:08,153 INFO : Running cycle 1/1 for v8_7 test... 17:12:08 INFO - 2015-12-18 17:12:08,154 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJg5LFZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:12:19 INFO - 2015-12-18 17:12:19,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 149708800 17:12:19 INFO - 2015-12-18 17:12:19,985 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50745/tests/v8_7/run.html (next: http://localhost:50745/tests/v8_7/run.html) 17:12:41 INFO - 2015-12-18 17:12:41,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 570720256 17:12:41 INFO - 2015-12-18 17:12:41,639 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.28845791752966 17:12:41 INFO - 2015-12-18 17:12:41,641 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1932.4324324324325 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |5;Earley;769.2307692307693 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |8;Splay;606.7961165048544 17:12:41 INFO - 2015-12-18 17:12:41,642 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:12:41 INFO - 2015-12-18 17:12:41,643 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:12:41 INFO - 2015-12-18 17:12:41,643 DEBUG : BROWSER_OUTPUT: __startTimestamp1450487561639__endTimestamp 17:12:41 INFO - 2015-12-18 17:12:41,643 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,643 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:12:41 INFO - 2015-12-18 17:12:41,643 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:12:41 INFO - 2015-12-18 17:12:41,644 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,644 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,644 DEBUG : BROWSER_OUTPUT: Values: 166.3 17:12:41 INFO - 2015-12-18 17:12:41,644 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,644 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.29 Median:188.29 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,644 DEBUG : BROWSER_OUTPUT: Values: 188.3 17:12:41 INFO - 2015-12-18 17:12:41,645 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,645 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,646 DEBUG : BROWSER_OUTPUT: Values: 280.0 17:12:41 INFO - 2015-12-18 17:12:41,646 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,646 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,646 DEBUG : BROWSER_OUTPUT: Values: 5196.9 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1932.43 Median:1932.43 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: Values: 1932.4 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:769.23 Median:769.23 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: Values: 769.2 17:12:41 INFO - 2015-12-18 17:12:41,647 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: Values: 12207.3 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: Values: 25200.0 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.80 Median:606.80 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,648 DEBUG : BROWSER_OUTPUT: Values: 606.8 17:12:41 INFO - 2015-12-18 17:12:41,649 DEBUG : BROWSER_OUTPUT: 17:12:41 INFO - 2015-12-18 17:12:41,649 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:12:41 INFO - 2015-12-18 17:12:41,649 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:12:41 INFO - 2015-12-18 17:12:41,649 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:12:41 INFO - 2015-12-18 17:12:41,649 DEBUG : BROWSER_OUTPUT: 17:12:42 INFO - 2015-12-18 17:12:42,501 INFO : Browser exited with error code: 0 17:12:42 INFO - 2015-12-18 17:12:42,514 INFO : Completed test v8_7 (00:00:39) 17:12:42 INFO - 2015-12-18 17:12:42,630 INFO : Completed test suite (00:20:11) 17:12:42 INFO - 2015-12-18 17:12:42,631 DEBUG : Working with test: dromaeo_css 17:12:42 INFO - 2015-12-18 17:12:42,631 DEBUG : Generating results file: dromaeo_css 17:12:42 INFO - 2015-12-18 17:12:42,632 DEBUG : Working with test: kraken 17:12:42 INFO - 2015-12-18 17:12:42,632 DEBUG : Generating results file: kraken 17:12:42 INFO - 2015-12-18 17:12:42,632 INFO : javascript benchmark 17:12:42 INFO - 2015-12-18 17:12:42,632 DEBUG : Working with test: v8_7 17:12:42 INFO - 2015-12-18 17:12:42,633 DEBUG : Generating results file: v8_7 17:12:42 INFO - 2015-12-18 17:12:42,633 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:42 INFO - 2015-12-18 17:12:42,686 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:12:42 INFO - 2015-12-18 17:12:42,686 DEBUG : process_Request line: dromaeo_css 6896.32 graph.html#tests=[[72,201,35]] 17:12:42 INFO - 2015-12-18 17:12:42,686 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:42 INFO - 2015-12-18 17:12:42,716 DEBUG : process_Request line: kraken 1504.70 graph.html#tests=[[232,201,35]] 17:12:42 INFO - 2015-12-18 17:12:42,716 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:12:42 INFO - 2015-12-18 17:12:42,758 DEBUG : process_Request line: v8_7 19989.16 graph.html#tests=[[230,201,35]] 17:12:42 INFO - 2015-12-18 17:12:42,759 INFO : javascript benchmark 17:12:42 INFO - 2015-12-18 17:12:42,763 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3075.47716888129, 3143.685631436855, 3201.5677883485723, 3203.3593281343724, 3228.3866065447555, 5165.81919632813, 5295.549878260343, 5349.866253343668, 5375.892482150354, 5401.972990135044, 5193.298904647881, 5262.184361423976, 5312.335958005249, 5312.867178320544, 5321.654092483986, 4812.807487700487, 4859.392575928009, 4873.610111191114, 4934.6299027572895, 4992.026554821811, 4731.5268473152755, 4975.577075948549, 4993.550580447759, 4999.850004499871, 5052.0906236877345, 4852.369192005034, 4854.441739200002, 4930.950690493085, 4941.579965702919, 4949.628777841676, 4836.854894353175, 4841.080194762983, 4850.563449289581, 4855.830045948375, 4877.902441951177, 4758.1673207188605, 4830.0, 4833.057553777015, 4862.1491239033385, 4886.169351210267, 5050.39395272566, 5130.025295193938, 5135.306733590992, 5159.2003239497935, 5180.6891586504935, 5694.800681976152, 5704.971475142639, 5713.485786279255, 5718.256626638552, 5719.370869204384, 5510.6969116698565, 5645.407232240596, 5726.284214473191, 5728.369879313273, 5728.570357223183, 5323.627346085776, 5389.380221274525, 5408.810691625853, 5409.83770486886, 5459.863503412406, 5766.452187042224, 5769.307683078057, 5773.134029895466, 5776.913346299809, 5779.2775903012125, 5498.45015498447, 5591.888162236733, 5592.5805564582815, 5598.608097433222, 5615.410381909923, 5590.8043218487155, 5649.915251271234, 5650.7174641267775, 5652.349979752299, 5707.942920570741, 5623.0721930880945, 5672.773089076473, 5673.631213971079, 5675.120356344691, 5677.687727175045, 5555.0, 5563.944360556424, 5667.688277144796, 5690.174924635905, 5703.515201207943, 4415.028693687384, 4431.379606855043, 4437.622802061796, 4443.6889417741095, 4481.619062379669, 3933.174033453007, 3942.0, 3970.4838371011583, 3991.022199561126, 4007.278689835799, 5234.633575649668, 5304.681719096867, 5338.652987555796, 5382.111951527954, 5421.891562168735, 5638.182463542763, 5782.0, 5787.074068149076, 5810.622309549865, 5813.244278243886, 5417.5395091416885, 5432.076546987022, 5432.75552600134, 5437.673739575638, 5440.591955603346, 4843.104025755176, 4890.902181956341, 4903.264510323409, 4922.950770492249, 5028.723420211923, 5892.469677729025, 5921.644701317935, 5925.081612350093, 5927.288725352985, 5928.199693041471, 5766.5675074368755, 5783.19035335045, 5793.739281732248, 5799.391063938226, 5804.100364443518, 5764.942350576608, 5786.161006653927, 5845.678487683218, 5856.795012174553, 5926.318473375444, 5658.603897727119, 5660.264165658438, 5663.66018038919, 5666.263385759825, 5676.091825307931, 5704.971475142598, 5744.080947048452, 5750.0, 5752.9712351437975, 5766.308043034863, 5363.651362661414, 5395.81114660985, 5438.537724293479, 5519.254900588369, 5532.419095995024, 5589.161625756169, 5590.161475778503, 5592.916106258328, 5595.804146854841, 5596.888062238814, 5494.2033405155225, 5509.393966663744, 5511.118221084607, 5514.0, 5563.388027317073, 5459.890802184013, 5513.917291240555, 5572.582056345709, 5602.607817452902, 5687.544996400361, 5527.585431092603, 5530.115181570929, 5540.279763630702, 5550.084236100998, 5592.468715472024], "unit": "score", "name": "dojo.html", "value": 5263.382343813639}, {"lowerIsBetter": false, "replicates": [566.7477972302325, 578.4620303118102, 581.1950448628648, 582.6591444005255, 590.1884908251154, 29599.26001849955, 38745.61254387455, 39279.60720392795, 39306.0, 39377.40933885991, 42805.57194428055, 42873.35689964653, 43326.783366083124, 43435.131297374035, 43469.30510906577, 7517.586532740697, 7625.8474830503355, 8632.741017769462, 8804.075572064938, 8811.030786613468, 10487.108595769369, 10734.248602597821, 10756.300840445347, 10760.192985526117, 10760.623378181765, 10435.530401131968, 10545.0, 10551.683449496528, 10551.73620659482, 10559.208059395538, 7757.301842834116, 7949.72175973844, 10384.584616615364, 10547.314424562379, 10851.891481085246, 10177.287589868713, 10361.326513776581, 10372.688819335432, 10377.740556486073, 10379.532921018572, 40490.0, 40838.79580602078, 40908.0, 40956.38565421521, 40997.0, 3092.443360195164, 3253.024092772159, 3402.3025279817825, 3472.808995505246, 3910.4720862683457, 29590.0, 29614.25964350887, 30058.54912176319, 30262.54606180887, 30353.544696829566, 3592.7125829933543, 3660.7254455915913, 3661.2311414602964, 3685.262947410502, 3764.726856735347, 243197.0, 243319.78340108364, 244359.0, 244834.0, 245989.0, 54191.72904135454, 55195.17207241894, 55223.723881380334, 59368.70315648394, 59788.701056494436, 48340.27489587659, 70449.0, 71710.64144679243, 71865.0, 71875.0, 16050.598735031484, 16199.352025919066, 16311.429099981444, 16320.347186112422, 16323.836761632232, 12398.938005309916, 12476.563320283927, 12476.81284780729, 12480.063995200397, 12481.56314528987, 20396.388108356772, 20441.26249268799, 20747.1701131953, 20776.896115519325, 20809.479763006046, 7897.131315555284, 8055.5972201389695, 8147.959260203779, 8174.182581741898, 8191.549464779494, 897.3897749530382, 936.765808547863, 999.5102399824034, 1026.1329176845554, 1038.0138868075207, 28861.268323900633, 31342.37315253682, 32357.19107022296, 32423.35153296921, 32584.76748990639, 934.1965909317981, 962.9951850240705, 1007.2093406675871, 1026.3533973596586, 1107.5901916291025, 14625.926870365793, 14781.05353896153, 14820.3330850112, 14844.703105938037, 14893.627659308604, 699340.0, 709672.0, 715103.0, 715944.0, 717220.0, 54667.72666136644, 55270.0, 55298.17052744212, 55356.16965745517, 55367.169492457644, 1344.509254122258, 1354.3160703844692, 1365.4196966289287, 1367.8358596968428, 1380.675541247806, 27978.300542485787, 29003.564946525395, 29244.853775730986, 29466.852665736533, 29471.55792663069, 46674.0, 47243.763781180875, 47258.763706182624, 47281.52718472771, 47406.76296618495, 287619.0, 291763.0, 294914.0, 295182.0, 394943.0, 31849.8407507961, 31916.84041579777, 31967.520487192247, 32137.839310803298, 32148.678513215506, 42340.0, 42768.57231427646, 43127.13745725131, 43869.78065109654, 44128.77935610301, 36096.27807443889, 36361.818190908874, 36508.63491365052, 36535.0, 37480.250394992494, 36061.45907811332, 36694.08264793402, 36820.07949801169, 36987.81506092452, 37121.81439092787, 35322.0, 36061.45907811332, 36331.63668363282, 36377.636223637426, 36582.0, 29903.401931960805, 30016.099517014525, 33086.0, 33365.0, 33392.332153356314, 24675.0, 24789.25632231036, 24846.875765621055, 24869.378265543506, 25148.874255628605], "unit": "score", "name": "ext.html", "value": 19408.990028983884}, {"lowerIsBetter": false, "replicates": [355.6177109607172, 360.46650956584256, 360.5295089907673, 361.4469861112497, 362.6373626373626, 13658.38537265823, 13770.518031868887, 16462.670746585078, 16696.83303166968, 17251.654966900653, 13377.331133443313, 13933.860661393383, 15933.20333983302, 16179.35282588698, 16286.0, 5243.2659427680155, 5408.567314614841, 5417.864553386177, 5418.376886658026, 5425.891482170354, 3655.1775850433573, 3726.7763934164036, 5178.844634660966, 5307.708076055835, 5351.598630102739, 5370.113931201347, 5513.393526712059, 5522.22688823565, 5533.916991245134, 5534.833954981357, 5369.677819330833, 5497.202905578689, 5515.338159420875, 5939.792107276267, 5951.6726580038085, 5264.763085661116, 5328.893422131575, 5335.466453354672, 5338.679679219221, 5341.4658534146665, 12756.362181890869, 12817.67955801103, 13302.068855180141, 13329.0, 13383.19700817954, 1861.748663930379, 1900.7719073711105, 1957.3442896629647, 1962.0876292523901, 2034.8270397016124, 9536.332456728032, 9607.4715890626, 9809.264305177068, 9852.261080418997, 9890.703278901572, 1790.239148361954, 1820.335577514211, 1832.4502649205185, 1835.8347748702681, 1885.5568941298784, 58982.0, 59011.0, 59824.40175598232, 60256.0, 62025.37974620286, 9734.561944712505, 10154.695359139238, 10185.490725463846, 10240.48797560119, 10247.180225581935, 13303.66740831487, 13400.0, 13444.798328025088, 13454.394552245172, 13473.461061557427, 7767.961160194162, 7794.298513133732, 7811.218878112143, 7848.882266766003, 7856.214378562098, 7596.126445458733, 7612.657430415645, 7617.047869016373, 7657.693692252359, 7668.427972265672, 4369.0, 4401.735895846259, 4411.602955733935, 4436.711613745097, 4460.04109116535, 1676.4551520755804, 1736.2447335409138, 1783.8929664220188, 1819.8999055051834, 1850.6113716119496, 806.395203597302, 883.4169448164181, 952.5046975572802, 954.9924829305149, 1045.7960697663882, 15142.0, 15625.453109141126, 15927.203639817963, 15941.362345506283, 16018.279177437043, 803.6704950970075, 851.948883067018, 879.6745204274459, 889.4352086425166, 896.5696465696502, 8652.740417787476, 8877.156670116328, 9070.54647267634, 9352.719418417459, 9717.854232186522, 520554.0, 550517.0, 555053.0, 581640.0, 587337.9496537776, 81443.59278203572, 83438.0, 83561.58219208865, 83880.58059709784, 83973.58013209894, 1139.4132022008507, 1158.5887010111458, 1169.2341516306833, 1178.8938995490446, 1183.1540448579308, 15134.470293539673, 15201.77197342063, 15327.846721533087, 15361.692766144391, 15619.21903904823, 36081.45877811783, 36165.819170903975, 36624.63375366212, 36670.266594667424, 38432.423513647875, 47810.76094619644, 48585.0, 52824.735876320374, 54079.459205407446, 55548.44451555433, 8584.613692383733, 9029.593668284811, 9049.411788233743, 9085.545722713705, 9157.175854173156, 10741.785164296514, 10815.945920270347, 11971.760564788481, 17119.400820971205, 17617.0, 13744.312784360942, 13879.306034698428, 13886.166829990232, 14018.439262429389, 14054.297285135906, 13834.515791947233, 14077.436902523785, 14447.205403702897, 14557.781633275721, 14645.780313295096, 10460.372377657364, 10747.193960453154, 13735.725285494435, 14096.647583810076, 14413.423463061361, 8948.865767013369, 9017.233535149586, 9042.231410330196, 9150.63397464094, 9200.815983680155, 13395.665108372368, 13553.661158471117, 13620.04659673853, 13822.308884555932, 14166.150030998173], "unit": "score", "name": "jquery.html", "value": 8595.585749980599}, {"lowerIsBetter": false, "replicates": [1417.9078359906607, 1475.0633347824132, 1515.0, 1578.7237233484138, 1742.5904912345597, 6547.901781473276, 7154.0, 7508.587027713474, 7539.9246007539905, 7543.811404714885, 7348.485606007582, 7472.663730132143, 7493.250674932504, 7511.962440187805, 7515.098188217408, 1941.3884626342656, 1968.8621796474254, 1971.3888694504749, 2203.3610253026645, 2250.797428231459, 2019.9495012624654, 2173.3588591365583, 2226.944326391845, 2228.0419419649543, 2230.9107635694554, 2191.605511008018, 2219.323106452531, 2224.443889027743, 2226.3543572363997, 2248.561530501545, 2233.944151396212, 2254.954900901973, 2257.582347265753, 2258.706368172127, 2259.2092767531317, 2152.332776839185, 2187.5187458759046, 2187.56248750249, 2191.2768786300644, 2193.1885202475028, 7478.476506644537, 7538.246175382473, 7548.886766698504, 7565.546067235929, 7570.659320330598, 4444.466664000308, 4455.131249406367, 4471.351654010183, 4501.369808226851, 4510.616597589209, 2988.148377712363, 3012.698730126992, 3017.3814368054714, 3024.017194411803, 3034.3931213757114, 971.4910102314522, 972.4457059476101, 978.505854543451, 988.569972062148, 1010.2170817616333, 10006.399616022989, 10054.899451005469, 10117.797644047152, 10126.493675316206, 10135.138513226384, 4013.3177359848896, 4027.2549578328103, 4052.8986775330263, 4079.286699586181, 4091.6931230157857, 8457.53483558398, 8529.701460448854, 8553.101924297984, 8554.700585479603, 8580.313574913991, 4472.284434490466, 4499.055198408306, 4500.459944806644, 4508.954910450919, 4514.0971805639, 4123.814428350732, 4135.937960930589, 4158.563350848118, 4174.707770456039, 4182.372644103409, 3342.632310445849, 3515.876944306937, 3518.20840310928, 3531.5585551806025, 3572.035550401377, 1073.355986408149, 1082.9566817327377, 1106.397013627575, 1109.589451902801, 1132.128261238858, 925.167349385545, 930.5440334236175, 994.751312171957, 1001.0090010889168, 1277.8722127787146, 6685.364890335411, 6724.3948044675235, 6726.428253598499, 6732.730690772314, 6735.932640673628, 1091.7052395853075, 1093.6609651008214, 1099.8735145458375, 1106.0543235533664, 1108.2020944919645, 5251.6061295403, 5268.552173065333, 5294.682319060792, 5302.496262855023, 5312.150055991023, 8631.6978905738, 8786.780330491789, 8936.41913275635, 9066.592003359732, 9124.543772811332, 8905.910940890508, 8933.553322333857, 8938.284937205008, 8944.329175311877, 8952.731418057469, 6635.668216589248, 6979.511434199558, 7002.544834585736, 7035.613041282779, 7059.929400705927, 6720.495962802907, 6727.0, 6760.898586521108, 6775.898361524482, 6778.084958530535, 7622.885656715264, 7844.84310313802, 7851.332636725942, 7988.84022319562, 8017.318527925192, 8008.479448835807, 8169.55067471271, 8174.959125204336, 8282.668693252203, 8321.334293256647, 6207.255129384323, 6248.218972628421, 6289.49684025286, 6298.433141017331, 6320.146780184617, 6300.495960323072, 6491.545591808528, 7090.220075791555, 7146.499745017799, 7156.534825236343, 6353.523485738496, 6372.171617689671, 6638.83402914931, 6683.0, 6774.051632771318, 6614.206295244409, 6726.3273672634305, 6735.225449073419, 6771.898421523582, 6778.525503214728, 5947.286325640951, 6253.187085679015, 6262.123302737711, 6263.96868015657, 6275.6548389839, 5743.282089738783, 5989.401059893976, 5996.760129594942, 5998.280206375263, 6005.129256257731, 5936.7922122725495, 5994.400559943971, 5994.88010239784, 6066.757329706938, 6074.817755467343], "unit": "score", "name": "mootools.html", "value": 4250.3871220200845}, {"lowerIsBetter": false, "replicates": [328.99342013159753, 336.2468071519796, 340.25993464215327, 342.9194139377246, 353.04325278495276, 5796.594238403313, 5877.853053673661, 5887.705614719268, 5892.499137573301, 5946.494547963417, 5648.491635752782, 5785.479306862381, 5802.941970580293, 5803.970980145104, 5805.0, 4446.933296000562, 4541.318802179667, 4550.795214215352, 4586.3808385867815, 4595.747233902134, 4541.864533866534, 4556.84051058213, 4562.543745625428, 4564.5435456454425, 4570.223062079438, 4387.736735795863, 4437.156940181371, 4480.14877173336, 4532.070925460289, 4536.432945881765, 4547.408836851188, 4548.135854187693, 4560.794764235618, 4570.154521413516, 4574.4510658721, 4043.0, 4045.37296719009, 4046.6560342370935, 4047.8868311214355, 4055.513338399411, 5630.577706672016, 5633.352164501053, 5636.464535869086, 5638.069718496443, 5639.520640745542, 5105.310783044316, 5250.553702935255, 5288.65623734456, 5313.229581710669, 5325.520703136736, 6233.937660623381, 6240.063990401431, 6240.251169859646, 6241.032639940817, 6242.781502647431, 4413.029133590605, 4419.292913133915, 4421.027373977719, 4422.977885110586, 4427.5572442755465, 6348.079528468393, 6456.225252969627, 6504.642244676541, 6519.282878883319, 6539.64031978241, 4488.820447182142, 4507.256302710081, 4507.5267096955, 4508.752018639007, 4510.481294651091, 4551.203539380595, 4553.408056952575, 4554.0, 4554.4990051094355, 4555.954440455553, 5225.947740522546, 5230.241614965808, 5237.240600112962, 5239.476052394806, 5239.816606418757, 6155.10750941111, 6274.121622972787, 6289.7484100636375, 6294.150289710922, 6304.3695630437505, 1588.801399825022, 1613.782139411188, 1614.8465895739887, 1615.0874755762957, 1615.6284054667492, 1043.3583346242158, 1062.8830828608848, 1070.1973519860105, 1074.1889873145724, 1077.1436707817304, 6031.4270144336215, 6048.516118710492, 6066.939330606638, 6067.332593414721, 6067.634782174064, 6516.413522782877, 6517.185351831021, 6524.217093948661, 6526.412622863965, 6530.444912182423, 5856.853578660568, 5908.0, 6059.7273122709585, 6076.969615151896, 6077.696115194222, 3473.4095203815414, 3488.337215928965, 3512.841922113511, 3513.578370595545, 3514.24443744591, 6733.831654208684, 6736.5958042517605, 6738.932610673831, 6741.528093033538, 6745.5952642841585, 6556.508261880378, 6754.425873800684, 6754.797356079325, 6762.526623136431, 6767.323267673193, 6720.630365329954, 6728.730850766013, 6735.6295403753265, 6736.730530778714, 6738.090357801634, 6544.116544266463, 6561.278259391559, 6569.178852643419, 6573.0, 6575.539712220098, 6291.339409361951, 6459.418652321314, 6467.0, 6467.741290348334, 6483.902741458787, 6609.173853268341, 6616.305287944697, 6641.0, 6706.83232919181, 6710.496712746466, 4458.665600080072, 4498.3252512123445, 4516.661250406299, 4520.141173177086, 4522.29904364824, 6378.77674281398, 6514.446272066927, 6550.246721626883, 6555.2789193187755, 6558.409743123142, 6402.839929001626, 6403.327650596807, 6406.775762848278, 6407.391297826699, 6410.294867564658, 6388.201474815648, 6391.360863913757, 6391.552591318563, 6396.520260980352, 6396.584222025554, 6128.387161283836, 6255.061740738925, 6256.249250090018, 6278.277998030285, 6279.96860015697, 6409.487241020801, 6412.839679008062, 6413.518986075969, 6417.679116044085, 6421.357864213542, 6255.124282600348, 6263.404976527223, 6264.498840092872, 6265.686715664107, 6282.623042617458], "unit": "score", "name": "prototype.html", "value": 4765.809184123657}, {"lowerIsBetter": false, "replicates": [847.5677404523695, 852.2925971443702, 857.3612658569365, 860.7073594977707, 888.0453512474091, 13756.724865502696, 13997.930010349959, 13999.510017149389, 14001.159930404183, 14041.859581404184, 12215.877841221585, 12303.815442768344, 12312.076594255423, 12323.075769317315, 12347.876521234784, 690.647769637486, 691.2327316678483, 833.6332013913889, 833.9416240863158, 848.859938110211, 835.3150416658343, 836.3894357119307, 844.3371953016883, 844.6874656377149, 845.5222799118509, 865.904750477447, 872.2324354568003, 877.4428238068808, 878.2227728460294, 879.4020066354876, 706.650208146968, 707.6992278281709, 848.2916764501648, 859.5831021954347, 861.2248975921658, 641.5861769158867, 641.9518536109811, 642.1748053750907, 642.354433794034, 642.4603333200134, 13100.672483187902, 13168.473261069546, 13210.273434961073, 13217.801732974012, 13249.271290079041, 11899.226550274205, 12663.746725065539, 12711.300878451682, 13032.348382580833, 13054.934725326408, 9994.0, 10290.588376464932, 10295.536700848479, 10609.522571484302, 10803.891961080446, 3552.236269202108, 3622.0763705255254, 3654.232611151635, 3696.002079438563, 3703.6481534254203, 49312.260316095286, 49375.0, 49949.25076123861, 50020.0, 50032.24951625729, 9731.805363892825, 9990.650327238513, 10071.14395276395, 10077.848832267522, 10457.267991240693, 17687.380941667237, 17703.20335584876, 17709.822901771076, 17722.379716709853, 17727.822721772875, 7305.634718264066, 7584.886226706604, 7653.655585498666, 7723.536587804638, 7739.380849532024, 4240.300350442204, 4336.284513055373, 4358.411614432074, 4384.605385515319, 4423.159599676052, 3064.846757662108, 3085.506318988951, 3087.382523495265, 3089.382123575294, 3093.1030001299373, 554.365251786702, 556.6576555418388, 561.7809054468761, 564.6724899558246, 573.7332140554662, 569.5272923473507, 590.5806877117209, 595.7825393731257, 617.1303439008557, 618.9412005859436, 7399.4450416219, 7604.771856844303, 7617.428692848059, 7815.4529182957785, 7859.921400786034, 466.5800779298658, 513.2352794336412, 516.5841497594472, 525.6294312509672, 526.9367675878842, 3357.261402491448, 3461.9826900865837, 3471.3057388522398, 3565.3938830398893, 3684.502592150079, 52428.68928276824, 53319.46680533145, 53353.73323133437, 53380.0, 53429.46570534245, 50647.0, 50926.0, 51248.0, 51298.97402051938, 51814.74092629588, 45607.0, 45842.541574584495, 46235.53764462379, 47015.0, 47317.76341118272, 7319.304666056716, 7360.963195184204, 7368.778936631909, 7440.479166458296, 7650.273224043707, 33499.83250083734, 34076.488852667724, 34151.46318415627, 34446.311073777884, 34527.65472345345, 42793.57206427896, 44266.3360049606, 44767.776161118985, 44964.0, 45253.0, 9888.555015024485, 10038.598456061967, 10051.296409251283, 10211.540480678239, 10252.589896404359, 10576.4711764413, 10694.786104277715, 11125.44372781374, 11317.0, 11378.203525753117, 8817.651211581939, 8829.779255518664, 8988.640454381752, 9088.227500662519, 9122.5438728062, 10526.894731052898, 10916.56333746673, 11034.668959931216, 11082.722931926766, 11300.321980681185, 9590.616375344907, 9730.464824434725, 9833.60665573369, 9897.0, 9956.55195516189, 8986.68546600866, 9164.908350916672, 9228.40015398997, 9394.812103758024, 9523.095305945924, 8033.297609849619, 8120.187981201832, 8440.535770532433, 8612.138786121337, 8636.740897773077], "unit": "score", "name": "yui.html", "value": 6047.185996577966}], "name": "dromaeo_css", "value": 6896.320109321969}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 119.0, 106.0, 111.0, 111.0, 111.0, 100.0, 111.0, 111.0, 117.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 150.0, 161.0, 125.0, 154.0, 148.0, 126.0, 167.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 159.0, 160.0, 162.0, 160.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 82.0, 93.0, 71.0, 72.0, 72.0, 109.0, 87.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 94.0, 94.0, 95.0, 138.0, 95.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 60.0, 59.0, 59.0, 57.0, 58.0, 69.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 86.0, 85.0, 86.0, 85.0, 85.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 122.0, 127.0, 114.0, 117.0, 120.0, 118.0, 124.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [152.0, 154.0, 152.0, 160.0, 153.0, 139.0, 152.0, 163.0, 151.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 69.0, 67.0, 66.0, 67.0, 66.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1504.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [188.28845791752966], "unit": "score", "name": "DeltaBlue", "value": 351.152698}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1932.4324324324325], "unit": "score", "name": "RayTrace", "value": 382.9313706293705}, {"lowerIsBetter": false, "replicates": [769.2307692307693], "unit": "score", "name": "Earley", "value": 866.4018999999997}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [606.7961165048544], "unit": "score", "name": "Splay", "value": 134.29716800000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19989.155068956487}]} 17:12:42 INFO - RETURN: dromaeo_css: 6896.32 17:12:42 INFO - RETURN: kraken: 1504.70 17:12:42 INFO - RETURN: v8_7: 19989.16 17:12:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19989.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6896.32"}}} 17:12:42 INFO - Return code: 0 17:12:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:12:42 INFO - # TBPL SUCCESS # 17:12:42 INFO - Running post-action listener: _resource_record_post_action 17:12:42 INFO - Running post-run listener: _resource_record_post_run 17:12:43 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 32768; Write bytes: 557064192; Read time: 148; Write time: 709496 17:12:43 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 249323520; Read time: 0; Write time: 473476 17:12:43 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 32768; Write bytes: 307740672; Read time: 148; Write time: 236020 17:12:43 INFO - Running post-run listener: _upload_blobber_files 17:12:43 INFO - Blob upload gear active. 17:12:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:12:43 INFO - Copying logs to upload dir... 17:12:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.498122 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-18 17:12:43.930029) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 17:12:43.933617) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010057 build_url: 'https://queue.taskcluster.net/v1/task/7Ac9SuHJTUqunj2eZjtB7Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 17:12:43.986160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:12:43.986626) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450484707.69232-1845405581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:12:44.037195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 17:12:44.037545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 17:12:44.037856) ========= ========= Total master_lag: 0.22 =========