builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1450909828.52 results: success (0) buildid: 20151223135912 builduid: 4b774c5b07e644e9b0f34a3769a11dcc revision: 3a4b329934ab687c9996d0b11e368ed013b7401c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.522259) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.522737) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.523059) ========= bash -c pwd in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006262 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.546065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.546417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.559845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.560215) ========= rm -rf properties in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.609816) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.610162) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.610554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.610824) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 14:30:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 74.9M=0s 2015-12-23 14:30:28 (74.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.716108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.716440) ========= rm -rf scripts in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022018 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.766280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:28.766680) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3a4b329934ab687c9996d0b11e368ed013b7401c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3a4b329934ab687c9996d0b11e368ed013b7401c --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 14:30:28,826 truncating revision to first 12 chars 2015-12-23 14:30:28,826 Setting DEBUG logging. 2015-12-23 14:30:28,826 attempt 1/10 2015-12-23 14:30:28,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/3a4b329934ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 14:30:29,110 unpacking tar archive at: b2g-inbound-3a4b329934ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578717 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:29.358594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:29.358937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:29.367767) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:29.368153) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 14:30:29.368616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-23 14:30:29.368913) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (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-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:30:29 INFO - MultiFileLogger online at 20151223 14:30:29 in /builds/slave/test 14:30:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 14:30:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:29 INFO - {'append_to_log': False, 14:30:29 INFO - 'base_work_dir': '/builds/slave/test', 14:30:29 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 14:30:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:29 INFO - 'branch': 'B2G-Inbound-Non-PGO', 14:30:29 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:29 INFO - 'config_files': ('talos/linux_config.py',), 14:30:29 INFO - 'default_actions': ('clobber', 14:30:29 INFO - 'read-buildbot-config', 14:30:29 INFO - 'download-and-extract', 14:30:29 INFO - 'populate-webroot', 14:30:29 INFO - 'create-virtualenv', 14:30:29 INFO - 'install', 14:30:29 INFO - 'run-tests'), 14:30:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:29 INFO - 'download_minidump_stackwalk': True, 14:30:29 INFO - 'download_symbols': 'ondemand', 14:30:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:29 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:29 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:29 INFO - 'installer_path': 'installer.exe', 14:30:29 INFO - 'log_level': 'info', 14:30:29 INFO - 'log_name': 'talos', 14:30:29 INFO - 'log_to_console': True, 14:30:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:30:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:30:29 INFO - 'opt_config_files': (), 14:30:29 INFO - 'pip_index': False, 14:30:29 INFO - 'sps_profile': False, 14:30:29 INFO - 'sps_profile_interval': 0, 14:30:29 INFO - 'suite': 'dromaeojs', 14:30:29 INFO - 'system_bits': '64', 14:30:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:29 INFO - 'title': 'talos-linux64-ix-030', 14:30:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:29 INFO - 'use_talos_json': True, 14:30:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:29 INFO - 'work_dir': 'build'} 14:30:29 INFO - ##### 14:30:29 INFO - ##### Running clobber step. 14:30:29 INFO - ##### 14:30:29 INFO - Running pre-action listener: _resource_record_pre_action 14:30:29 INFO - Running main action method: clobber 14:30:29 INFO - rmtree: /builds/slave/test/build 14:30:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:29 INFO - Running post-action listener: _resource_record_post_action 14:30:29 INFO - ##### 14:30:29 INFO - ##### Running read-buildbot-config step. 14:30:29 INFO - ##### 14:30:29 INFO - Running pre-action listener: _resource_record_pre_action 14:30:29 INFO - Running main action method: read_buildbot_config 14:30:29 INFO - Using buildbot properties: 14:30:29 INFO - { 14:30:29 INFO - "project": "", 14:30:29 INFO - "product": "firefox", 14:30:29 INFO - "script_repo_revision": "production", 14:30:29 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:30:29 INFO - "repository": "", 14:30:29 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 14:30:29 INFO - "buildid": "20151223135912", 14:30:29 INFO - "pgo_build": "False", 14:30:29 INFO - "basedir": "/builds/slave/test", 14:30:29 INFO - "buildnumber": 799, 14:30:29 INFO - "slavename": "talos-linux64-ix-030", 14:30:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:30:29 INFO - "platform": "ubuntu64_hw", 14:30:29 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 14:30:29 INFO - "branch": "b2g-inbound", 14:30:29 INFO - "repo_path": "integration/b2g-inbound", 14:30:29 INFO - "revision": "3a4b329934ab687c9996d0b11e368ed013b7401c", 14:30:29 INFO - "stage_platform": "linux64", 14:30:29 INFO - "builduid": "4b774c5b07e644e9b0f34a3769a11dcc", 14:30:29 INFO - "slavebuilddir": "test" 14:30:29 INFO - } 14:30:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:30:29 INFO - Running post-action listener: _resource_record_post_action 14:30:29 INFO - ##### 14:30:29 INFO - ##### Running download-and-extract step. 14:30:29 INFO - ##### 14:30:29 INFO - Running pre-action listener: _resource_record_pre_action 14:30:29 INFO - Running main action method: download_and_extract 14:30:29 INFO - mkdir: /builds/slave/test/build/tests 14:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:29 INFO - https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/test_packages.json 14:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/test_packages.json 14:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:30:31 INFO - Downloaded 1302 bytes. 14:30:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:30:31 INFO - Using the following test package requirements: 14:30:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:30:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'jsshell-linux-x86_64.zip'], 14:30:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:30:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:30:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:30:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:30:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:30:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:31 INFO - https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:32 INFO - Downloaded 21931778 bytes. 14:30:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:30:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:30:33 INFO - Return code: 0 14:30:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:33 INFO - https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:34 INFO - Downloaded 21931778 bytes. 14:30:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:30:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:30:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:30:35 INFO - Return code: 0 14:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:35 INFO - https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:30:36 INFO - Downloaded 11132277 bytes. 14:30:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 14:30:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:30:36 INFO - Return code: 0 14:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:36 INFO - https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:30:38 INFO - Downloaded 53275689 bytes. 14:30:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:30:38 INFO - mkdir: /builds/slave/test/properties 14:30:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:38 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:38 INFO - Contents: 14:30:38 INFO - build_url:https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:30:38 INFO - Running post-action listener: _resource_record_post_action 14:30:38 INFO - Running post-action listener: set_extra_try_arguments 14:30:38 INFO - ##### 14:30:38 INFO - ##### Running populate-webroot step. 14:30:38 INFO - ##### 14:30:38 INFO - Running pre-action listener: _resource_record_pre_action 14:30:38 INFO - Running main action method: populate_webroot 14:30:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:38 INFO - '--tppagecycles', 14:30:38 INFO - '7'], 14:30:38 INFO - 'tests': ['tsvgm']}}, 14:30:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:30:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:30:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:30:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'tests': ['damp', 'tps']}, 14:30:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['damp', 'tps']}, 14:30:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:30:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:38 INFO - 'other': {'tests': ['a11yr', 14:30:38 INFO - 'ts_paint', 14:30:38 INFO - 'tpaint', 14:30:38 INFO - 'sessionrestore', 14:30:38 INFO - 'sessionrestore_no_auto_restore']}, 14:30:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['a11yr', 14:30:38 INFO - 'ts_paint', 14:30:38 INFO - 'tpaint', 14:30:38 INFO - 'sessionrestore', 14:30:38 INFO - 'sessionrestore_no_auto_restore']}, 14:30:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['a11yr', 14:30:38 INFO - 'ts_paint', 14:30:38 INFO - 'tpaint', 14:30:38 INFO - 'sessionrestore', 14:30:38 INFO - 'sessionrestore_no_auto_restore']}, 14:30:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['a11yr', 14:30:38 INFO - 'ts_paint', 14:30:38 INFO - 'tpaint', 14:30:38 INFO - 'sessionrestore', 14:30:38 INFO - 'sessionrestore_no_auto_restore']}, 14:30:38 INFO - 'other_l64': {'tests': ['a11yr', 14:30:38 INFO - 'ts_paint', 14:30:38 INFO - 'tpaint', 14:30:38 INFO - 'sessionrestore', 14:30:38 INFO - 'sessionrestore_no_auto_restore']}, 14:30:38 INFO - 'other_nol64': {'tests': ['a11yr', 14:30:38 INFO - 'ts_paint', 14:30:38 INFO - 'tpaint', 14:30:38 INFO - 'sessionrestore', 14:30:38 INFO - 'sessionrestore_no_auto_restore']}, 14:30:38 INFO - 'svgr': {'tests': ['tsvgx', 14:30:38 INFO - 'tsvgr_opacity', 14:30:38 INFO - 'tart', 14:30:38 INFO - 'tscrollx', 14:30:38 INFO - 'cart']}, 14:30:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['tsvgx', 14:30:38 INFO - 'tsvgr_opacity', 14:30:38 INFO - 'tart', 14:30:38 INFO - 'tscrollx', 14:30:38 INFO - 'cart']}, 14:30:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'tests': ['tp5o']}, 14:30:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'talos_options': ['--e10s'], 14:30:38 INFO - 'tests': ['tp5o']}, 14:30:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'talos_options': ['--xperf_path', 14:30:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:38 INFO - 'tests': ['tp5n']}, 14:30:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:38 INFO - 'talos_options': ['--e10s', 14:30:38 INFO - '--xperf_path', 14:30:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:38 INFO - 'tests': ['tp5n']}}, 14:30:38 INFO - 'talos.zip': {'path': '', 14:30:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:38 INFO - Running post-action listener: _resource_record_post_action 14:30:38 INFO - ##### 14:30:38 INFO - ##### Running create-virtualenv step. 14:30:38 INFO - ##### 14:30:38 INFO - Running pre-action listener: _resource_record_pre_action 14:30:38 INFO - Running main action method: create_virtualenv 14:30:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:30:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:38 INFO - Using real prefix '/usr' 14:30:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:41 INFO - Installing pip.................done. 14:30:41 INFO - Return code: 0 14:30:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 14:30:41 INFO - Using env: {'DISPLAY': ':0', 14:30:41 INFO - 'HOME': '/home/cltbld', 14:30:41 INFO - 'LANG': 'en_US.UTF-8', 14:30:41 INFO - 'LANGUAGE': 'en_US:en', 14:30:41 INFO - 'LOGNAME': 'cltbld', 14:30:41 INFO - 'MAIL': '/var/mail/cltbld', 14:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:41 INFO - 'MOZ_NO_REMOTE': '1', 14:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:41 INFO - 'NO_EM_RESTART': '1', 14:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:41 INFO - 'PWD': '/builds/slave/test', 14:30:41 INFO - 'SHELL': '/bin/bash', 14:30:41 INFO - 'SHLVL': '1', 14:30:41 INFO - 'TERM': 'linux', 14:30:41 INFO - 'TMOUT': '86400', 14:30:41 INFO - 'USER': 'cltbld', 14:30:41 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:41 INFO - '_': '/tools/buildbot/bin/python'} 14:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:41 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 14:30:41 INFO - Cleaning up... 14:30:41 INFO - Return code: 0 14:30:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 14:30:41 INFO - Using env: {'DISPLAY': ':0', 14:30:41 INFO - 'HOME': '/home/cltbld', 14:30:41 INFO - 'LANG': 'en_US.UTF-8', 14:30:41 INFO - 'LANGUAGE': 'en_US:en', 14:30:41 INFO - 'LOGNAME': 'cltbld', 14:30:41 INFO - 'MAIL': '/var/mail/cltbld', 14:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:41 INFO - 'MOZ_NO_REMOTE': '1', 14:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:41 INFO - 'NO_EM_RESTART': '1', 14:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:41 INFO - 'PWD': '/builds/slave/test', 14:30:41 INFO - 'SHELL': '/bin/bash', 14:30:41 INFO - 'SHLVL': '1', 14:30:41 INFO - 'TERM': 'linux', 14:30:41 INFO - 'TMOUT': '86400', 14:30:41 INFO - 'USER': 'cltbld', 14:30:41 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:41 INFO - '_': '/tools/buildbot/bin/python'} 14:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:41 INFO - Downloading/unpacking psutil>=0.7.1 14:30:41 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 14:30:41 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 14:30:41 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 14:30:41 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 14:30:41 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 14:30:41 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 14:30:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:30:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:30:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:43 INFO - Installing collected packages: psutil 14:30:43 INFO - Running setup.py install for psutil 14:30:43 INFO - building 'psutil._psutil_linux' extension 14:30:43 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 14:30:43 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 14:30:43 INFO - building 'psutil._psutil_posix' extension 14:30:43 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 14:30:43 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 14:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:43 INFO - Successfully installed psutil 14:30:43 INFO - Cleaning up... 14:30:43 INFO - Return code: 0 14:30:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 14:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 14:30:43 INFO - Using env: {'DISPLAY': ':0', 14:30:43 INFO - 'HOME': '/home/cltbld', 14:30:43 INFO - 'LANG': 'en_US.UTF-8', 14:30:43 INFO - 'LANGUAGE': 'en_US:en', 14:30:43 INFO - 'LOGNAME': 'cltbld', 14:30:43 INFO - 'MAIL': '/var/mail/cltbld', 14:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:43 INFO - 'MOZ_NO_REMOTE': '1', 14:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:43 INFO - 'NO_EM_RESTART': '1', 14:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:43 INFO - 'PWD': '/builds/slave/test', 14:30:43 INFO - 'SHELL': '/bin/bash', 14:30:43 INFO - 'SHLVL': '1', 14:30:43 INFO - 'TERM': 'linux', 14:30:43 INFO - 'TMOUT': '86400', 14:30:43 INFO - 'USER': 'cltbld', 14:30:43 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:43 INFO - '_': '/tools/buildbot/bin/python'} 14:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:30:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:30:45 INFO - Installing collected packages: mozsystemmonitor 14:30:45 INFO - Running setup.py install for mozsystemmonitor 14:30:45 INFO - Successfully installed mozsystemmonitor 14:30:45 INFO - Cleaning up... 14:30:45 INFO - Return code: 0 14:30:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 14:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 14:30:45 INFO - Using env: {'DISPLAY': ':0', 14:30:45 INFO - 'HOME': '/home/cltbld', 14:30:45 INFO - 'LANG': 'en_US.UTF-8', 14:30:45 INFO - 'LANGUAGE': 'en_US:en', 14:30:45 INFO - 'LOGNAME': 'cltbld', 14:30:45 INFO - 'MAIL': '/var/mail/cltbld', 14:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:45 INFO - 'MOZ_NO_REMOTE': '1', 14:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:45 INFO - 'NO_EM_RESTART': '1', 14:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:45 INFO - 'PWD': '/builds/slave/test', 14:30:45 INFO - 'SHELL': '/bin/bash', 14:30:45 INFO - 'SHLVL': '1', 14:30:45 INFO - 'TERM': 'linux', 14:30:45 INFO - 'TMOUT': '86400', 14:30:45 INFO - 'USER': 'cltbld', 14:30:45 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:45 INFO - '_': '/tools/buildbot/bin/python'} 14:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:47 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 14:30:47 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 14:30:47 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 14:30:47 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 14:30:47 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 14:30:47 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 14:30:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:49 INFO - Downloading docopt-0.6.1.tar.gz 14:30:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:49 INFO - Running setup.py install for blobuploader 14:30:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:49 INFO - Running setup.py install for requests 14:30:50 INFO - Running setup.py install for docopt 14:30:50 INFO - Successfully installed blobuploader requests docopt 14:30:50 INFO - Cleaning up... 14:30:50 INFO - Return code: 0 14:30:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 14:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 14:30:50 INFO - Using env: {'DISPLAY': ':0', 14:30:50 INFO - 'HOME': '/home/cltbld', 14:30:50 INFO - 'LANG': 'en_US.UTF-8', 14:30:50 INFO - 'LANGUAGE': 'en_US:en', 14:30:50 INFO - 'LOGNAME': 'cltbld', 14:30:50 INFO - 'MAIL': '/var/mail/cltbld', 14:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:50 INFO - 'MOZ_NO_REMOTE': '1', 14:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:50 INFO - 'NO_EM_RESTART': '1', 14:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:50 INFO - 'PWD': '/builds/slave/test', 14:30:50 INFO - 'SHELL': '/bin/bash', 14:30:50 INFO - 'SHLVL': '1', 14:30:50 INFO - 'TERM': 'linux', 14:30:50 INFO - 'TMOUT': '86400', 14:30:50 INFO - 'USER': 'cltbld', 14:30:50 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:50 INFO - '_': '/tools/buildbot/bin/python'} 14:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:51 INFO - Running setup.py (path:/tmp/pip-j0CQSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:51 INFO - Running setup.py (path:/tmp/pip-CMpTgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:51 INFO - Running setup.py (path:/tmp/pip-nyFygA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:51 INFO - Running setup.py (path:/tmp/pip-VVjE8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:51 INFO - Running setup.py (path:/tmp/pip-HtlWa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:51 INFO - Running setup.py (path:/tmp/pip-NLdLte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:51 INFO - Running setup.py (path:/tmp/pip-aOX_Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:51 INFO - Running setup.py (path:/tmp/pip-6vaS0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:51 INFO - Running setup.py (path:/tmp/pip-ztLir6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:51 INFO - Running setup.py (path:/tmp/pip-fWJA7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:51 INFO - Running setup.py (path:/tmp/pip-Z0Qpdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:51 INFO - Running setup.py (path:/tmp/pip-oC5WL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:51 INFO - Running setup.py (path:/tmp/pip-wMQFKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:51 INFO - Running setup.py (path:/tmp/pip-1nyb_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:52 INFO - Running setup.py (path:/tmp/pip-vk7i7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:52 INFO - Running setup.py (path:/tmp/pip-gWu3EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:52 INFO - Running setup.py (path:/tmp/pip-baFeZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:52 INFO - Running setup.py install for manifestparser 14:30:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozcrash 14:30:52 INFO - Running setup.py install for mozdebug 14:30:52 INFO - Running setup.py install for mozdevice 14:30:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozfile 14:30:52 INFO - Running setup.py install for mozhttpd 14:30:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozinfo 14:30:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozInstall 14:30:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozleak 14:30:53 INFO - Running setup.py install for mozlog 14:30:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for moznetwork 14:30:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozprocess 14:30:53 INFO - Running setup.py install for mozprofile 14:30:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozrunner 14:30:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozscreenshot 14:30:53 INFO - Running setup.py install for moztest 14:30:53 INFO - Running setup.py install for mozversion 14:30:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:53 INFO - Cleaning up... 14:30:53 INFO - Return code: 0 14:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 14:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 14:30:53 INFO - Using env: {'DISPLAY': ':0', 14:30:53 INFO - 'HOME': '/home/cltbld', 14:30:53 INFO - 'LANG': 'en_US.UTF-8', 14:30:53 INFO - 'LANGUAGE': 'en_US:en', 14:30:53 INFO - 'LOGNAME': 'cltbld', 14:30:53 INFO - 'MAIL': '/var/mail/cltbld', 14:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:53 INFO - 'MOZ_NO_REMOTE': '1', 14:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:53 INFO - 'NO_EM_RESTART': '1', 14:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:53 INFO - 'PWD': '/builds/slave/test', 14:30:53 INFO - 'SHELL': '/bin/bash', 14:30:53 INFO - 'SHLVL': '1', 14:30:53 INFO - 'TERM': 'linux', 14:30:53 INFO - 'TMOUT': '86400', 14:30:53 INFO - 'USER': 'cltbld', 14:30:53 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:53 INFO - '_': '/tools/buildbot/bin/python'} 14:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:54 INFO - Running setup.py (path:/tmp/pip-QpCZRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:54 INFO - Running setup.py (path:/tmp/pip-fRgRoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:54 INFO - Running setup.py (path:/tmp/pip-_kKNlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:54 INFO - Running setup.py (path:/tmp/pip-DEaaza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:54 INFO - Running setup.py (path:/tmp/pip-KKGJQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:54 INFO - Running setup.py (path:/tmp/pip-EMFnU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:54 INFO - Running setup.py (path:/tmp/pip-HgDaAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:54 INFO - Running setup.py (path:/tmp/pip-iHl1PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:54 INFO - Running setup.py (path:/tmp/pip-jlotbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:54 INFO - Running setup.py (path:/tmp/pip-yHx_V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:54 INFO - Running setup.py (path:/tmp/pip-rw3AKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:55 INFO - Running setup.py (path:/tmp/pip-qi5nFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:55 INFO - Running setup.py (path:/tmp/pip-D9wNSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:55 INFO - Running setup.py (path:/tmp/pip-ymeFpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:55 INFO - Running setup.py (path:/tmp/pip-RQhqK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:55 INFO - Running setup.py (path:/tmp/pip-YjVfUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:55 INFO - Running setup.py (path:/tmp/pip-VaIxat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:30:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30:55 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 14:30:55 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 14:30:55 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 14:30:55 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 14:30:55 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 14:30:55 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 14:30:57 INFO - Downloading blessings-1.5.1.tar.gz 14:30:57 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:30:57 INFO - Installing collected packages: blessings 14:30:57 INFO - Running setup.py install for blessings 14:30:57 INFO - Successfully installed blessings 14:30:57 INFO - Cleaning up... 14:30:57 INFO - Return code: 0 14:30:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:30:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:57 INFO - Reading from file tmpfile_stdout 14:30:57 INFO - Current package versions: 14:30:57 INFO - argparse == 1.2.1 14:30:57 INFO - blessings == 1.5.1 14:30:57 INFO - blobuploader == 1.2.4 14:30:57 INFO - docopt == 0.6.1 14:30:57 INFO - manifestparser == 1.1 14:30:57 INFO - mozInstall == 1.12 14:30:57 INFO - mozcrash == 0.16 14:30:57 INFO - mozdebug == 0.1 14:30:57 INFO - mozdevice == 0.47 14:30:57 INFO - mozfile == 1.2 14:30:57 INFO - mozhttpd == 0.7 14:30:57 INFO - mozinfo == 0.9 14:30:57 INFO - mozleak == 0.1 14:30:57 INFO - mozlog == 3.1 14:30:57 INFO - moznetwork == 0.27 14:30:57 INFO - mozprocess == 0.22 14:30:57 INFO - mozprofile == 0.28 14:30:57 INFO - mozrunner == 6.11 14:30:57 INFO - mozscreenshot == 0.1 14:30:57 INFO - mozsystemmonitor == 0.0 14:30:57 INFO - moztest == 0.7 14:30:57 INFO - mozversion == 1.4 14:30:57 INFO - psutil == 3.1.1 14:30:57 INFO - requests == 1.2.3 14:30:57 INFO - wsgiref == 0.1.2 14:30:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 14:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 14:30:57 INFO - Using env: {'DISPLAY': ':0', 14:30:57 INFO - 'HOME': '/home/cltbld', 14:30:57 INFO - 'LANG': 'en_US.UTF-8', 14:30:57 INFO - 'LANGUAGE': 'en_US:en', 14:30:57 INFO - 'LOGNAME': 'cltbld', 14:30:57 INFO - 'MAIL': '/var/mail/cltbld', 14:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:57 INFO - 'MOZ_NO_REMOTE': '1', 14:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:57 INFO - 'NO_EM_RESTART': '1', 14:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:57 INFO - 'PWD': '/builds/slave/test', 14:30:57 INFO - 'SHELL': '/bin/bash', 14:30:57 INFO - 'SHLVL': '1', 14:30:57 INFO - 'TERM': 'linux', 14:30:57 INFO - 'TMOUT': '86400', 14:30:57 INFO - 'USER': 'cltbld', 14:30:57 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:57 INFO - '_': '/tools/buildbot/bin/python'} 14:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:30:57 INFO - Cleaning up... 14:30:57 INFO - Return code: 0 14:30:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 14:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 14:30:57 INFO - Using env: {'DISPLAY': ':0', 14:30:57 INFO - 'HOME': '/home/cltbld', 14:30:57 INFO - 'LANG': 'en_US.UTF-8', 14:30:57 INFO - 'LANGUAGE': 'en_US:en', 14:30:57 INFO - 'LOGNAME': 'cltbld', 14:30:57 INFO - 'MAIL': '/var/mail/cltbld', 14:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:57 INFO - 'MOZ_NO_REMOTE': '1', 14:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:57 INFO - 'NO_EM_RESTART': '1', 14:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:57 INFO - 'PWD': '/builds/slave/test', 14:30:57 INFO - 'SHELL': '/bin/bash', 14:30:57 INFO - 'SHLVL': '1', 14:30:57 INFO - 'TERM': 'linux', 14:30:57 INFO - 'TMOUT': '86400', 14:30:57 INFO - 'USER': 'cltbld', 14:30:57 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:57 INFO - '_': '/tools/buildbot/bin/python'} 14:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:58 INFO - Downloading/unpacking jsonschema 14:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:59 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 14:30:59 INFO - Downloading/unpacking functools32 (from jsonschema) 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:59 INFO - warning: no files found matching '*.txt' 14:30:59 INFO - no previously-included directories found matching 'build' 14:30:59 INFO - no previously-included directories found matching 'dist' 14:30:59 INFO - no previously-included directories found matching '.git*' 14:30:59 INFO - Installing collected packages: jsonschema, functools32 14:31:00 INFO - Running setup.py install for functools32 14:31:00 INFO - warning: no files found matching '*.txt' 14:31:00 INFO - no previously-included directories found matching 'build' 14:31:00 INFO - no previously-included directories found matching 'dist' 14:31:00 INFO - no previously-included directories found matching '.git*' 14:31:00 INFO - Successfully installed jsonschema functools32 14:31:00 INFO - Cleaning up... 14:31:00 INFO - Return code: 0 14:31:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:31:00 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')]} 14:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:00 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')]} 14:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x7f343b1a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2974dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 14:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 14:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 14:31:00 INFO - Using env: {'DISPLAY': ':0', 14:31:00 INFO - 'HOME': '/home/cltbld', 14:31:00 INFO - 'LANG': 'en_US.UTF-8', 14:31:00 INFO - 'LANGUAGE': 'en_US:en', 14:31:00 INFO - 'LOGNAME': 'cltbld', 14:31:00 INFO - 'MAIL': '/var/mail/cltbld', 14:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:00 INFO - 'MOZ_NO_REMOTE': '1', 14:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:00 INFO - 'NO_EM_RESTART': '1', 14:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:00 INFO - 'PWD': '/builds/slave/test', 14:31:00 INFO - 'SHELL': '/bin/bash', 14:31:00 INFO - 'SHLVL': '1', 14:31:00 INFO - 'TERM': 'linux', 14:31:00 INFO - 'TMOUT': '86400', 14:31:00 INFO - 'USER': 'cltbld', 14:31:00 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:00 INFO - '_': '/tools/buildbot/bin/python'} 14:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:00 INFO - Downloading/unpacking flake8 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:31:02 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 14:31:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:31:02 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 14:31:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 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 14:31:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:02 INFO - no previously-included directories found matching 'docs/_build' 14:31:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:31:02 INFO - Running setup.py install for pep8 14:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:02 INFO - no previously-included directories found matching 'docs/_build' 14:31:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:31:02 INFO - Cleaning up... 14:31:02 INFO - Return code: 0 14:31:02 INFO - Running post-action listener: _resource_record_post_action 14:31:02 INFO - Running post-action listener: _start_resource_monitoring 14:31:02 INFO - Starting resource monitoring. 14:31:02 INFO - ##### 14:31:02 INFO - ##### Running install step. 14:31:02 INFO - ##### 14:31:02 INFO - Running pre-action listener: _resource_record_pre_action 14:31:02 INFO - Running main action method: install 14:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:03 INFO - Reading from file tmpfile_stdout 14:31:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:03 INFO - Reading from file tmpfile_stdout 14:31:03 INFO - Output received: 14:31:03 INFO - Usage: mozinstall [options] installer 14:31:03 INFO - Options: 14:31:03 INFO - -h, --help show this help message and exit 14:31:03 INFO - -d DEST, --destination=DEST 14:31:03 INFO - Directory to install application into. [default: 14:31:03 INFO - "/builds/slave/test"] 14:31:03 INFO - --app=APP Application being installed. [default: firefox] 14:31:03 INFO - mkdir: /builds/slave/test/build/application 14:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:31:18 INFO - Reading from file tmpfile_stdout 14:31:18 INFO - Output received: 14:31:18 INFO - /builds/slave/test/build/application/firefox/firefox 14:31:18 INFO - Running post-action listener: _resource_record_post_action 14:31:18 INFO - ##### 14:31:18 INFO - ##### Running run-tests step. 14:31:18 INFO - ##### 14:31:18 INFO - Running pre-action listener: _resource_record_pre_action 14:31:18 INFO - Running main action method: run_tests 14:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:18 INFO - Python 2.7.3 14:31:18 INFO - Return code: 0 14:31:18 INFO - grabbing minidump binary from tooltool 14:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/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 0x2a073d0>, '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 0x2972ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2973360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:31:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:31:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:18 INFO - Return code: 0 14:31:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:31:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:31:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:31:19 INFO - Return code: 0 14:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:31:19 INFO - Using env: {'DISPLAY': ':0', 14:31:19 INFO - 'HOME': '/home/cltbld', 14:31:19 INFO - 'LANG': 'en_US.UTF-8', 14:31:19 INFO - 'LANGUAGE': 'en_US:en', 14:31:19 INFO - 'LOGNAME': 'cltbld', 14:31:19 INFO - 'MAIL': '/var/mail/cltbld', 14:31:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:19 INFO - 'MOZ_NO_REMOTE': '1', 14:31:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:19 INFO - 'NO_EM_RESTART': '1', 14:31:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:19 INFO - 'PWD': '/builds/slave/test', 14:31:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:19 INFO - 'SHELL': '/bin/bash', 14:31:19 INFO - 'SHLVL': '1', 14:31:19 INFO - 'TERM': 'linux', 14:31:19 INFO - 'TMOUT': '86400', 14:31:19 INFO - 'USER': 'cltbld', 14:31:19 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067', 14:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:19 INFO - '_': '/tools/buildbot/bin/python'} 14:31:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:31:19 INFO - mozversion application_buildid: 20151223135912 14:31:19 INFO - mozversion application_changeset: 3a4b329934ab687c9996d0b11e368ed013b7401c 14:31:19 INFO - mozversion application_display_name: Nightly 14:31:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:19 INFO - mozversion application_name: Firefox 14:31:19 INFO - mozversion application_remotingname: firefox 14:31:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:31:19 INFO - mozversion application_vendor: Mozilla 14:31:19 INFO - mozversion application_version: 46.0a1 14:31:19 INFO - mozversion platform_buildid: 20151223135912 14:31:19 INFO - mozversion platform_changeset: 3a4b329934ab687c9996d0b11e368ed013b7401c 14:31:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:31:19 INFO - mozversion platform_version: 46.0a1 14:31:19 INFO - using testdate: 1450909879 14:31:19 INFO - actual date: 1450909879 14:31:19 INFO - starting webserver on 'localhost:37454' 14:31:19 INFO - SUITE-START | Running 3 tests 14:31:19 INFO - TEST-START | dromaeo_css 14:31:19 INFO - operating with platform_type : linux_ 14:31:19 INFO - Initialising browser for dromaeo_css test... 14:31:20 INFO - TEST-INFO | started process 6574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv9Yziz/profile http://localhost:37454/getInfo.html) 14:31:24 INFO - PROCESS | 6574 | __metrics Screen width/height:1600/1200 14:31:24 INFO - PROCESS | 6574 | colorDepth:24 14:31:24 INFO - PROCESS | 6574 | Browser inner width/height: 1024/697 14:31:24 INFO - PROCESS | 6574 | __metrics 14:31:24 INFO - PROCESS | 6574 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:31:24 INFO - PROCESS | 6574 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:25 INFO - TEST-INFO | 6574: exit 0 14:31:25 INFO - Browser initialized. 14:31:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:25 INFO - TEST-INFO | started process 6665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv9Yziz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:37 INFO - PROCESS | 6665 | RSS: Main: 150949888 14:31:37 INFO - PROCESS | 6665 | 14:32:28 INFO - PROCESS | 6665 | 1450909948712 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] 14:34:40 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:37454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37454/tests/dromaeo/cssquery-ext.html) 14:34:41 INFO - PROCESS | 6665 | RSS: Main: 251383808 14:34:41 INFO - PROCESS | 6665 | 14:37:44 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:37454/tests/dromaeo/cssquery-ext.html (next: http://localhost:37454/tests/dromaeo/cssquery-jquery.html) 14:37:44 INFO - PROCESS | 6665 | RSS: Main: 225419264 14:37:44 INFO - PROCESS | 6665 | 14:40:46 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:37454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37454/tests/dromaeo/cssquery-mootools.html) 14:40:47 INFO - PROCESS | 6665 | RSS: Main: 222584832 14:40:47 INFO - PROCESS | 6665 | 14:43:49 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:37454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37454/tests/dromaeo/cssquery-prototype.html) 14:43:50 INFO - PROCESS | 6665 | RSS: Main: 207814656 14:43:50 INFO - PROCESS | 6665 | 14:46:52 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:37454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37454/tests/dromaeo/cssquery-yui.html) 14:46:53 INFO - PROCESS | 6665 | RSS: Main: 214335488 14:46:53 INFO - PROCESS | 6665 | 14:49:55 INFO - PROCESS | 6665 | Cycle 1(1): loaded http://localhost:37454/tests/dromaeo/cssquery-yui.html (next: http://localhost:37454/tests/dromaeo/cssquery-dojo.html) 14:49:56 INFO - PROCESS | 6665 | RSS: Main: 248393728 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | __start_tp_report 14:49:56 INFO - PROCESS | 6665 | _x_x_mozilla_page_load 14:49:56 INFO - PROCESS | 6665 | _x_x_mozilla_page_load_details 14:49:56 INFO - PROCESS | 6665 | |i|pagename|runs| 14:49:56 INFO - PROCESS | 6665 | |0;dojo.html;2611.8694065296736;2670.452557225769;2685.825421347612;2686.7447592478707;2716.660417447819;4396.868093957179;4531.139083574119;4645.51222121677;4670.906581868365;4687.343771871941;4560.9087818243615;4617;4646.953530464694;4654.930176047362;4666.136764698533;4283.550227226143;4336.9349459758205;4348.869533913988;4415.072834704716;4428.889277768049;4190.455240818689;4340.544242854502;4378.321360189176;4437.889052773674;4468.8212471501265;4208.242516347056;4310.5042920064125;4311.33174357975;4316.115196384733;4319.956800431987;4333.198358303693;4335.84824531143;4338.58783415575;4344.348347747831;4381;4315.331123675835;4316.179925814116;4324.005478739908;4352.521222665504;4359.258925982559;4434.246178149722;4502.549745025504;4554.2485489894125;4564.520725323827;4631.027484228282;4986.10250154972;4990.775415106329;5000.0999820032375;5008.023435430093;5060.721660308682;5020.899582008376;5040.117979353635;5042.949570504285;5079.466656001104;5080.288759573663;4500.054988452429;4600.769961501912;4603.95396046042;4639.791209395586;4644.512326205768;5225.555827754607;5226.738663066907;5227.215917612312;5229.581633469314;5240.109181439165;4947.480514545993;4966.478519755446;4966.9817687374;4967.4784147664695;5012.448630650625;4787.593054590329;4889.877753056202;4897.951020489821;4902.901941961212;5036.899262014813;4757.738324392122;4867.756612169377;4869.9513004870205;4871.878203044952;4889.266610008527;4948.62885283598;4965.751712414365;4966.900661986812;4970.826021089245;4976.825811096594;4118.382242663624;4200.663946884242;4211.347241177622;4250.659947204216;4275.508316543575;3631.1829838286176;3684.3368193725387;3693.519842420522;3706.5737440194184;3730.1420673245307;4319.460067491564;4320.65434765218;4320.956790432118;4339.327404252346;4357.8256869724855;4810.5670489656095;4945;5061.44324124346;5066.771995260148;5110.591152707774;4173.311403618369;4190.790460476964;4252.043290259667;4254.298040823292;4296.82812687489;4504.34686970394;4506.076254367847;4511.774411279423;4529;4544.409226800495;4543.341215523797;4664.650151238603;4803.519648035239;4807.711537307633;4810.59109975649;4860.198067318853;4896.90206195867;4926.704397736147;4959.132151873336;5012.248162775612;4775.6657034007285;4777.522247775195;4779.928301075417;4780.474147843804;4822.107910036654;4751.40607424072;4853.538913803183;4940.555350018516;4942.876428089183;4985.027919555652;4970.826021089245;4989.925151122663;5098.337216161875;5105.617078719037;5114.923276150935;4847.491013443538;4851.223804191312;4878.926816097691;4889.657723959289;4899.877503062309;4809.735464549483;4831.444383895897;4844.249141383091;4853.247746599282;4894.898647804215;4604.148232576984;4682.2040253156365;4725.362076119817;4726;4726.03116361152;4851.490593487633;4853;4855.174620314484;4877.6341774367775;4903.33804936329;4691.108689349013;4692.0146769178855;4693.483716791218;4705.12955103307;4746.7863946121815 14:49:56 INFO - PROCESS | 6665 | |1;ext.html;536.4206656810645;538.946105389461;541.4774742373611;569.3566270114769;572.4475880775054;24628.138015169472;36637.81681091594;36661.63338366619;36928.63071369285;37040.444393334124;40482.190356192856;41022.38466422998;41095.178096438125;41125;41169.38245926306;6981.301869813029;7100.396466300371;7888.132305446382;8046.758597242092;8058.758237252891;10233.232507561925;10577.73555661107;10579.153667706603;10581.418022008786;10592.364458132537;10142.442165680885;10235.641752538662;10236.590536378535;10239.129673977684;10244.180465562775;7284.526505777108;7487.02668653077;9871.555779989918;10269.743256418575;10661.733456663567;10043.347182433119;10180.643677471253;10186.490675466197;10190.490475476197;10191.694249172537;37414.62585374139;37857.621423785684;37932.241355172744;38018.42972355417;38018.61981380206;2888.9711102889123;2931.457680329146;2936.8384738839354;3489.005633394496;3562.7065076856734;28666.283342916384;28874.6756114383;28892.855535722396;28916;30024.54963175554;3487.2676737885076;3494.755367124302;3511.841967111486;3576.8032758198287;3592.7485076044686;218123.9999999984;218675;219136;220166;220306.9999999984;57129.42870571241;57307;57524;57574.7121264391;57626;50872.74563627158;52120.47879521232;66425;67936.6603166981;68015;13907.58277251684;13908.721825563634;13911.165330080228;14051.297435128203;14088.718225635635;10744.30162039465;10828.242023058468;10830.67507974762;10847.457627118612;10848.457577121113;19316.813929443764;19568.608627827365;19701;19704.113314900864;19713.408597741804;7113.253108423644;7250.456215783837;7342.889856652155;7347.669354879044;7417.925820741723;805;881.6032785246665;891.9241864441595;918.9294471940249;940.9200217981411;25943.870280648476;26554.867225663747;26583.202503924913;26601.467970640864;26602.46795064088;929.1823195587839;938.4791440750313;943.9669611563562;956.9473678947725;1061.506399524225;13660.316984150753;13850.584482465541;13868.167909925436;13952.930235348758;14100.576982690536;249465;253653;255327;255574;255578;47297;47322.290165647544;47476.5252347479;47564.28653570199;47667.523324767004;1175.3183153770792;1187.3884949251142;1201.4893670190133;1209.1898428053225;1211.0735287505065;25120.246392608253;25517.61723574111;25937.870310648326;26348.473030539666;26368;41471.37792933169;41682.79158604187;41798.37302440405;41819;41870.999999998785;232293;235366;293822;296115;324512;26759.732402675723;26778.866105669345;27005;27337;27349.726502735513;36449.817750911076;38657.64698235548;39441.60558394494;40049.39925901172;40374.59625403708;28808.279793005342;31972.20069498281;33320.66679333176;34957;36886.815565922;31923.36153276968;36997.63002369942;38573.42139867848;38747;38834;34789.47815782714;34852;34934;35245.64754352424;35305;36351.63648363482;36994.44508332431;37414;37576.624233758404;37654;27850.607469626844;28622.284442889093;29024.56463153012;29084.7091529082;29111.563326550542 14:49:56 INFO - PROCESS | 6665 | |2;jquery.html;341.6463959801606;342.5409950666107;343.6237320134452;343.7267372438911;344.6484585722563;12508.186967847083;12938.288394138319;14903.776443353345;14937.10377377358;15588;11969.401529923512;14981.775273370908;15413.5375938722;15866.2066896655;15879.52361429159;4901.583365413944;4922.827701030465;5052.24216367546;5090.490950904898;5100.056489549426;3356.3790698720813;3427.0575591712354;5036.924446133311;5072.26452164436;5162.148245539482;5230.032443997854;5260.395054568716;5262.342207224097;5279.604029697769;5288.8413347599635;5240.502152295526;5247.1866860636665;5477.643953143053;5720.11338242573;5739.569532285053;5090.389153301628;5093.490650934914;5098.311727916721;5099.36257967754;5103.872403189913;10236.74408139795;11350.375729334883;12109.576164834189;12124.272543647321;12141;1675.748637704342;1679.3618424998544;1768.0629266488781;1800.0549711401488;1801.5856353038744;9102.13529714676;9138.543072846398;9424.293178011609;9456.621735130586;11013.669589912315;1694.305334812721;1717.3302412059306;1725.568607848038;1752.5618595351161;1755.3154269834774;56274.71862640702;58500.414995849926;58667.11999320056;58867;59396.703016484644;9407.482588457564;9532.714018579454;9707.369021013612;9720.61117555304;9740.318177727633;12054.819177712341;12130.090243231793;12140.15018948665;12143.332116733665;12150.635480935585;6859.794206173823;6882.139732533434;6946.305369463013;6946.9652651736415;6966.756163534252;6906.896396554056;6916.723331066701;6935.306469353024;6950.860982780316;6966.9651651741415;4027.677785777131;4257.318828987347;4274.166537525152;4277.230098582285;4318.589733975267;1670.5740036290667;1704.3267909176054;1717.3216579451048;1780.5103596510803;1860.2744929477515;764.0334976255042;798.8242586630931;805.3396215103676;822.3667775812711;918.7519369770125;15257.389704411698;15629.60925976837;15832.76250856238;15857.30425827612;15902.284397202153;809.299955538455;826.3884725303233;850.7660393391867;915.8534634458455;944.4333399959969;8034.718784842503;8829.955850220707;8980.326475514232;8983.191512763882;9074.183323500916;413684;415389;429730.810767572;434725;436196;37650.24699505995;68112.3188768106;68397.65801171062;70518.2506543066;72483.27516724766;1044.770150566874;1048.8793788714395;1052.4527245832278;1065.4725910674265;1067.829147336438;14077.225752583707;14212.644683882572;14255.857441425453;14281.357338919566;14383.496577620152;31515.684843152194;31569;31896.36207275795;32550.18624534311;32630.83684581562;42953;43654.78172609117;43688.12623747444;44182.55817441784;46220.537794621625;8353.749387518385;8560.91439085626;8659.87010194835;8677.305815534868;8680.435771674822;10089.495525223856;10187.388756674623;12638.368081596067;15901.28444220036;16034.839651603335;13144.539941102015;13374.465021399035;13705.383257753225;13795;13910.095843770123;12926.741465170831;13202.669933251746;13327.66680832987;13595.252261125734;13808.964327675665;13344.466221351036;13507.459701612219;13697.931510342385;13842.723145536831;14031.859681403464;8463.153684631734;8536.402451828313;8545.273651739672;8807.647694092164;8892.86660700103;9458.668946586837;13524.984663571322;13631.454741810216;13651.79522307186;13800.654983625489 14:49:56 INFO - PROCESS | 6665 | |3;mootools.html;1103.8178700514416;1645.3418632546984;1648.6372997940448;1690.1042447502828;1715.7597936288919;6107.877842443154;6834.692438840258;6993.335633114859;7005.334493223142;7017.122859642544;7195.424366050716;7315.8536829263385;7331.0469638947;7339.88990165148;7342.045534080562;2105.46310690774;2140.646793279107;2143.496278374581;2145.7210562626838;2148.5380643161716;2119.448943274752;2140.561184957088;2206.007296716476;2212.4579478027904;2226.031676220849;2097.528056187361;2122.129926730041;2134.551744133734;2140.2937030779885;2151.741790985076;2135.679648052789;2167.8590891592;2173.239366221818;2174.0868835089223;2175.3256490487997;2124.3626911926513;2160.8703477791382;2167.1873047607146;2170.1536400803543;2170.739511258659;7144.821379465503;7210.062691850078;7231.493795434321;7245;7245.0219220405625;4300.204462174508;4381.605655490989;4406.0747243078995;4410.1179764047;4414.426124603781;2613.124603257911;2648.6821581410163;2658.043104482385;2660.9467810643873;2662.6804783426114;830.8047608811925;845.4927043773687;846.834867200896;847.5084451018456;875.3303722652176;9613.567389467491;9632;9641.084097010773;9641.180499657466;9643.90356096437;3991.082051128257;3995.380715989026;4053.1285773558825;4065.4714887065084;4068.2066996935314;8394.370422218359;8398.580070996548;8398.622062007102;8409.621567029377;8423.031351394546;4182.707210495236;4232.428622135973;4236.703430759817;4269.380939763717;4270.188664153801;3374.915627109293;3478.913027174341;3862.633049860259;3867.013911452618;3869.2454971280895;3509.5613048368955;3545.096000519851;3547.6452354764315;3564.2515071835205;3592.892213233607;1115.068917453935;1123.4944275076248;1127.610974213895;1130.5703832543581;1136.494260054268;751.1474476469247;768.6080099149474;941.8775559177263;1001.019001378653;1153.400231879418;6703.664816759143;6787.083743694538;6787.321267873272;6792.592444453348;6808.523403361816;1036.6371769880482;1044.5926088825365;1054.8206804843196;1058.3120971368671;1084.159776173472;5250.579953603703;5315.176147697113;5322.707251101227;5342.893142137135;5354.54486368663;8258.25675689191;8359.791005224797;8368.707095251759;8372.03721572015;8375.581220938928;8227.794305142419;8329.208725171098;8329.583520824055;8345.165483451607;8347.207015333533;6789.830254243683;6871.072405225331;6953.33943275388;6969.16370035599;6975.790726278321;6756.223034350916;6778.93221067783;6809.148856392951;6818;6835.521513494206;7561.130469996021;7806.219378062148;7876.448648594773;7888.329491993245;7906.327962123284;7825.3739700824935;7951.522908625501;7999.040115186215;8058.556779377191;8084.110747817617;6244;6250.062490626442;6276.058591211355;6302.644931339784;6349.587276826992;6796.898046529405;6856.040154378291;6863.519553631198;6874.621895795779;6881.862362752617;6513.348665133449;6550.737970481318;6574.27682954865;6591.505637077143;6644.83387915306;6423.614583125028;6430.067640192239;6475.870482590416;6513.1532900722605;6545;6481.319461456667;6499.285078641251;6499.675016249074;6501.219853617407;6504.934950650433;5860.677662728591;5861.267341582302;5882.23530940975;5914.497267732291;5944.762209511571;6036.305824830025;6094.177286066501;6106.992346262995;6120.234970628671;6127.877442451215 14:49:56 INFO - PROCESS | 6665 | |4;prototype.html;311.3694768094608;311.377245508982;311.6431685719852;314.1126318151223;322.04995263971284;5238.476152384759;5325.920111198335;5332.066888294543;5336.012837625037;5348.598855085869;5263.0263401270795;5264.657797243177;5279.894402111955;5280.788768449267;5291.947080529194;3926.096997690533;4025.476688030552;4145.523264824538;4149.7302675326155;4158.563350848162;4046.271671099201;4122.361034039729;4162.854300099497;4176.248275310443;4181.540030596632;4134.834606615732;4136.731112477694;4146.357314616239;4149.813258403364;4165.10450253197;3927.4697915781576;4028.154087641599;4029.315016447211;4131.421600975866;4151.875443736678;3659.0669379308374;3671.963280367189;3672.155404257036;3688.5942546319884;3693.907652308687;5069.898602027975;5073.213651883964;5082.720450375228;5091.618128640367;5093.363329583802;4740.265258884879;4743.454502732161;4746.264329029006;4746.596539294164;4752.809887604491;5396.298481197419;5531.3362396512675;5533.501984821345;5550;5558.777648894039;3919.6276353746634;3926.11662375966;3927.8625248116177;3929.862454814068;3931.4495970564144;5822.446867547576;5825.475707186373;5829.4753472187285;5834.241548598655;5837.795677151322;4039.4950631171105;4044.69664775143;4045.0494133878515;4046.1300820323772;4046.979765101156;3731.869384571527;3837.3860182370686;4086.979565102215;4100.0569868930315;4103.466549348625;4438.1567502174485;4550.317452382103;4554.749488778083;4602.05657840142;4729.266963620645;5337.5463085637375;5557.77768889248;5557.888842223133;5560.304961879765;5561.6663000220115;1457.154850186889;1473.5579326202096;1477.0842077911548;1478.7116512280002;1481.9481318153812;989.0055221133248;1006.6677996261217;1021.2289721260549;1037.7613148975627;1049.5277125293649;4849.563539281482;4851.708897466164;4854.150523658416;4859.2954021667365;4864.829730959399;5712.885742285131;5717.142428635655;5719.799807006735;5728;5732.398098199712;4836.637252206098;4841.709497430165;4846.466888642247;4847.127517046965;4847.248676455155;2962.7333539981505;3039.5592639067213;3058.5565093061828;3063.5098384258413;3096.7367773739484;5505.889882202334;5517.006938751063;5518.779248830002;5524.4199359066715;5526.917096243559;5969.343372229051;5971.044632858809;5973.283206015306;5984.970075149684;5986.3714309997695;5371.301730774974;5461.890762184734;5503.697296648643;5507.284053073075;5512.366077901012;5779.450952159538;5804.2744656917885;5812.070068788974;5812.796552120655;5812.912806307824;5675.829725108253;5676.631018983753;5677.545796336366;5680.176374425602;5686.431356864446;5510.366307874646;5516.393196748435;5518.779248830002;5520.420355862577;5523.917141242804;3947.9013024674614;4017.6384125428854;4027.154297597537;4056.2090392374384;4063.9390409143293;5812.447817457335;5814.3604203538425;5816.680082595498;5817.447342502455;5821.912671309849;5587.0502014656795;5590.2453168821685;5593.664380137205;5597.244372009726;5598.748056337393;5462.91805622908;5591.720413979204;5592.105263157875;5592.916106258328;5605.383407825055;5473.67157970523;5479;5479.835604931858;5481.068218402801;5483.341998960151;5632.690202038927;5633.774649013993;5634.098544233067;5636.830895073154;5638.859028524155;5452.618316717951;5452.645578037414;5458.9454105458435;5461.15352120422;5462 14:49:56 INFO - PROCESS | 6665 | |5;yui.html;653.2324518690539;666.4601672645158;724.884018557031;731.2249016042995;739.1758189618573;10757.408342541157;10939.945300273488;10943.890561094388;10945.124390048797;10951;11215.439228038585;11515.654530364103;11528;11550.942245288783;11551.53793848245;628.801927392872;638.6551262318343;776.510798197135;786.1509569664763;812.5043723328765;804.2560631415946;804.7907544038563;810.1979040749645;811.1888111888112;812.9796755081111;840.4957025784541;849.2272032450471;851.4635779458963;852.071242345843;852.6205838401913;651.4202359899693;661.371696887956;819.6229734322219;836.021854430318;838.3670328901701;620.0791824141147;623.2209737827716;624.815679374581;625.3090335179652;625.4839757200328;11860.169788114836;11916.404179791063;11962.342071186082;11979.46092425843;12030.69923251917;10829;11520.827187592193;11983.281003139753;11994.340311282876;12411;9005.046576107523;9072.183503484717;9188.127127922837;9200.263978881674;9232.538373081386;3219.3078488125166;3249.1877030742316;3284.178955261185;3311.6688331166933;3320.25294308781;39107.80446097751;39200;39253.411198832044;39535.20929581421;39667.60332396668;9216.493092879957;9399.201067909167;9426.434413935185;9431.151196392357;9452.432854028642;16739.246733897005;16910.40813571519;16940.40708575194;16961.49115526536;17008.48974530766;6454.935450645527;6487.3188315226225;6544.181977252843;6585.341465853472;6750.35871592198;3290.3748287825715;3338.4992251162034;3341.276933770212;3442.1566716154703;3443.9827800860835;2699.4736026474648;2718.986405067962;2725.931851703723;2727.699953005168;2752.9587056194173;489.0290200115783;500.9874753131201;501.6488458079359;505.656153815409;508.69224119407227;465.37407187332985;500.29958058718086;524.3105316508779;572.9627574207664;584.5615788158881;7368.336849683555;7410.221926697727;7479.8504029919095;7585.393168546503;7610.1628820829665;492.59607122159485;546.9643478693316;573.5239751006654;579.3337661689092;595.5295316699845;3383.9323213536086;3956.5647778744315;4108.568600296926;4110.712250142521;4297.828086876552;47902.5209747905;47914.281285780744;48237;48396.27405588919;50337.49662503328;43298;43521.129577408276;43614.78192609017;43947;44082;38152.8092359542;38868.22263554713;39031.02422439405;39267.80366098151;40238.59761402407;7600.239976002355;7708.49894756839;8203.220694034057;8245.95877020611;8323.375746818892;30471.08586742401;30499.390012199186;31290.530642039932;31587.84206078955;31685.20786980344;36224.818875905454;37347.439788402655;38569.421458678706;39240;39287.803560982014;9156.954215228881;9323.487208203615;9814.85277720849;10104.393736375841;10126.93499992535;11106.57736288455;11381.552966111994;11456;11494.885051149382;11829.76340473203;10256.12822910061;10868.782624347627;11005.559777608805;11456.427178641201;11645.534178632759;9892.604295828087;9958.103770660675;10675.199360047873;10760.730981725519;10795.460226988776;10083.344582602107;10207.54066067014;10231.590736370461;10300.587976480856;10475.42385168823;9095.818083638158;9346.719598412059;9425.38734982224;9461.763455913382;9527.38072025316;9113;9446.716598502057;9484.905150948402;9494.28792840526;9546.188573971012 14:49:56 INFO - PROCESS | 6665 | __end_tp_report 14:49:56 INFO - PROCESS | 6665 | __start_cc_report 14:49:56 INFO - PROCESS | 6665 | _x_x_mozilla_cycle_collect,914 14:49:56 INFO - PROCESS | 6665 | __end_cc_report 14:49:56 INFO - PROCESS | 6665 | __startTimestamp1450910996119__endTimestamp 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | ------- Summary: start ------- 14:49:56 INFO - PROCESS | 6665 | Number of tests: 6 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | [#0] dojo.html Cycles:165 Average:4608.28 Median:4705.13 stddev:474.31 (10.1%) stddev-sans-first:449.17 14:49:56 INFO - PROCESS | 6665 | Values: 2611.9 2670.5 2685.8 2686.7 2716.7 4396.9 4531.1 4645.5 4670.9 4687.3 4560.9 4617.0 4647.0 4654.9 4666.1 4283.6 4336.9 4348.9 4415.1 4428.9 4190.5 4340.5 4378.3 4437.9 4468.8 4208.2 4310.5 4311.3 4316.1 4320.0 4333.2 4335.8 4338.6 4344.3 4381.0 4315.3 4316.2 4324.0 4352.5 4359.3 4434.2 4502.5 4554.2 4564.5 4631.0 4986.1 4990.8 5000.1 5008.0 5060.7 5020.9 5040.1 5042.9 5079.5 5080.3 4500.1 4600.8 4604.0 4639.8 4644.5 5225.6 5226.7 5227.2 5229.6 5240.1 4947.5 4966.5 4967.0 4967.5 5012.4 4787.6 4889.9 4898.0 4902.9 5036.9 4757.7 4867.8 4870.0 4871.9 4889.3 4948.6 4965.8 4966.9 4970.8 4976.8 4118.4 4200.7 4211.3 4250.7 4275.5 3631.2 3684.3 3693.5 3706.6 3730.1 4319.5 4320.7 4321.0 4339.3 4357.8 4810.6 4945.0 5061.4 5066.8 5110.6 4173.3 4190.8 4252.0 4254.3 4296.8 4504.3 4506.1 4511.8 4529.0 4544.4 4543.3 4664.7 4803.5 4807.7 4810.6 4860.2 4896.9 4926.7 4959.1 5012.2 4775.7 4777.5 4779.9 4780.5 4822.1 4751.4 4853.5 4940.6 4942.9 4985.0 4970.8 4989.9 5098.3 5105.6 5114.9 4847.5 4851.2 4878.9 4889.7 4899.9 4809.7 4831.4 4844.2 4853.2 4894.9 4604.1 4682.2 4725.4 4726.0 4726.0 4851.5 4853.0 4855.2 4877.6 4903.3 4691.1 4692.0 4693.5 4705.1 4746.8 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | [#1] ext.html Cycles:180 Average:42017.21 Median:34055.07 stddev:65580.68 (192.6%) stddev-sans-first:65690.69 14:49:56 INFO - PROCESS | 6665 | Values: 536.4 538.9 541.5 569.4 572.4 24628.1 36637.8 36661.6 36928.6 37040.4 40482.2 41022.4 41095.2 41125.0 41169.4 6981.3 7100.4 7888.1 8046.8 8058.8 10233.2 10577.7 10579.2 10581.4 10592.4 10142.4 10235.6 10236.6 10239.1 10244.2 7284.5 7487.0 9871.6 10269.7 10661.7 10043.3 10180.6 10186.5 10190.5 10191.7 37414.6 37857.6 37932.2 38018.4 38018.6 2889.0 2931.5 2936.8 3489.0 3562.7 28666.3 28874.7 28892.9 28916.0 30024.5 3487.3 3494.8 3511.8 3576.8 3592.7 218124.0 218675.0 219136.0 220166.0 220307.0 57129.4 57307.0 57524.0 57574.7 57626.0 50872.7 52120.5 66425.0 67936.7 68015.0 13907.6 13908.7 13911.2 14051.3 14088.7 10744.3 10828.2 10830.7 10847.5 10848.5 19316.8 19568.6 19701.0 19704.1 19713.4 7113.3 7250.5 7342.9 7347.7 7417.9 805.0 881.6 891.9 918.9 940.9 25943.9 26554.9 26583.2 26601.5 26602.5 929.2 938.5 944.0 956.9 1061.5 13660.3 13850.6 13868.2 13952.9 14100.6 249465.0 253653.0 255327.0 255574.0 255578.0 47297.0 47322.3 47476.5 47564.3 47667.5 1175.3 1187.4 1201.5 1209.2 1211.1 25120.2 25517.6 25937.9 26348.5 26368.0 41471.4 41682.8 41798.4 41819.0 41871.0 232293.0 235366.0 293822.0 296115.0 324512.0 26759.7 26778.9 27005.0 27337.0 27349.7 36449.8 38657.6 39441.6 40049.4 40374.6 28808.3 31972.2 33320.7 34957.0 36886.8 31923.4 36997.6 38573.4 38747.0 38834.0 34789.5 34852.0 34934.0 35245.6 35305.0 36351.6 36994.4 37414.0 37576.6 37654.0 27850.6 28622.3 29024.6 29084.7 29111.6 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | [#2] jquery.html Cycles:180 Average:24163.95 Median:209823.16 stddev:69673.69 (33.2%) stddev-sans-first:69846.18 14:49:56 INFO - PROCESS | 6665 | Values: 341.6 342.5 343.6 343.7 344.6 12508.2 12938.3 14903.8 14937.1 15588.0 11969.4 14981.8 15413.5 15866.2 15879.5 4901.6 4922.8 5052.2 5090.5 5100.1 3356.4 3427.1 5036.9 5072.3 5162.1 5230.0 5260.4 5262.3 5279.6 5288.8 5240.5 5247.2 5477.6 5720.1 5739.6 5090.4 5093.5 5098.3 5099.4 5103.9 10236.7 11350.4 12109.6 12124.3 12141.0 1675.7 1679.4 1768.1 1800.1 1801.6 9102.1 9138.5 9424.3 9456.6 11013.7 1694.3 1717.3 1725.6 1752.6 1755.3 56274.7 58500.4 58667.1 58867.0 59396.7 9407.5 9532.7 9707.4 9720.6 9740.3 12054.8 12130.1 12140.2 12143.3 12150.6 6859.8 6882.1 6946.3 6947.0 6966.8 6906.9 6916.7 6935.3 6950.9 6967.0 4027.7 4257.3 4274.2 4277.2 4318.6 1670.6 1704.3 1717.3 1780.5 1860.3 764.0 798.8 805.3 822.4 918.8 15257.4 15629.6 15832.8 15857.3 15902.3 809.3 826.4 850.8 915.9 944.4 8034.7 8830.0 8980.3 8983.2 9074.2 413684.0 415389.0 429730.8 434725.0 436196.0 37650.2 68112.3 68397.7 70518.3 72483.3 1044.8 1048.9 1052.5 1065.5 1067.8 14077.2 14212.6 14255.9 14281.4 14383.5 31515.7 31569.0 31896.4 32550.2 32630.8 42953.0 43654.8 43688.1 44182.6 46220.5 8353.7 8560.9 8659.9 8677.3 8680.4 10089.5 10187.4 12638.4 15901.3 16034.8 13144.5 13374.5 13705.4 13795.0 13910.1 12926.7 13202.7 13327.7 13595.3 13809.0 13344.5 13507.5 13697.9 13842.7 14031.9 8463.2 8536.4 8545.3 8807.6 8892.9 9458.7 13525.0 13631.5 13651.8 13800.7 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | [#3] mootools.html Cycles:180 Average:5031.14 Median:6289.35 stddev:2577.63 (41.0%) stddev-sans-first:2567.95 14:49:56 INFO - PROCESS | 6665 | Values: 1103.8 1645.3 1648.6 1690.1 1715.8 6107.9 6834.7 6993.3 7005.3 7017.1 7195.4 7315.9 7331.0 7339.9 7342.0 2105.5 2140.6 2143.5 2145.7 2148.5 2119.4 2140.6 2206.0 2212.5 2226.0 2097.5 2122.1 2134.6 2140.3 2151.7 2135.7 2167.9 2173.2 2174.1 2175.3 2124.4 2160.9 2167.2 2170.2 2170.7 7144.8 7210.1 7231.5 7245.0 7245.0 4300.2 4381.6 4406.1 4410.1 4414.4 2613.1 2648.7 2658.0 2660.9 2662.7 830.8 845.5 846.8 847.5 875.3 9613.6 9632.0 9641.1 9641.2 9643.9 3991.1 3995.4 4053.1 4065.5 4068.2 8394.4 8398.6 8398.6 8409.6 8423.0 4182.7 4232.4 4236.7 4269.4 4270.2 3374.9 3478.9 3862.6 3867.0 3869.2 3509.6 3545.1 3547.6 3564.3 3592.9 1115.1 1123.5 1127.6 1130.6 1136.5 751.1 768.6 941.9 1001.0 1153.4 6703.7 6787.1 6787.3 6792.6 6808.5 1036.6 1044.6 1054.8 1058.3 1084.2 5250.6 5315.2 5322.7 5342.9 5354.5 8258.3 8359.8 8368.7 8372.0 8375.6 8227.8 8329.2 8329.6 8345.2 8347.2 6789.8 6871.1 6953.3 6969.2 6975.8 6756.2 6778.9 6809.1 6818.0 6835.5 7561.1 7806.2 7876.4 7888.3 7906.3 7825.4 7951.5 7999.0 8058.6 8084.1 6244.0 6250.1 6276.1 6302.6 6349.6 6796.9 6856.0 6863.5 6874.6 6881.9 6513.3 6550.7 6574.3 6591.5 6644.8 6423.6 6430.1 6475.9 6513.2 6545.0 6481.3 6499.3 6499.7 6501.2 6504.9 5860.7 5861.3 5882.2 5914.5 5944.8 6036.3 6094.2 6107.0 6120.2 6127.9 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | [#4] prototype.html Cycles:180 Average:4630.85 Median:5263.84 stddev:1352.41 (25.7%) stddev-sans-first:1316.77 14:49:56 INFO - PROCESS | 6665 | Values: 311.4 311.4 311.6 314.1 322.0 5238.5 5325.9 5332.1 5336.0 5348.6 5263.0 5264.7 5279.9 5280.8 5291.9 3926.1 4025.5 4145.5 4149.7 4158.6 4046.3 4122.4 4162.9 4176.2 4181.5 4134.8 4136.7 4146.4 4149.8 4165.1 3927.5 4028.2 4029.3 4131.4 4151.9 3659.1 3672.0 3672.2 3688.6 3693.9 5069.9 5073.2 5082.7 5091.6 5093.4 4740.3 4743.5 4746.3 4746.6 4752.8 5396.3 5531.3 5533.5 5550.0 5558.8 3919.6 3926.1 3927.9 3929.9 3931.4 5822.4 5825.5 5829.5 5834.2 5837.8 4039.5 4044.7 4045.0 4046.1 4047.0 3731.9 3837.4 4087.0 4100.1 4103.5 4438.2 4550.3 4554.7 4602.1 4729.3 5337.5 5557.8 5557.9 5560.3 5561.7 1457.2 1473.6 1477.1 1478.7 1481.9 989.0 1006.7 1021.2 1037.8 1049.5 4849.6 4851.7 4854.2 4859.3 4864.8 5712.9 5717.1 5719.8 5728.0 5732.4 4836.6 4841.7 4846.5 4847.1 4847.2 2962.7 3039.6 3058.6 3063.5 3096.7 5505.9 5517.0 5518.8 5524.4 5526.9 5969.3 5971.0 5973.3 5985.0 5986.4 5371.3 5461.9 5503.7 5507.3 5512.4 5779.5 5804.3 5812.1 5812.8 5812.9 5675.8 5676.6 5677.5 5680.2 5686.4 5510.4 5516.4 5518.8 5520.4 5523.9 3947.9 4017.6 4027.2 4056.2 4063.9 5812.4 5814.4 5816.7 5817.4 5821.9 5587.1 5590.2 5593.7 5597.2 5598.7 5462.9 5591.7 5592.1 5592.9 5605.4 5473.7 5479.0 5479.8 5481.1 5483.3 5632.7 5633.8 5634.1 5636.8 5638.9 5452.6 5452.6 5458.9 5461.2 5462.0 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - PROCESS | 6665 | [#5] yui.html Cycles:180 Average:12072.74 Median:24183.95 stddev:13437.26 (55.6%) stddev-sans-first:13447.58 14:49:56 INFO - PROCESS | 6665 | Values: 653.2 666.5 724.9 731.2 739.2 10757.4 10939.9 10943.9 10945.1 10951.0 11215.4 11515.7 11528.0 11550.9 11551.5 628.8 638.7 776.5 786.2 812.5 804.3 804.8 810.2 811.2 813.0 840.5 849.2 851.5 852.1 852.6 651.4 661.4 819.6 836.0 838.4 620.1 623.2 624.8 625.3 625.5 11860.2 11916.4 11962.3 11979.5 12030.7 10829.0 11520.8 11983.3 11994.3 12411.0 9005.0 9072.2 9188.1 9200.3 9232.5 3219.3 3249.2 3284.2 3311.7 3320.3 39107.8 39200.0 39253.4 39535.2 39667.6 9216.5 9399.2 9426.4 9431.2 9452.4 16739.2 16910.4 16940.4 16961.5 17008.5 6454.9 6487.3 6544.2 6585.3 6750.4 3290.4 3338.5 3341.3 3442.2 3444.0 2699.5 2719.0 2725.9 2727.7 2753.0 489.0 501.0 501.6 505.7 508.7 465.4 500.3 524.3 573.0 584.6 7368.3 7410.2 7479.9 7585.4 7610.2 492.6 547.0 573.5 579.3 595.5 3383.9 3956.6 4108.6 4110.7 4297.8 47902.5 47914.3 48237.0 48396.3 50337.5 43298.0 43521.1 43614.8 43947.0 44082.0 38152.8 38868.2 39031.0 39267.8 40238.6 7600.2 7708.5 8203.2 8246.0 8323.4 30471.1 30499.4 31290.5 31587.8 31685.2 36224.8 37347.4 38569.4 39240.0 39287.8 9157.0 9323.5 9814.9 10104.4 10126.9 11106.6 11381.6 11456.0 11494.9 11829.8 10256.1 10868.8 11005.6 11456.4 11645.5 9892.6 9958.1 10675.2 10760.7 10795.5 10083.3 10207.5 10231.6 10300.6 10475.4 9095.8 9346.7 9425.4 9461.8 9527.4 9113.0 9446.7 9484.9 9494.3 9546.2 14:49:56 INFO - PROCESS | 6665 | -------- Summary: end -------- 14:49:56 INFO - PROCESS | 6665 | 14:49:56 INFO - TEST-INFO | 6665: exit 0 14:49:56 INFO - TEST-OK | dromaeo_css | took 1116893ms 14:49:56 INFO - TEST-START | kraken 14:49:56 INFO - operating with platform_type : linux_ 14:49:56 INFO - Initialising browser for kraken test... 14:49:56 INFO - TEST-INFO | started process 6855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZgqu4f/profile http://localhost:37454/getInfo.html) 14:50:01 INFO - PROCESS | 6855 | __metrics Screen width/height:1600/1200 14:50:01 INFO - PROCESS | 6855 | colorDepth:24 14:50:01 INFO - PROCESS | 6855 | Browser inner width/height: 1024/697 14:50:01 INFO - PROCESS | 6855 | __metrics 14:50:01 INFO - PROCESS | 6855 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:50:01 INFO - PROCESS | 6855 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:50:01 ERROR - PROCESS | 6855 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:50:01 INFO - PROCESS | 6855 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:50:02 INFO - TEST-INFO | 6855: exit 0 14:50:02 INFO - Browser initialized. 14:50:02 INFO - Running cycle 1/1 for kraken test... 14:50:02 INFO - TEST-INFO | started process 6938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZgqu4f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:14 INFO - PROCESS | 6938 | RSS: Main: 148430848 14:50:14 INFO - PROCESS | 6938 | 14:50:16 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37454/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:17 INFO - PROCESS | 6938 | RSS: Main: 184799232 14:50:17 INFO - PROCESS | 6938 | 14:50:20 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37454/tests/kraken/driver.html?testName=audio-dft) 14:50:20 INFO - PROCESS | 6938 | RSS: Main: 173219840 14:50:20 INFO - PROCESS | 6938 | 14:50:23 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37454/tests/kraken/driver.html?testName=audio-fft) 14:50:24 INFO - PROCESS | 6938 | RSS: Main: 158814208 14:50:24 INFO - PROCESS | 6938 | 14:50:26 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37454/tests/kraken/driver.html?testName=audio-oscillator) 14:50:26 INFO - PROCESS | 6938 | RSS: Main: 160079872 14:50:26 INFO - PROCESS | 6938 | 14:50:29 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:29 INFO - PROCESS | 6938 | RSS: Main: 162488320 14:50:29 INFO - PROCESS | 6938 | 14:50:32 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37454/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:33 INFO - PROCESS | 6938 | RSS: Main: 162107392 14:50:33 INFO - PROCESS | 6938 | 14:50:36 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37454/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:37 INFO - PROCESS | 6938 | RSS: Main: 162381824 14:50:37 INFO - PROCESS | 6938 | 14:50:40 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37454/tests/kraken/driver.html?testName=json-parse-financial) 14:50:40 INFO - PROCESS | 6938 | RSS: Main: 163360768 14:50:40 INFO - PROCESS | 6938 | 14:50:42 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:43 INFO - PROCESS | 6938 | RSS: Main: 173649920 14:50:43 INFO - PROCESS | 6938 | 14:50:44 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:45 INFO - PROCESS | 6938 | RSS: Main: 170409984 14:50:45 INFO - PROCESS | 6938 | 14:50:47 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:48 INFO - PROCESS | 6938 | RSS: Main: 183517184 14:50:48 INFO - PROCESS | 6938 | 14:50:50 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:51 INFO - PROCESS | 6938 | RSS: Main: 189689856 14:50:51 INFO - PROCESS | 6938 | 14:50:53 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:54 INFO - PROCESS | 6938 | RSS: Main: 188375040 14:50:54 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:37454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37454/tests/kraken/driver.html?testName=ai-astar) 14:50:56 INFO - PROCESS | 6938 | RSS: Main: 247595008 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | __start_tp_report 14:50:56 INFO - PROCESS | 6938 | _x_x_mozilla_page_load 14:50:56 INFO - PROCESS | 6938 | _x_x_mozilla_page_load_details 14:50:56 INFO - PROCESS | 6938 | |i|pagename|runs| 14:50:56 INFO - PROCESS | 6938 | |0;ai-astar;109;111;105;111;111;112;100;111;111;117 14:50:56 INFO - PROCESS | 6938 | |1;audio-beat-detection;153;132;150;168;131;155;156;131;166;133 14:50:56 INFO - PROCESS | 6938 | |2;audio-dft;160;161;159;158;161;163;163;162;162;160 14:50:56 INFO - PROCESS | 6938 | |3;audio-fft;72;72;81;90;72;72;72;96;91;72 14:50:56 INFO - PROCESS | 6938 | |4;audio-oscillator;95;95;131;94;95;94;133;94;95;126 14:50:56 INFO - PROCESS | 6938 | |5;imaging-gaussian-blur;110;110;109;110;110;110;110;110;109;110 14:50:56 INFO - PROCESS | 6938 | |6;imaging-darkroom;146;146;146;147;146;147;146;146;148;146 14:50:56 INFO - PROCESS | 6938 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 14:50:56 INFO - PROCESS | 6938 | |8;json-parse-financial;71;70;72;71;71;73;71;88;68;69 14:50:56 INFO - PROCESS | 6938 | |9;json-stringify-tinderbox;69;68;68;68;68;68;68;69;68;68 14:50:56 INFO - PROCESS | 6938 | |10;stanford-crypto-aes;82;89;84;89;82;82;82;83;84;84 14:50:56 INFO - PROCESS | 6938 | |11;stanford-crypto-ccm;129;121;118;116;117;121;120;119;119;126 14:50:56 INFO - PROCESS | 6938 | |12;stanford-crypto-pbkdf2;135;149;151;147;145;133;146;145;146;133 14:50:56 INFO - PROCESS | 6938 | |13;stanford-crypto-sha256-iterative;69;71;69;69;71;69;67;69;69;68 14:50:56 INFO - PROCESS | 6938 | __end_tp_report 14:50:56 INFO - PROCESS | 6938 | __start_cc_report 14:50:56 INFO - PROCESS | 6938 | _x_x_mozilla_cycle_collect,993 14:50:56 INFO - PROCESS | 6938 | __end_cc_report 14:50:56 INFO - PROCESS | 6938 | __startTimestamp1450911056357__endTimestamp 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | ------- Summary: start ------- 14:50:56 INFO - PROCESS | 6938 | Number of tests: 14 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:4.52 (4.1%) stddev-sans-first:4.78 14:50:56 INFO - PROCESS | 6938 | Values: 109.0 111.0 105.0 111.0 111.0 112.0 100.0 111.0 111.0 117.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:154.00 stddev:14.62 (9.5%) stddev-sans-first:15.37 14:50:56 INFO - PROCESS | 6938 | Values: 153.0 132.0 150.0 168.0 131.0 155.0 156.0 131.0 166.0 133.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.66 (1.0%) stddev-sans-first:1.73 14:50:56 INFO - PROCESS | 6938 | Values: 160.0 161.0 159.0 158.0 161.0 163.0 163.0 162.0 162.0 160.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#3] audio-fft Cycles:10 Average:79.00 Median:76.50 stddev:9.73 (12.7%) stddev-sans-first:9.98 14:50:56 INFO - PROCESS | 6938 | Values: 72.0 72.0 81.0 90.0 72.0 72.0 72.0 96.0 91.0 72.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.50 stddev:17.20 (18.2%) stddev-sans-first:17.85 14:50:56 INFO - PROCESS | 6938 | Values: 95.0 95.0 131.0 94.0 95.0 94.0 133.0 94.0 95.0 126.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:50:56 INFO - PROCESS | 6938 | Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:50:56 INFO - PROCESS | 6938 | Values: 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 148.0 146.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:50:56 INFO - PROCESS | 6938 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#8] json-parse-financial Cycles:10 Average:72.40 Median:71.00 stddev:5.66 (8.0%) stddev-sans-first:5.98 14:50:56 INFO - PROCESS | 6938 | Values: 71.0 70.0 72.0 71.0 71.0 73.0 71.0 88.0 68.0 69.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 14:50:56 INFO - PROCESS | 6938 | Values: 69.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.73 (3.2%) stddev-sans-first:2.78 14:50:56 INFO - PROCESS | 6938 | Values: 82.0 89.0 84.0 89.0 82.0 82.0 82.0 83.0 84.0 84.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:4.03 (3.3%) stddev-sans-first:2.92 14:50:56 INFO - PROCESS | 6938 | Values: 129.0 121.0 118.0 116.0 117.0 121.0 120.0 119.0 119.0 126.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:146.00 stddev:6.72 (4.6%) stddev-sans-first:6.47 14:50:56 INFO - PROCESS | 6938 | Values: 135.0 149.0 151.0 147.0 145.0 133.0 146.0 145.0 146.0 133.0 14:50:56 INFO - PROCESS | 6938 | 14:50:56 INFO - PROCESS | 6938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 14:50:56 INFO - PROCESS | 6938 | Values: 69.0 71.0 69.0 69.0 71.0 69.0 67.0 69.0 69.0 68.0 14:50:56 INFO - PROCESS | 6938 | -------- Summary: end -------- 14:50:56 INFO - PROCESS | 6938 | 14:50:57 INFO - TEST-INFO | 6938: exit 0 14:50:57 INFO - TEST-OK | kraken | took 60450ms 14:50:57 INFO - TEST-START | v8_7 14:50:57 INFO - operating with platform_type : linux_ 14:50:57 INFO - Initialising browser for v8_7 test... 14:50:57 INFO - TEST-INFO | started process 7186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppkb8ln/profile http://localhost:37454/getInfo.html) 14:51:01 INFO - PROCESS | 7186 | __metrics Screen width/height:1600/1200 14:51:01 INFO - PROCESS | 7186 | colorDepth:24 14:51:01 INFO - PROCESS | 7186 | Browser inner width/height: 1024/697 14:51:01 INFO - PROCESS | 7186 | __metrics 14:51:01 INFO - PROCESS | 7186 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:51:02 INFO - PROCESS | 7186 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:51:02 ERROR - PROCESS | 7186 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:51:02 INFO - TEST-INFO | 7186: exit 0 14:51:02 INFO - Browser initialized. 14:51:02 INFO - Running cycle 1/1 for v8_7 test... 14:51:02 INFO - TEST-INFO | started process 7266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppkb8ln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:14 INFO - PROCESS | 7266 | RSS: Main: 150343680 14:51:14 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | Cycle 1(1): loaded http://localhost:37454/tests/v8_7/run.html (next: http://localhost:37454/tests/v8_7/run.html) 14:51:36 INFO - PROCESS | 7266 | RSS: Main: 451121152 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | __start_tp_report 14:51:36 INFO - PROCESS | 7266 | _x_x_mozilla_page_load 14:51:36 INFO - PROCESS | 7266 | _x_x_mozilla_page_load_details 14:51:36 INFO - PROCESS | 7266 | |i|pagename|runs| 14:51:36 INFO - PROCESS | 7266 | |0;Richards;165.61775422325275 14:51:36 INFO - PROCESS | 7266 | |1;DeltaBlue;186.35855385762207 14:51:36 INFO - PROCESS | 7266 | |2;Encrypt;278.78449958182324 14:51:36 INFO - PROCESS | 7266 | |3;Decrypt;5138.461538461538 14:51:36 INFO - PROCESS | 7266 | |4;RayTrace;1980.1980198019803 14:51:36 INFO - PROCESS | 7266 | |5;Earley;791.1392405063291 14:51:36 INFO - PROCESS | 7266 | |6;Boyer;12083.333333333334 14:51:36 INFO - PROCESS | 7266 | |7;RegExp;26763.157894736843 14:51:36 INFO - PROCESS | 7266 | |8;Splay;619.5786864931846 14:51:36 INFO - PROCESS | 7266 | |9;NavierStokes;4835.748792270531 14:51:36 INFO - PROCESS | 7266 | __end_tp_report 14:51:36 INFO - PROCESS | 7266 | __startTimestamp1450911096610__endTimestamp 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | ------- Summary: start ------- 14:51:36 INFO - PROCESS | 7266 | Number of tests: 10 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 165.6 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#1] DeltaBlue Cycles:1 Average:186.36 Median:186.36 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 186.4 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 278.8 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 5138.5 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 1980.2 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 791.1 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#6] Boyer Cycles:1 Average:12083.33 Median:12083.33 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 12083.3 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 26763.2 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#8] Splay Cycles:1 Average:619.58 Median:619.58 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 619.6 14:51:36 INFO - PROCESS | 7266 | 14:51:36 INFO - PROCESS | 7266 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:51:36 INFO - PROCESS | 7266 | Values: 4835.7 14:51:36 INFO - PROCESS | 7266 | -------- Summary: end -------- 14:51:36 INFO - PROCESS | 7266 | 14:51:37 INFO - TEST-INFO | 7266: exit 0 14:51:37 INFO - TEST-OK | v8_7 | took 40230ms 14:51:37 INFO - SUITE-END | took 1217s 14:51:37 INFO - Completed test suite (00:20:17) 14:51:37 INFO - Working with test: dromaeo_css 14:51:37 INFO - Generating results file: dromaeo_css 14:51:37 INFO - Working with test: kraken 14:51:37 INFO - Generating results file: kraken 14:51:37 INFO - javascript benchmark 14:51:37 INFO - Working with test: v8_7 14:51:37 INFO - Generating results file: v8_7 14:51:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:51:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 14:51:37 INFO - process_Request line: dromaeo_css 6322.93 graph.html#tests=[[72,203,35]] 14:51:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:51:37 INFO - process_Request line: kraken 1511.10 graph.html#tests=[[232,203,35]] 14:51:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:51:37 INFO - process_Request line: v8_7 19803.40 graph.html#tests=[[230,203,35]] 14:51:37 INFO - RETURN: dromaeo_css: 6322.93 14:51:37 INFO - RETURN: kraken: 1511.10 14:51:37 INFO - RETURN: v8_7: 19803.40 14:51:37 INFO - javascript benchmark 14:51:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2611.8694065296736, 2670.452557225769, 2685.825421347612, 2686.7447592478707, 2716.660417447819, 4396.868093957179, 4531.139083574119, 4645.51222121677, 4670.906581868365, 4687.343771871941, 4560.9087818243615, 4617.0, 4646.953530464694, 4654.930176047362, 4666.136764698533, 4283.550227226143, 4336.9349459758205, 4348.869533913988, 4415.072834704716, 4428.889277768049, 4190.455240818689, 4340.544242854502, 4378.321360189176, 4437.889052773674, 4468.8212471501265, 4208.242516347056, 4310.5042920064125, 4311.33174357975, 4316.115196384733, 4319.956800431987, 4333.198358303693, 4335.84824531143, 4338.58783415575, 4344.348347747831, 4381.0, 4315.331123675835, 4316.179925814116, 4324.005478739908, 4352.521222665504, 4359.258925982559, 4434.246178149722, 4502.549745025504, 4554.2485489894125, 4564.520725323827, 4631.027484228282, 4986.10250154972, 4990.775415106329, 5000.0999820032375, 5008.023435430093, 5060.721660308682, 5020.899582008376, 5040.117979353635, 5042.949570504285, 5079.466656001104, 5080.288759573663, 4500.054988452429, 4600.769961501912, 4603.95396046042, 4639.791209395586, 4644.512326205768, 5225.555827754607, 5226.738663066907, 5227.215917612312, 5229.581633469314, 5240.109181439165, 4947.480514545993, 4966.478519755446, 4966.9817687374, 4967.4784147664695, 5012.448630650625, 4787.593054590329, 4889.877753056202, 4897.951020489821, 4902.901941961212, 5036.899262014813, 4757.738324392122, 4867.756612169377, 4869.9513004870205, 4871.878203044952, 4889.266610008527, 4948.62885283598, 4965.751712414365, 4966.900661986812, 4970.826021089245, 4976.825811096594, 4118.382242663624, 4200.663946884242, 4211.347241177622, 4250.659947204216, 4275.508316543575, 3631.1829838286176, 3684.3368193725387, 3693.519842420522, 3706.5737440194184, 3730.1420673245307, 4319.460067491564, 4320.65434765218, 4320.956790432118, 4339.327404252346, 4357.8256869724855, 4810.5670489656095, 4945.0, 5061.44324124346, 5066.771995260148, 5110.591152707774, 4173.311403618369, 4190.790460476964, 4252.043290259667, 4254.298040823292, 4296.82812687489, 4504.34686970394, 4506.076254367847, 4511.774411279423, 4529.0, 4544.409226800495, 4543.341215523797, 4664.650151238603, 4803.519648035239, 4807.711537307633, 4810.59109975649, 4860.198067318853, 4896.90206195867, 4926.704397736147, 4959.132151873336, 5012.248162775612, 4775.6657034007285, 4777.522247775195, 4779.928301075417, 4780.474147843804, 4822.107910036654, 4751.40607424072, 4853.538913803183, 4940.555350018516, 4942.876428089183, 4985.027919555652, 4970.826021089245, 4989.925151122663, 5098.337216161875, 5105.617078719037, 5114.923276150935, 4847.491013443538, 4851.223804191312, 4878.926816097691, 4889.657723959289, 4899.877503062309, 4809.735464549483, 4831.444383895897, 4844.249141383091, 4853.247746599282, 4894.898647804215, 4604.148232576984, 4682.2040253156365, 4725.362076119817, 4726.0, 4726.03116361152, 4851.490593487633, 4853.0, 4855.174620314484, 4877.6341774367775, 4903.33804936329, 4691.108689349013, 4692.0146769178855, 4693.483716791218, 4705.12955103307, 4746.7863946121815], "unit": "score", "name": "dojo.html", "value": 4579.13989886657}, {"lowerIsBetter": false, "replicates": [536.4206656810645, 538.946105389461, 541.4774742373611, 569.3566270114769, 572.4475880775054, 24628.138015169472, 36637.81681091594, 36661.63338366619, 36928.63071369285, 37040.444393334124, 40482.190356192856, 41022.38466422998, 41095.178096438125, 41125.0, 41169.38245926306, 6981.301869813029, 7100.396466300371, 7888.132305446382, 8046.758597242092, 8058.758237252891, 10233.232507561925, 10577.73555661107, 10579.153667706603, 10581.418022008786, 10592.364458132537, 10142.442165680885, 10235.641752538662, 10236.590536378535, 10239.129673977684, 10244.180465562775, 7284.526505777108, 7487.02668653077, 9871.555779989918, 10269.743256418575, 10661.733456663567, 10043.347182433119, 10180.643677471253, 10186.490675466197, 10190.490475476197, 10191.694249172537, 37414.62585374139, 37857.621423785684, 37932.241355172744, 38018.42972355417, 38018.61981380206, 2888.9711102889123, 2931.457680329146, 2936.8384738839354, 3489.005633394496, 3562.7065076856734, 28666.283342916384, 28874.6756114383, 28892.855535722396, 28916.0, 30024.54963175554, 3487.2676737885076, 3494.755367124302, 3511.841967111486, 3576.8032758198287, 3592.7485076044686, 218123.9999999984, 218675.0, 219136.0, 220166.0, 220306.9999999984, 57129.42870571241, 57307.0, 57524.0, 57574.7121264391, 57626.0, 50872.74563627158, 52120.47879521232, 66425.0, 67936.6603166981, 68015.0, 13907.58277251684, 13908.721825563634, 13911.165330080228, 14051.297435128203, 14088.718225635635, 10744.30162039465, 10828.242023058468, 10830.67507974762, 10847.457627118612, 10848.457577121113, 19316.813929443764, 19568.608627827365, 19701.0, 19704.113314900864, 19713.408597741804, 7113.253108423644, 7250.456215783837, 7342.889856652155, 7347.669354879044, 7417.925820741723, 805.0, 881.6032785246665, 891.9241864441595, 918.9294471940249, 940.9200217981411, 25943.870280648476, 26554.867225663747, 26583.202503924913, 26601.467970640864, 26602.46795064088, 929.1823195587839, 938.4791440750313, 943.9669611563562, 956.9473678947725, 1061.506399524225, 13660.316984150753, 13850.584482465541, 13868.167909925436, 13952.930235348758, 14100.576982690536, 249465.0, 253653.0, 255327.0, 255574.0, 255578.0, 47297.0, 47322.290165647544, 47476.5252347479, 47564.28653570199, 47667.523324767004, 1175.3183153770792, 1187.3884949251142, 1201.4893670190133, 1209.1898428053225, 1211.0735287505065, 25120.246392608253, 25517.61723574111, 25937.870310648326, 26348.473030539666, 26368.0, 41471.37792933169, 41682.79158604187, 41798.37302440405, 41819.0, 41870.999999998785, 232293.0, 235366.0, 293822.0, 296115.0, 324512.0, 26759.732402675723, 26778.866105669345, 27005.0, 27337.0, 27349.726502735513, 36449.817750911076, 38657.64698235548, 39441.60558394494, 40049.39925901172, 40374.59625403708, 28808.279793005342, 31972.20069498281, 33320.66679333176, 34957.0, 36886.815565922, 31923.36153276968, 36997.63002369942, 38573.42139867848, 38747.0, 38834.0, 34789.47815782714, 34852.0, 34934.0, 35245.64754352424, 35305.0, 36351.63648363482, 36994.44508332431, 37414.0, 37576.624233758404, 37654.0, 27850.607469626844, 28622.284442889093, 29024.56463153012, 29084.7091529082, 29111.563326550542], "unit": "score", "name": "ext.html", "value": 17669.931446692535}, {"lowerIsBetter": false, "replicates": [341.6463959801606, 342.5409950666107, 343.6237320134452, 343.7267372438911, 344.6484585722563, 12508.186967847083, 12938.288394138319, 14903.776443353345, 14937.10377377358, 15588.0, 11969.401529923512, 14981.775273370908, 15413.5375938722, 15866.2066896655, 15879.52361429159, 4901.583365413944, 4922.827701030465, 5052.24216367546, 5090.490950904898, 5100.056489549426, 3356.3790698720813, 3427.0575591712354, 5036.924446133311, 5072.26452164436, 5162.148245539482, 5230.032443997854, 5260.395054568716, 5262.342207224097, 5279.604029697769, 5288.8413347599635, 5240.502152295526, 5247.1866860636665, 5477.643953143053, 5720.11338242573, 5739.569532285053, 5090.389153301628, 5093.490650934914, 5098.311727916721, 5099.36257967754, 5103.872403189913, 10236.74408139795, 11350.375729334883, 12109.576164834189, 12124.272543647321, 12141.0, 1675.748637704342, 1679.3618424998544, 1768.0629266488781, 1800.0549711401488, 1801.5856353038744, 9102.13529714676, 9138.543072846398, 9424.293178011609, 9456.621735130586, 11013.669589912315, 1694.305334812721, 1717.3302412059306, 1725.568607848038, 1752.5618595351161, 1755.3154269834774, 56274.71862640702, 58500.414995849926, 58667.11999320056, 58867.0, 59396.703016484644, 9407.482588457564, 9532.714018579454, 9707.369021013612, 9720.61117555304, 9740.318177727633, 12054.819177712341, 12130.090243231793, 12140.15018948665, 12143.332116733665, 12150.635480935585, 6859.794206173823, 6882.139732533434, 6946.305369463013, 6946.9652651736415, 6966.756163534252, 6906.896396554056, 6916.723331066701, 6935.306469353024, 6950.860982780316, 6966.9651651741415, 4027.677785777131, 4257.318828987347, 4274.166537525152, 4277.230098582285, 4318.589733975267, 1670.5740036290667, 1704.3267909176054, 1717.3216579451048, 1780.5103596510803, 1860.2744929477515, 764.0334976255042, 798.8242586630931, 805.3396215103676, 822.3667775812711, 918.7519369770125, 15257.389704411698, 15629.60925976837, 15832.76250856238, 15857.30425827612, 15902.284397202153, 809.299955538455, 826.3884725303233, 850.7660393391867, 915.8534634458455, 944.4333399959969, 8034.718784842503, 8829.955850220707, 8980.326475514232, 8983.191512763882, 9074.183323500916, 413684.0, 415389.0, 429730.810767572, 434725.0, 436196.0, 37650.24699505995, 68112.3188768106, 68397.65801171062, 70518.2506543066, 72483.27516724766, 1044.770150566874, 1048.8793788714395, 1052.4527245832278, 1065.4725910674265, 1067.829147336438, 14077.225752583707, 14212.644683882572, 14255.857441425453, 14281.357338919566, 14383.496577620152, 31515.684843152194, 31569.0, 31896.36207275795, 32550.18624534311, 32630.83684581562, 42953.0, 43654.78172609117, 43688.12623747444, 44182.55817441784, 46220.537794621625, 8353.749387518385, 8560.91439085626, 8659.87010194835, 8677.305815534868, 8680.435771674822, 10089.495525223856, 10187.388756674623, 12638.368081596067, 15901.28444220036, 16034.839651603335, 13144.539941102015, 13374.465021399035, 13705.383257753225, 13795.0, 13910.095843770123, 12926.741465170831, 13202.669933251746, 13327.66680832987, 13595.252261125734, 13808.964327675665, 13344.466221351036, 13507.459701612219, 13697.931510342385, 13842.723145536831, 14031.859681403464, 8463.153684631734, 8536.402451828313, 8545.273651739672, 8807.647694092164, 8892.86660700103, 9458.668946586837, 13524.984663571322, 13631.454741810216, 13651.79522307186, 13800.654983625489], "unit": "score", "name": "jquery.html", "value": 8005.908696714158}, {"lowerIsBetter": false, "replicates": [1103.8178700514416, 1645.3418632546984, 1648.6372997940448, 1690.1042447502828, 1715.7597936288919, 6107.877842443154, 6834.692438840258, 6993.335633114859, 7005.334493223142, 7017.122859642544, 7195.424366050716, 7315.8536829263385, 7331.0469638947, 7339.88990165148, 7342.045534080562, 2105.46310690774, 2140.646793279107, 2143.496278374581, 2145.7210562626838, 2148.5380643161716, 2119.448943274752, 2140.561184957088, 2206.007296716476, 2212.4579478027904, 2226.031676220849, 2097.528056187361, 2122.129926730041, 2134.551744133734, 2140.2937030779885, 2151.741790985076, 2135.679648052789, 2167.8590891592, 2173.239366221818, 2174.0868835089223, 2175.3256490487997, 2124.3626911926513, 2160.8703477791382, 2167.1873047607146, 2170.1536400803543, 2170.739511258659, 7144.821379465503, 7210.062691850078, 7231.493795434321, 7245.0, 7245.0219220405625, 4300.204462174508, 4381.605655490989, 4406.0747243078995, 4410.1179764047, 4414.426124603781, 2613.124603257911, 2648.6821581410163, 2658.043104482385, 2660.9467810643873, 2662.6804783426114, 830.8047608811925, 845.4927043773687, 846.834867200896, 847.5084451018456, 875.3303722652176, 9613.567389467491, 9632.0, 9641.084097010773, 9641.180499657466, 9643.90356096437, 3991.082051128257, 3995.380715989026, 4053.1285773558825, 4065.4714887065084, 4068.2066996935314, 8394.370422218359, 8398.580070996548, 8398.622062007102, 8409.621567029377, 8423.031351394546, 4182.707210495236, 4232.428622135973, 4236.703430759817, 4269.380939763717, 4270.188664153801, 3374.915627109293, 3478.913027174341, 3862.633049860259, 3867.013911452618, 3869.2454971280895, 3509.5613048368955, 3545.096000519851, 3547.6452354764315, 3564.2515071835205, 3592.892213233607, 1115.068917453935, 1123.4944275076248, 1127.610974213895, 1130.5703832543581, 1136.494260054268, 751.1474476469247, 768.6080099149474, 941.8775559177263, 1001.019001378653, 1153.400231879418, 6703.664816759143, 6787.083743694538, 6787.321267873272, 6792.592444453348, 6808.523403361816, 1036.6371769880482, 1044.5926088825365, 1054.8206804843196, 1058.3120971368671, 1084.159776173472, 5250.579953603703, 5315.176147697113, 5322.707251101227, 5342.893142137135, 5354.54486368663, 8258.25675689191, 8359.791005224797, 8368.707095251759, 8372.03721572015, 8375.581220938928, 8227.794305142419, 8329.208725171098, 8329.583520824055, 8345.165483451607, 8347.207015333533, 6789.830254243683, 6871.072405225331, 6953.33943275388, 6969.16370035599, 6975.790726278321, 6756.223034350916, 6778.93221067783, 6809.148856392951, 6818.0, 6835.521513494206, 7561.130469996021, 7806.219378062148, 7876.448648594773, 7888.329491993245, 7906.327962123284, 7825.3739700824935, 7951.522908625501, 7999.040115186215, 8058.556779377191, 8084.110747817617, 6244.0, 6250.062490626442, 6276.058591211355, 6302.644931339784, 6349.587276826992, 6796.898046529405, 6856.040154378291, 6863.519553631198, 6874.621895795779, 6881.862362752617, 6513.348665133449, 6550.737970481318, 6574.27682954865, 6591.505637077143, 6644.83387915306, 6423.614583125028, 6430.067640192239, 6475.870482590416, 6513.1532900722605, 6545.0, 6481.319461456667, 6499.285078641251, 6499.675016249074, 6501.219853617407, 6504.934950650433, 5860.677662728591, 5861.267341582302, 5882.23530940975, 5914.497267732291, 5944.762209511571, 6036.305824830025, 6094.177286066501, 6106.992346262995, 6120.234970628671, 6127.877442451215], "unit": "score", "name": "mootools.html", "value": 4138.040355201168}, {"lowerIsBetter": false, "replicates": [311.3694768094608, 311.377245508982, 311.6431685719852, 314.1126318151223, 322.04995263971284, 5238.476152384759, 5325.920111198335, 5332.066888294543, 5336.012837625037, 5348.598855085869, 5263.0263401270795, 5264.657797243177, 5279.894402111955, 5280.788768449267, 5291.947080529194, 3926.096997690533, 4025.476688030552, 4145.523264824538, 4149.7302675326155, 4158.563350848162, 4046.271671099201, 4122.361034039729, 4162.854300099497, 4176.248275310443, 4181.540030596632, 4134.834606615732, 4136.731112477694, 4146.357314616239, 4149.813258403364, 4165.10450253197, 3927.4697915781576, 4028.154087641599, 4029.315016447211, 4131.421600975866, 4151.875443736678, 3659.0669379308374, 3671.963280367189, 3672.155404257036, 3688.5942546319884, 3693.907652308687, 5069.898602027975, 5073.213651883964, 5082.720450375228, 5091.618128640367, 5093.363329583802, 4740.265258884879, 4743.454502732161, 4746.264329029006, 4746.596539294164, 4752.809887604491, 5396.298481197419, 5531.3362396512675, 5533.501984821345, 5550.0, 5558.777648894039, 3919.6276353746634, 3926.11662375966, 3927.8625248116177, 3929.862454814068, 3931.4495970564144, 5822.446867547576, 5825.475707186373, 5829.4753472187285, 5834.241548598655, 5837.795677151322, 4039.4950631171105, 4044.69664775143, 4045.0494133878515, 4046.1300820323772, 4046.979765101156, 3731.869384571527, 3837.3860182370686, 4086.979565102215, 4100.0569868930315, 4103.466549348625, 4438.1567502174485, 4550.317452382103, 4554.749488778083, 4602.05657840142, 4729.266963620645, 5337.5463085637375, 5557.77768889248, 5557.888842223133, 5560.304961879765, 5561.6663000220115, 1457.154850186889, 1473.5579326202096, 1477.0842077911548, 1478.7116512280002, 1481.9481318153812, 989.0055221133248, 1006.6677996261217, 1021.2289721260549, 1037.7613148975627, 1049.5277125293649, 4849.563539281482, 4851.708897466164, 4854.150523658416, 4859.2954021667365, 4864.829730959399, 5712.885742285131, 5717.142428635655, 5719.799807006735, 5728.0, 5732.398098199712, 4836.637252206098, 4841.709497430165, 4846.466888642247, 4847.127517046965, 4847.248676455155, 2962.7333539981505, 3039.5592639067213, 3058.5565093061828, 3063.5098384258413, 3096.7367773739484, 5505.889882202334, 5517.006938751063, 5518.779248830002, 5524.4199359066715, 5526.917096243559, 5969.343372229051, 5971.044632858809, 5973.283206015306, 5984.970075149684, 5986.3714309997695, 5371.301730774974, 5461.890762184734, 5503.697296648643, 5507.284053073075, 5512.366077901012, 5779.450952159538, 5804.2744656917885, 5812.070068788974, 5812.796552120655, 5812.912806307824, 5675.829725108253, 5676.631018983753, 5677.545796336366, 5680.176374425602, 5686.431356864446, 5510.366307874646, 5516.393196748435, 5518.779248830002, 5520.420355862577, 5523.917141242804, 3947.9013024674614, 4017.6384125428854, 4027.154297597537, 4056.2090392374384, 4063.9390409143293, 5812.447817457335, 5814.3604203538425, 5816.680082595498, 5817.447342502455, 5821.912671309849, 5587.0502014656795, 5590.2453168821685, 5593.664380137205, 5597.244372009726, 5598.748056337393, 5462.91805622908, 5591.720413979204, 5592.105263157875, 5592.916106258328, 5605.383407825055, 5473.67157970523, 5479.0, 5479.835604931858, 5481.068218402801, 5483.341998960151, 5632.690202038927, 5633.774649013993, 5634.098544233067, 5636.830895073154, 5638.859028524155, 5452.618316717951, 5452.645578037414, 5458.9454105458435, 5461.15352120422, 5462.0], "unit": "score", "name": "prototype.html", "value": 4203.938100906477}, {"lowerIsBetter": false, "replicates": [653.2324518690539, 666.4601672645158, 724.884018557031, 731.2249016042995, 739.1758189618573, 10757.408342541157, 10939.945300273488, 10943.890561094388, 10945.124390048797, 10951.0, 11215.439228038585, 11515.654530364103, 11528.0, 11550.942245288783, 11551.53793848245, 628.801927392872, 638.6551262318343, 776.510798197135, 786.1509569664763, 812.5043723328765, 804.2560631415946, 804.7907544038563, 810.1979040749645, 811.1888111888112, 812.9796755081111, 840.4957025784541, 849.2272032450471, 851.4635779458963, 852.071242345843, 852.6205838401913, 651.4202359899693, 661.371696887956, 819.6229734322219, 836.021854430318, 838.3670328901701, 620.0791824141147, 623.2209737827716, 624.815679374581, 625.3090335179652, 625.4839757200328, 11860.169788114836, 11916.404179791063, 11962.342071186082, 11979.46092425843, 12030.69923251917, 10829.0, 11520.827187592193, 11983.281003139753, 11994.340311282876, 12411.0, 9005.046576107523, 9072.183503484717, 9188.127127922837, 9200.263978881674, 9232.538373081386, 3219.3078488125166, 3249.1877030742316, 3284.178955261185, 3311.6688331166933, 3320.25294308781, 39107.80446097751, 39200.0, 39253.411198832044, 39535.20929581421, 39667.60332396668, 9216.493092879957, 9399.201067909167, 9426.434413935185, 9431.151196392357, 9452.432854028642, 16739.246733897005, 16910.40813571519, 16940.40708575194, 16961.49115526536, 17008.48974530766, 6454.935450645527, 6487.3188315226225, 6544.181977252843, 6585.341465853472, 6750.35871592198, 3290.3748287825715, 3338.4992251162034, 3341.276933770212, 3442.1566716154703, 3443.9827800860835, 2699.4736026474648, 2718.986405067962, 2725.931851703723, 2727.699953005168, 2752.9587056194173, 489.0290200115783, 500.9874753131201, 501.6488458079359, 505.656153815409, 508.69224119407227, 465.37407187332985, 500.29958058718086, 524.3105316508779, 572.9627574207664, 584.5615788158881, 7368.336849683555, 7410.221926697727, 7479.8504029919095, 7585.393168546503, 7610.1628820829665, 492.59607122159485, 546.9643478693316, 573.5239751006654, 579.3337661689092, 595.5295316699845, 3383.9323213536086, 3956.5647778744315, 4108.568600296926, 4110.712250142521, 4297.828086876552, 47902.5209747905, 47914.281285780744, 48237.0, 48396.27405588919, 50337.49662503328, 43298.0, 43521.129577408276, 43614.78192609017, 43947.0, 44082.0, 38152.8092359542, 38868.22263554713, 39031.02422439405, 39267.80366098151, 40238.59761402407, 7600.239976002355, 7708.49894756839, 8203.220694034057, 8245.95877020611, 8323.375746818892, 30471.08586742401, 30499.390012199186, 31290.530642039932, 31587.84206078955, 31685.20786980344, 36224.818875905454, 37347.439788402655, 38569.421458678706, 39240.0, 39287.803560982014, 9156.954215228881, 9323.487208203615, 9814.85277720849, 10104.393736375841, 10126.93499992535, 11106.57736288455, 11381.552966111994, 11456.0, 11494.885051149382, 11829.76340473203, 10256.12822910061, 10868.782624347627, 11005.559777608805, 11456.427178641201, 11645.534178632759, 9892.604295828087, 9958.103770660675, 10675.199360047873, 10760.730981725519, 10795.460226988776, 10083.344582602107, 10207.54066067014, 10231.590736370461, 10300.587976480856, 10475.42385168823, 9095.818083638158, 9346.719598412059, 9425.38734982224, 9461.763455913382, 9527.38072025316, 9113.0, 9446.716598502057, 9484.905150948402, 9494.28792840526, 9546.188573971012], "unit": "score", "name": "yui.html", "value": 5669.991590677815}], "name": "dromaeo_css", "value": 6322.927594305648}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 111.0, 111.0, 112.0, 100.0, 111.0, 111.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 150.0, 168.0, 131.0, 155.0, 156.0, 131.0, 166.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 158.0, 161.0, 163.0, 163.0, 162.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 90.0, 72.0, 72.0, 72.0, 96.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 95.0, 94.0, 133.0, 94.0, 95.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 71.0, 71.0, 73.0, 71.0, 88.0, 68.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 89.0, 84.0, 89.0, 82.0, 82.0, 82.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 118.0, 116.0, 117.0, 121.0, 120.0, 119.0, 119.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 151.0, 147.0, 145.0, 133.0, 146.0, 145.0, 146.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 69.0, 71.0, 69.0, 67.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1511.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [186.35855385762207], "unit": "score", "name": "DeltaBlue", "value": 354.7891880000001}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12083.333333333334], "unit": "score", "name": "Boyer", "value": 55.155558620689625}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [619.5786864931846], "unit": "score", "name": "Splay", "value": 131.52647400000006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19803.395270110243}]} 14:51:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19803.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1511.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6322.93"}}} 14:51:37 INFO - Return code: 0 14:51:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:51:37 ERROR - # TBPL SUCCESS # 14:51:37 INFO - Running post-action listener: _resource_record_post_action 14:51:37 INFO - Running post-run listener: _resource_record_post_run 14:51:38 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 266240; Write bytes: 317665280; Read time: 76; Write time: 201640 14:51:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1417216; Read time: 0; Write time: 88 14:51:38 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 266240; Write bytes: 316166144; Read time: 76; Write time: 201536 14:51:38 INFO - Running post-run listener: _upload_blobber_files 14:51:38 INFO - Blob upload gear active. 14:51:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:40 INFO - (blobuploader) - INFO - Done attempting. 14:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:41 INFO - (blobuploader) - INFO - Done attempting. 14:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:41 INFO - Return code: 0 14:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0361fd823755bf70a17b3efb0ff6b603c6250812b31108ed5b538f1c5ab9c272b07a2b149cca90fe2fe02e746d9f5d460c3f92ef0d85bfe5dc596824f1cb49e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/07465aee7f45c0e4f8c42ddcda3767d1ff5b068d4e70b438fe2b4c9e264b5cba441be4230e3178d133ab7c218f93d752ba129fc75aefe0c5642ac5d528090912"} 14:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:41 INFO - Contents: 14:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0361fd823755bf70a17b3efb0ff6b603c6250812b31108ed5b538f1c5ab9c272b07a2b149cca90fe2fe02e746d9f5d460c3f92ef0d85bfe5dc596824f1cb49e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/07465aee7f45c0e4f8c42ddcda3767d1ff5b068d4e70b438fe2b4c9e264b5cba441be4230e3178d133ab7c218f93d752ba129fc75aefe0c5642ac5d528090912"} 14:51:41 INFO - Copying logs to upload dir... 14:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.752168 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-23 14:51:41.153850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 14:51:41.157839) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0361fd823755bf70a17b3efb0ff6b603c6250812b31108ed5b538f1c5ab9c272b07a2b149cca90fe2fe02e746d9f5d460c3f92ef0d85bfe5dc596824f1cb49e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/07465aee7f45c0e4f8c42ddcda3767d1ff5b068d4e70b438fe2b4c9e264b5cba441be4230e3178d133ab7c218f93d752ba129fc75aefe0c5642ac5d528090912"} build_url:https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/wQU1E9ARSeC5AOpqvEZ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0361fd823755bf70a17b3efb0ff6b603c6250812b31108ed5b538f1c5ab9c272b07a2b149cca90fe2fe02e746d9f5d460c3f92ef0d85bfe5dc596824f1cb49e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/07465aee7f45c0e4f8c42ddcda3767d1ff5b068d4e70b438fe2b4c9e264b5cba441be4230e3178d133ab7c218f93d752ba129fc75aefe0c5642ac5d528090912"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 14:51:41.187030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:51:41.187386) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450909824.424285-891669067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 14:51:41.271509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 14:51:41.271845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 14:51:41.272248) ========= ========= Total master_lag: 0.25 =========