builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1452098832.51 results: success (0) buildid: 20160106073110 builduid: f26df8ec12944d49b69282da9bb91b37 revision: b9d04e89cb12a9da07c9e8474030c6754d2e3f30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.510322) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.510846) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.511192) ========= 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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005465 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.533867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.534244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.548078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.548432) ========= 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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.598738) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.599255) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.599995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.600323) ========= 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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 08:47:13-- 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% 13.1M=0.001s 2016-01-06 08:47:13 (13.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.383513 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.997219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:12.997609) ========= 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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017949 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.048767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.049174) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b9d04e89cb12a9da07c9e8474030c6754d2e3f30 --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 b9d04e89cb12a9da07c9e8474030c6754d2e3f30 --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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 08:47:14,044 truncating revision to first 12 chars 2016-01-06 08:47:14,044 Setting DEBUG logging. 2016-01-06 08:47:14,044 attempt 1/10 2016-01-06 08:47:14,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b9d04e89cb12?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 08:47:14,572 unpacking tar archive at: b2g-inbound-b9d04e89cb12/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.888736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.889086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.900090) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.900432) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 08:47:13.900906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 08:47:13.901231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --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', '--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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:14 INFO - MultiFileLogger online at 20160106 08:47:14 in /builds/slave/test 08:47:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 08:47:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:14 INFO - {'append_to_log': False, 08:47:14 INFO - 'base_work_dir': '/builds/slave/test', 08:47:14 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 08:47:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:14 INFO - 'branch': 'B2G-Inbound-Non-PGO', 08:47:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:14 INFO - 'config_files': ('talos/linux_config.py',), 08:47:14 INFO - 'default_actions': ('clobber', 08:47:14 INFO - 'read-buildbot-config', 08:47:14 INFO - 'download-and-extract', 08:47:14 INFO - 'populate-webroot', 08:47:14 INFO - 'create-virtualenv', 08:47:14 INFO - 'install', 08:47:14 INFO - 'run-tests'), 08:47:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:14 INFO - 'download_minidump_stackwalk': True, 08:47:14 INFO - 'download_symbols': 'ondemand', 08:47:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:14 INFO - 'installer_path': 'installer.exe', 08:47:14 INFO - 'log_level': 'info', 08:47:14 INFO - 'log_name': 'talos', 08:47:14 INFO - 'log_to_console': True, 08:47:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:14 INFO - 'opt_config_files': (), 08:47:14 INFO - 'pip_index': False, 08:47:14 INFO - 'sps_profile': False, 08:47:14 INFO - 'sps_profile_interval': 0, 08:47:14 INFO - 'suite': 'dromaeojs', 08:47:14 INFO - 'system_bits': '32', 08:47:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:14 INFO - 'title': 'talos-linux64-ix-056', 08:47:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:14 INFO - 'use_talos_json': True, 08:47:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:14 INFO - 'work_dir': 'build'} 08:47:14 INFO - ##### 08:47:14 INFO - ##### Running clobber step. 08:47:14 INFO - ##### 08:47:14 INFO - Running pre-action listener: _resource_record_pre_action 08:47:14 INFO - Running main action method: clobber 08:47:14 INFO - rmtree: /builds/slave/test/build 08:47:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:15 INFO - Running post-action listener: _resource_record_post_action 08:47:15 INFO - ##### 08:47:15 INFO - ##### Running read-buildbot-config step. 08:47:15 INFO - ##### 08:47:15 INFO - Running pre-action listener: _resource_record_pre_action 08:47:15 INFO - Running main action method: read_buildbot_config 08:47:15 INFO - Using buildbot properties: 08:47:15 INFO - { 08:47:15 INFO - "project": "", 08:47:15 INFO - "product": "firefox", 08:47:15 INFO - "script_repo_revision": "production", 08:47:15 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:47:15 INFO - "repository": "", 08:47:15 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 08:47:15 INFO - "buildid": "20160106073110", 08:47:15 INFO - "pgo_build": "False", 08:47:15 INFO - "basedir": "/builds/slave/test", 08:47:15 INFO - "buildnumber": 325, 08:47:15 INFO - "slavename": "talos-linux64-ix-056", 08:47:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:47:15 INFO - "platform": "ubuntu64_hw", 08:47:15 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 08:47:15 INFO - "branch": "b2g-inbound", 08:47:15 INFO - "repo_path": "integration/b2g-inbound", 08:47:15 INFO - "revision": "b9d04e89cb12a9da07c9e8474030c6754d2e3f30", 08:47:15 INFO - "stage_platform": "linux64", 08:47:15 INFO - "builduid": "f26df8ec12944d49b69282da9bb91b37", 08:47:15 INFO - "slavebuilddir": "test" 08:47:15 INFO - } 08:47:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:47:15 INFO - Running post-action listener: _resource_record_post_action 08:47:15 INFO - ##### 08:47:15 INFO - ##### Running download-and-extract step. 08:47:15 INFO - ##### 08:47:15 INFO - Running pre-action listener: _resource_record_pre_action 08:47:15 INFO - Running main action method: download_and_extract 08:47:15 INFO - mkdir: /builds/slave/test/build/tests 08:47:15 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')]} 08:47:15 INFO - https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/test_packages.json 08:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/test_packages.json 08:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:47:16 INFO - Downloaded 1302 bytes. 08:47:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:47:16 INFO - Using the following test package requirements: 08:47:16 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:16 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:16 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'jsshell-linux-x86_64.zip'], 08:47:16 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:16 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:16 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:47:16 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:47:16 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:16 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:16 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:16 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:16 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')]} 08:47:16 INFO - https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:47:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:47:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:17 INFO - Downloaded 22834677 bytes. 08:47:17 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 08:47:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:47:17 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 08:47:18 INFO - Return code: 0 08:47:18 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 08:47: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')]} 08:47:18 INFO - https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:19 INFO - Downloaded 22834677 bytes. 08:47:19 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 08:47:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:47:19 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 08:47:20 INFO - Return code: 0 08:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:20 INFO - https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:21 INFO - Downloaded 11132285 bytes. 08:47:21 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 08:47:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:21 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 08:47:21 INFO - Return code: 0 08:47:21 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')]} 08:47:21 INFO - https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:47:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:47:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:47:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLlEPXkoRAKodq0Cv4V10g/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 08:47:23 INFO - Downloaded 53478928 bytes. 08:47:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:47:23 INFO - mkdir: /builds/slave/test/properties 08:47:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:23 INFO - Contents: 08:47:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:47:23 INFO - Running post-action listener: _resource_record_post_action 08:47:23 INFO - Running post-action listener: set_extra_try_arguments 08:47:23 INFO - ##### 08:47:23 INFO - ##### Running populate-webroot step. 08:47:23 INFO - ##### 08:47:23 INFO - Running pre-action listener: _resource_record_pre_action 08:47:23 INFO - Running main action method: populate_webroot 08:47:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:23 INFO - '--tppagecycles', 08:47:23 INFO - '7'], 08:47:23 INFO - 'tests': ['tsvgm']}}, 08:47:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:47:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:47:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:47:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'tests': ['damp', 'tps']}, 08:47:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['damp', 'tps']}, 08:47:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:47:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:23 INFO - 'other': {'tests': ['a11yr', 08:47:23 INFO - 'ts_paint', 08:47:23 INFO - 'tpaint', 08:47:23 INFO - 'sessionrestore', 08:47:23 INFO - 'sessionrestore_no_auto_restore']}, 08:47:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['a11yr', 08:47:23 INFO - 'ts_paint', 08:47:23 INFO - 'tpaint', 08:47:23 INFO - 'sessionrestore', 08:47:23 INFO - 'sessionrestore_no_auto_restore']}, 08:47:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['a11yr', 08:47:23 INFO - 'ts_paint', 08:47:23 INFO - 'tpaint', 08:47:23 INFO - 'sessionrestore', 08:47:23 INFO - 'sessionrestore_no_auto_restore']}, 08:47:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['a11yr', 08:47:23 INFO - 'ts_paint', 08:47:23 INFO - 'tpaint', 08:47:23 INFO - 'sessionrestore', 08:47:23 INFO - 'sessionrestore_no_auto_restore']}, 08:47:23 INFO - 'other_l64': {'tests': ['a11yr', 08:47:23 INFO - 'ts_paint', 08:47:23 INFO - 'tpaint', 08:47:23 INFO - 'sessionrestore', 08:47:23 INFO - 'sessionrestore_no_auto_restore']}, 08:47:23 INFO - 'other_nol64': {'tests': ['a11yr', 08:47:23 INFO - 'ts_paint', 08:47:23 INFO - 'tpaint', 08:47:23 INFO - 'sessionrestore', 08:47:23 INFO - 'sessionrestore_no_auto_restore']}, 08:47:23 INFO - 'svgr': {'tests': ['tsvgx', 08:47:23 INFO - 'tsvgr_opacity', 08:47:23 INFO - 'tart', 08:47:23 INFO - 'tscrollx', 08:47:23 INFO - 'cart']}, 08:47:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['tsvgx', 08:47:23 INFO - 'tsvgr_opacity', 08:47:23 INFO - 'tart', 08:47:23 INFO - 'tscrollx', 08:47:23 INFO - 'cart']}, 08:47:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'tests': ['tp5o']}, 08:47:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'talos_options': ['--e10s'], 08:47:23 INFO - 'tests': ['tp5o']}, 08:47:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'talos_options': ['--xperf_path', 08:47:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:23 INFO - 'tests': ['tp5n']}, 08:47:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:23 INFO - 'talos_options': ['--e10s', 08:47:23 INFO - '--xperf_path', 08:47:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:23 INFO - 'tests': ['tp5n']}}, 08:47:23 INFO - 'talos.zip': {'path': '', 08:47:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:23 INFO - Running post-action listener: _resource_record_post_action 08:47:23 INFO - ##### 08:47:23 INFO - ##### Running create-virtualenv step. 08:47:23 INFO - ##### 08:47:23 INFO - Running pre-action listener: _resource_record_pre_action 08:47:23 INFO - Running main action method: create_virtualenv 08:47:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:23 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 08:47:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:23 INFO - Using real prefix '/usr' 08:47:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:25 INFO - Installing pip.................done. 08:47:25 INFO - Return code: 0 08:47:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:25 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')]} 08:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:25 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')]} 08:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:25 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:25 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 08:47:25 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 08:47:25 INFO - Using env: {'DISPLAY': ':0', 08:47:25 INFO - 'HOME': '/home/cltbld', 08:47:25 INFO - 'LANG': 'en_US.UTF-8', 08:47:25 INFO - 'LANGUAGE': 'en_US:en', 08:47:25 INFO - 'LOGNAME': 'cltbld', 08:47:25 INFO - 'MAIL': '/var/mail/cltbld', 08:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:25 INFO - 'MOZ_NO_REMOTE': '1', 08:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:25 INFO - 'NO_EM_RESTART': '1', 08:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:25 INFO - 'PWD': '/builds/slave/test', 08:47:25 INFO - 'SHELL': '/bin/bash', 08:47:25 INFO - 'SHLVL': '1', 08:47:25 INFO - 'TERM': 'linux', 08:47:25 INFO - 'TMOUT': '86400', 08:47:25 INFO - 'USER': 'cltbld', 08:47:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:25 INFO - '_': '/tools/buildbot/bin/python'} 08:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:25 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 08:47:25 INFO - Cleaning up... 08:47:25 INFO - Return code: 0 08:47:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:47:25 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')]} 08:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:25 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')]} 08:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:25 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:25 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 08:47:25 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 08:47:25 INFO - Using env: {'DISPLAY': ':0', 08:47:25 INFO - 'HOME': '/home/cltbld', 08:47:25 INFO - 'LANG': 'en_US.UTF-8', 08:47:25 INFO - 'LANGUAGE': 'en_US:en', 08:47:25 INFO - 'LOGNAME': 'cltbld', 08:47:25 INFO - 'MAIL': '/var/mail/cltbld', 08:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:25 INFO - 'MOZ_NO_REMOTE': '1', 08:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:25 INFO - 'NO_EM_RESTART': '1', 08:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:25 INFO - 'PWD': '/builds/slave/test', 08:47:25 INFO - 'SHELL': '/bin/bash', 08:47:25 INFO - 'SHLVL': '1', 08:47:25 INFO - 'TERM': 'linux', 08:47:25 INFO - 'TMOUT': '86400', 08:47:25 INFO - 'USER': 'cltbld', 08:47:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:25 INFO - '_': '/tools/buildbot/bin/python'} 08:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:26 INFO - Downloading/unpacking psutil>=0.7.1 08:47:26 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 08:47:26 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 08:47:26 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 08:47:26 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 08:47:26 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 08:47:26 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 08:47:27 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:47:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:27 INFO - Installing collected packages: psutil 08:47:27 INFO - Running setup.py install for psutil 08:47:27 INFO - building 'psutil._psutil_linux' extension 08:47:27 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 08:47:28 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 08:47:28 INFO - building 'psutil._psutil_posix' extension 08:47:28 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 08:47:28 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 08:47:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:28 INFO - Successfully installed psutil 08:47:28 INFO - Cleaning up... 08:47:28 INFO - Return code: 0 08:47:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:47:28 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')]} 08:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:28 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')]} 08:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:28 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:28 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 08:47:28 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 08:47:28 INFO - Using env: {'DISPLAY': ':0', 08:47:28 INFO - 'HOME': '/home/cltbld', 08:47:28 INFO - 'LANG': 'en_US.UTF-8', 08:47:28 INFO - 'LANGUAGE': 'en_US:en', 08:47:28 INFO - 'LOGNAME': 'cltbld', 08:47:28 INFO - 'MAIL': '/var/mail/cltbld', 08:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:28 INFO - 'MOZ_NO_REMOTE': '1', 08:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:28 INFO - 'NO_EM_RESTART': '1', 08:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:28 INFO - 'PWD': '/builds/slave/test', 08:47:28 INFO - 'SHELL': '/bin/bash', 08:47:28 INFO - 'SHLVL': '1', 08:47:28 INFO - 'TERM': 'linux', 08:47:28 INFO - 'TMOUT': '86400', 08:47:28 INFO - 'USER': 'cltbld', 08:47:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:28 INFO - '_': '/tools/buildbot/bin/python'} 08:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:47:28 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 08:47:28 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 08:47:28 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 08:47:28 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 08:47:28 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 08:47:28 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 08:47:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:47:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:47:30 INFO - Installing collected packages: mozsystemmonitor 08:47:30 INFO - Running setup.py install for mozsystemmonitor 08:47:30 INFO - Successfully installed mozsystemmonitor 08:47:30 INFO - Cleaning up... 08:47:30 INFO - Return code: 0 08:47:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:30 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:30 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 08:47:30 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 08:47:30 INFO - Using env: {'DISPLAY': ':0', 08:47:30 INFO - 'HOME': '/home/cltbld', 08:47:30 INFO - 'LANG': 'en_US.UTF-8', 08:47:30 INFO - 'LANGUAGE': 'en_US:en', 08:47:30 INFO - 'LOGNAME': 'cltbld', 08:47:30 INFO - 'MAIL': '/var/mail/cltbld', 08:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:30 INFO - 'MOZ_NO_REMOTE': '1', 08:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:30 INFO - 'NO_EM_RESTART': '1', 08:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:30 INFO - 'PWD': '/builds/slave/test', 08:47:30 INFO - 'SHELL': '/bin/bash', 08:47:30 INFO - 'SHLVL': '1', 08:47:30 INFO - 'TERM': 'linux', 08:47:30 INFO - 'TMOUT': '86400', 08:47:30 INFO - 'USER': 'cltbld', 08:47:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:30 INFO - '_': '/tools/buildbot/bin/python'} 08:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:30 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 08:47:30 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 08:47:30 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 08:47:30 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 08:47:30 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 08:47:30 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 08:47:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 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 08:47:32 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 08:47:33 INFO - Downloading docopt-0.6.1.tar.gz 08:47:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:33 INFO - Running setup.py install for blobuploader 08:47:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:33 INFO - Running setup.py install for requests 08:47:33 INFO - Running setup.py install for docopt 08:47:33 INFO - Successfully installed blobuploader requests docopt 08:47:33 INFO - Cleaning up... 08:47:33 INFO - Return code: 0 08:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:33 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:33 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 08:47:33 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 08:47:33 INFO - Using env: {'DISPLAY': ':0', 08:47:33 INFO - 'HOME': '/home/cltbld', 08:47:33 INFO - 'LANG': 'en_US.UTF-8', 08:47:33 INFO - 'LANGUAGE': 'en_US:en', 08:47:33 INFO - 'LOGNAME': 'cltbld', 08:47:33 INFO - 'MAIL': '/var/mail/cltbld', 08:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:33 INFO - 'MOZ_NO_REMOTE': '1', 08:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:33 INFO - 'NO_EM_RESTART': '1', 08:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:33 INFO - 'PWD': '/builds/slave/test', 08:47:33 INFO - 'SHELL': '/bin/bash', 08:47:33 INFO - 'SHLVL': '1', 08:47:33 INFO - 'TERM': 'linux', 08:47:33 INFO - 'TMOUT': '86400', 08:47:33 INFO - 'USER': 'cltbld', 08:47:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:33 INFO - '_': '/tools/buildbot/bin/python'} 08:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:34 INFO - Running setup.py (path:/tmp/pip-bCv4PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:34 INFO - Running setup.py (path:/tmp/pip-SLAHkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:34 INFO - Running setup.py (path:/tmp/pip-hEG_fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:34 INFO - Running setup.py (path:/tmp/pip-mnbB2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:34 INFO - Running setup.py (path:/tmp/pip-fZKqEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:34 INFO - Running setup.py (path:/tmp/pip-Esq6Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:34 INFO - Running setup.py (path:/tmp/pip-wpMYRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:34 INFO - Running setup.py (path:/tmp/pip-j07VA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:34 INFO - Running setup.py (path:/tmp/pip-xAVRYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:34 INFO - Running setup.py (path:/tmp/pip-q19_23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:34 INFO - Running setup.py (path:/tmp/pip-BB4Evp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:34 INFO - Running setup.py (path:/tmp/pip-SbdVgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:34 INFO - Running setup.py (path:/tmp/pip-3J0p9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:34 INFO - Running setup.py (path:/tmp/pip-J5XUXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:35 INFO - Running setup.py (path:/tmp/pip-jB5e70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:35 INFO - Running setup.py (path:/tmp/pip-gtTlCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:35 INFO - Running setup.py (path:/tmp/pip-jYVRLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:35 INFO - Running setup.py install for manifestparser 08:47:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:35 INFO - Running setup.py install for mozcrash 08:47:35 INFO - Running setup.py install for mozdebug 08:47:35 INFO - Running setup.py install for mozdevice 08:47:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:35 INFO - Running setup.py install for mozfile 08:47:35 INFO - Running setup.py install for mozhttpd 08:47:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:35 INFO - Running setup.py install for mozinfo 08:47:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:35 INFO - Running setup.py install for mozInstall 08:47:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for mozleak 08:47:36 INFO - Running setup.py install for mozlog 08:47:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for moznetwork 08:47:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for mozprocess 08:47:36 INFO - Running setup.py install for mozprofile 08:47:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for mozrunner 08:47:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for mozscreenshot 08:47:36 INFO - Running setup.py install for moztest 08:47:36 INFO - Running setup.py install for mozversion 08:47:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:37 INFO - Cleaning up... 08:47:37 INFO - Return code: 0 08:47:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:37 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:37 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 08:47:37 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 08:47:37 INFO - Using env: {'DISPLAY': ':0', 08:47:37 INFO - 'HOME': '/home/cltbld', 08:47:37 INFO - 'LANG': 'en_US.UTF-8', 08:47:37 INFO - 'LANGUAGE': 'en_US:en', 08:47:37 INFO - 'LOGNAME': 'cltbld', 08:47:37 INFO - 'MAIL': '/var/mail/cltbld', 08:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:37 INFO - 'MOZ_NO_REMOTE': '1', 08:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:37 INFO - 'NO_EM_RESTART': '1', 08:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:37 INFO - 'PWD': '/builds/slave/test', 08:47:37 INFO - 'SHELL': '/bin/bash', 08:47:37 INFO - 'SHLVL': '1', 08:47:37 INFO - 'TERM': 'linux', 08:47:37 INFO - 'TMOUT': '86400', 08:47:37 INFO - 'USER': 'cltbld', 08:47:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:37 INFO - '_': '/tools/buildbot/bin/python'} 08:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:37 INFO - Running setup.py (path:/tmp/pip-pl7eUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:37 INFO - Running setup.py (path:/tmp/pip-2uQHhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:37 INFO - Running setup.py (path:/tmp/pip-MObv4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:37 INFO - Running setup.py (path:/tmp/pip-9WWTUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:37 INFO - Running setup.py (path:/tmp/pip-tlXalW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:37 INFO - Running setup.py (path:/tmp/pip-lzW0nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:37 INFO - Running setup.py (path:/tmp/pip-eEshyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:37 INFO - Running setup.py (path:/tmp/pip-ptmwAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:37 INFO - Running setup.py (path:/tmp/pip-WkHAxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:37 INFO - Running setup.py (path:/tmp/pip-zXvNCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:37 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)) 08:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:37 INFO - Running setup.py (path:/tmp/pip-_WXoP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:38 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)) 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:38 INFO - Running setup.py (path:/tmp/pip-jCwuBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:38 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)) 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:38 INFO - Running setup.py (path:/tmp/pip-BooJy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:38 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)) 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:38 INFO - Running setup.py (path:/tmp/pip-wMMk8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:38 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)) 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:38 INFO - Running setup.py (path:/tmp/pip-F6pArl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:38 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)) 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:38 INFO - Running setup.py (path:/tmp/pip-nu1SLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:38 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)) 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:38 INFO - Running setup.py (path:/tmp/pip-vs4YnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:38 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)) 08:47:38 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)) 08:47:38 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)) 08:47:38 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)) 08:47:38 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)) 08:47:38 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)) 08:47:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:38 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 08:47:38 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 08:47:38 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 08:47:38 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 08:47:38 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 08:47:38 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 08:47:40 INFO - Downloading blessings-1.5.1.tar.gz 08:47:40 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 08:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:40 INFO - Installing collected packages: blessings 08:47:40 INFO - Running setup.py install for blessings 08:47:40 INFO - Successfully installed blessings 08:47:40 INFO - Cleaning up... 08:47:40 INFO - Return code: 0 08:47:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:40 INFO - Reading from file tmpfile_stdout 08:47:40 INFO - Current package versions: 08:47:40 INFO - argparse == 1.2.1 08:47:40 INFO - blessings == 1.5.1 08:47:40 INFO - blobuploader == 1.2.4 08:47:40 INFO - docopt == 0.6.1 08:47:40 INFO - manifestparser == 1.1 08:47:40 INFO - mozInstall == 1.12 08:47:40 INFO - mozcrash == 0.16 08:47:40 INFO - mozdebug == 0.1 08:47:40 INFO - mozdevice == 0.47 08:47:40 INFO - mozfile == 1.2 08:47:40 INFO - mozhttpd == 0.7 08:47:40 INFO - mozinfo == 0.9 08:47:40 INFO - mozleak == 0.1 08:47:40 INFO - mozlog == 3.1 08:47:40 INFO - moznetwork == 0.27 08:47:40 INFO - mozprocess == 0.22 08:47:40 INFO - mozprofile == 0.28 08:47:40 INFO - mozrunner == 6.11 08:47:40 INFO - mozscreenshot == 0.1 08:47:40 INFO - mozsystemmonitor == 0.0 08:47:40 INFO - moztest == 0.7 08:47:40 INFO - mozversion == 1.4 08:47:40 INFO - psutil == 3.1.1 08:47:40 INFO - requests == 1.2.3 08:47:40 INFO - wsgiref == 0.1.2 08:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:40 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:40 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 08:47:40 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 08:47:40 INFO - Using env: {'DISPLAY': ':0', 08:47:40 INFO - 'HOME': '/home/cltbld', 08:47:40 INFO - 'LANG': 'en_US.UTF-8', 08:47:40 INFO - 'LANGUAGE': 'en_US:en', 08:47:40 INFO - 'LOGNAME': 'cltbld', 08:47:40 INFO - 'MAIL': '/var/mail/cltbld', 08:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:40 INFO - 'MOZ_NO_REMOTE': '1', 08:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:40 INFO - 'NO_EM_RESTART': '1', 08:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:40 INFO - 'PWD': '/builds/slave/test', 08:47:40 INFO - 'SHELL': '/bin/bash', 08:47:40 INFO - 'SHLVL': '1', 08:47:40 INFO - 'TERM': 'linux', 08:47:40 INFO - 'TMOUT': '86400', 08:47:40 INFO - 'USER': 'cltbld', 08:47:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:40 INFO - '_': '/tools/buildbot/bin/python'} 08:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 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)) 08:47:40 INFO - Cleaning up... 08:47:40 INFO - Return code: 0 08:47:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:40 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 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47:40 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 08:47:40 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 08:47:40 INFO - Using env: {'DISPLAY': ':0', 08:47:40 INFO - 'HOME': '/home/cltbld', 08:47:40 INFO - 'LANG': 'en_US.UTF-8', 08:47:40 INFO - 'LANGUAGE': 'en_US:en', 08:47:40 INFO - 'LOGNAME': 'cltbld', 08:47:40 INFO - 'MAIL': '/var/mail/cltbld', 08:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:40 INFO - 'MOZ_NO_REMOTE': '1', 08:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:40 INFO - 'NO_EM_RESTART': '1', 08:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:40 INFO - 'PWD': '/builds/slave/test', 08:47:40 INFO - 'SHELL': '/bin/bash', 08:47:40 INFO - 'SHLVL': '1', 08:47:40 INFO - 'TERM': 'linux', 08:47:40 INFO - 'TMOUT': '86400', 08:47:40 INFO - 'USER': 'cltbld', 08:47:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:40 INFO - '_': '/tools/buildbot/bin/python'} 08:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:41 INFO - Downloading/unpacking jsonschema 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:42 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 08:47:42 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:43 INFO - warning: no files found matching '*.txt' 08:47:43 INFO - no previously-included directories found matching 'build' 08:47:43 INFO - no previously-included directories found matching 'dist' 08:47:43 INFO - no previously-included directories found matching '.git*' 08:47:43 INFO - Installing collected packages: jsonschema, functools32 08:47:43 INFO - Running setup.py install for functools32 08:47:43 INFO - warning: no files found matching '*.txt' 08:47:43 INFO - no previously-included directories found matching 'build' 08:47:43 INFO - no previously-included directories found matching 'dist' 08:47:43 INFO - no previously-included directories found matching '.git*' 08:47:43 INFO - Successfully installed jsonschema functools32 08:47:43 INFO - Cleaning up... 08:47:43 INFO - Return code: 0 08:47:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafbbd23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2096dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, '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': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', '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 08:47: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', 'flake8'] in /builds/slave/test/build 08:47: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 flake8 08:47:43 INFO - Using env: {'DISPLAY': ':0', 08:47:43 INFO - 'HOME': '/home/cltbld', 08:47:43 INFO - 'LANG': 'en_US.UTF-8', 08:47:43 INFO - 'LANGUAGE': 'en_US:en', 08:47:43 INFO - 'LOGNAME': 'cltbld', 08:47:43 INFO - 'MAIL': '/var/mail/cltbld', 08:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:43 INFO - 'MOZ_NO_REMOTE': '1', 08:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:43 INFO - 'NO_EM_RESTART': '1', 08:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:43 INFO - 'PWD': '/builds/slave/test', 08:47:43 INFO - 'SHELL': '/bin/bash', 08:47:43 INFO - 'SHLVL': '1', 08:47:43 INFO - 'TERM': 'linux', 08:47:43 INFO - 'TMOUT': '86400', 08:47:43 INFO - 'USER': 'cltbld', 08:47:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:43 INFO - '_': '/tools/buildbot/bin/python'} 08:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:43 INFO - Downloading/unpacking flake8 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:45 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 08:47:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:45 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 08:47:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:45 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 08:47:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:45 INFO - no previously-included directories found matching 'docs/_build' 08:47:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:46 INFO - Running setup.py install for pep8 08:47:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:46 INFO - no previously-included directories found matching 'docs/_build' 08:47:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:46 INFO - Cleaning up... 08:47:46 INFO - Return code: 0 08:47:46 INFO - Running post-action listener: _resource_record_post_action 08:47:46 INFO - Running post-action listener: _start_resource_monitoring 08:47:46 INFO - Starting resource monitoring. 08:47:46 INFO - ##### 08:47:46 INFO - ##### Running install step. 08:47:46 INFO - ##### 08:47:46 INFO - Running pre-action listener: _resource_record_pre_action 08:47:46 INFO - Running main action method: install 08:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:46 INFO - Reading from file tmpfile_stdout 08:47:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:46 INFO - Reading from file tmpfile_stdout 08:47:46 INFO - Output received: 08:47:46 INFO - Usage: mozinstall [options] installer 08:47:46 INFO - Options: 08:47:46 INFO - -h, --help show this help message and exit 08:47:46 INFO - -d DEST, --destination=DEST 08:47:46 INFO - Directory to install application into. [default: 08:47:46 INFO - "/builds/slave/test"] 08:47:46 INFO - --app=APP Application being installed. [default: firefox] 08:47:46 INFO - mkdir: /builds/slave/test/build/application 08:47:46 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'] 08:47:46 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 08:48:02 INFO - Reading from file tmpfile_stdout 08:48:02 INFO - Output received: 08:48:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:02 INFO - Running post-action listener: _resource_record_post_action 08:48:02 INFO - ##### 08:48:02 INFO - ##### Running run-tests step. 08:48:02 INFO - ##### 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: run_tests 08:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:02 INFO - Python 2.7.3 08:48:02 INFO - Return code: 0 08:48:02 INFO - grabbing minidump binary from tooltool 08:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:02 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 0x21293d0>, '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 0x2094ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2095360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:02 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 08:48:02 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 08:48:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:02 INFO - Return code: 0 08:48:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:48:03 INFO - Return code: 0 08:48:03 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/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 08:48:03 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/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 08:48:03 INFO - Using env: {'DISPLAY': ':0', 08:48:03 INFO - 'HOME': '/home/cltbld', 08:48:03 INFO - 'LANG': 'en_US.UTF-8', 08:48:03 INFO - 'LANGUAGE': 'en_US:en', 08:48:03 INFO - 'LOGNAME': 'cltbld', 08:48:03 INFO - 'MAIL': '/var/mail/cltbld', 08:48:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:03 INFO - 'MOZ_NO_REMOTE': '1', 08:48:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:03 INFO - 'NO_EM_RESTART': '1', 08:48:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:03 INFO - 'PWD': '/builds/slave/test', 08:48:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:03 INFO - 'SHELL': '/bin/bash', 08:48:03 INFO - 'SHLVL': '1', 08:48:03 INFO - 'TERM': 'linux', 08:48:03 INFO - 'TMOUT': '86400', 08:48:03 INFO - 'USER': 'cltbld', 08:48:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856', 08:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:03 INFO - '_': '/tools/buildbot/bin/python'} 08:48:03 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/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 08:48:03 INFO - mozversion application_buildid: 20160106073110 08:48:03 INFO - mozversion application_changeset: b9d04e89cb12a9da07c9e8474030c6754d2e3f30 08:48:03 INFO - mozversion application_display_name: Nightly 08:48:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:03 INFO - mozversion application_name: Firefox 08:48:03 INFO - mozversion application_remotingname: firefox 08:48:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:48:03 INFO - mozversion application_vendor: Mozilla 08:48:03 INFO - mozversion application_version: 46.0a1 08:48:03 INFO - mozversion platform_buildid: 20160106073110 08:48:03 INFO - mozversion platform_changeset: b9d04e89cb12a9da07c9e8474030c6754d2e3f30 08:48:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:48:03 INFO - mozversion platform_version: 46.0a1 08:48:03 INFO - using testdate: 1452098883 08:48:03 INFO - actual date: 1452098883 08:48:03 INFO - starting webserver on 'localhost:41264' 08:48:03 INFO - SUITE-START | Running 3 tests 08:48:03 INFO - TEST-START | dromaeo_css 08:48:03 INFO - operating with platform_type : linux_ 08:48:03 INFO - Initialising browser for dromaeo_css test... 08:48:03 INFO - TEST-INFO | started process 4269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIe5f3_/profile http://localhost:41264/getInfo.html) 08:48:08 INFO - PROCESS | 4269 | __metrics Screen width/height:1600/1200 08:48:08 INFO - PROCESS | 4269 | colorDepth:24 08:48:08 INFO - PROCESS | 4269 | Browser inner width/height: 1024/697 08:48:08 INFO - PROCESS | 4269 | __metrics 08:48:08 INFO - PROCESS | 4269 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:48:08 INFO - PROCESS | 4269 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:09 INFO - TEST-INFO | 4269: exit 0 08:48:09 INFO - Browser initialized. 08:48:09 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:09 INFO - TEST-INFO | started process 4363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIe5f3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:21 INFO - PROCESS | 4363 | RSS: Main: 149950464 08:48:21 INFO - PROCESS | 4363 | 08:49:12 INFO - PROCESS | 4363 | 1452098952355 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] 08:51:24 INFO - PROCESS | 4363 | Cycle 1(1): loaded http://localhost:41264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41264/tests/dromaeo/cssquery-ext.html) 08:51:25 INFO - PROCESS | 4363 | RSS: Main: 253272064 08:51:25 INFO - PROCESS | 4363 | 08:54:28 INFO - PROCESS | 4363 | Cycle 1(1): loaded http://localhost:41264/tests/dromaeo/cssquery-ext.html (next: http://localhost:41264/tests/dromaeo/cssquery-jquery.html) 08:54:28 INFO - PROCESS | 4363 | RSS: Main: 235282432 08:54:28 INFO - PROCESS | 4363 | 08:57:30 INFO - PROCESS | 4363 | Cycle 1(1): loaded http://localhost:41264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41264/tests/dromaeo/cssquery-mootools.html) 08:57:31 INFO - PROCESS | 4363 | RSS: Main: 225669120 08:57:31 INFO - PROCESS | 4363 | 09:00:33 INFO - PROCESS | 4363 | Cycle 1(1): loaded http://localhost:41264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41264/tests/dromaeo/cssquery-prototype.html) 09:00:34 INFO - PROCESS | 4363 | RSS: Main: 212332544 09:00:34 INFO - PROCESS | 4363 | 09:03:36 INFO - PROCESS | 4363 | Cycle 1(1): loaded http://localhost:41264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41264/tests/dromaeo/cssquery-yui.html) 09:03:37 INFO - PROCESS | 4363 | RSS: Main: 214433792 09:03:37 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | Cycle 1(1): loaded http://localhost:41264/tests/dromaeo/cssquery-yui.html (next: http://localhost:41264/tests/dromaeo/cssquery-dojo.html) 09:06:40 INFO - PROCESS | 4363 | RSS: Main: 239464448 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | __start_tp_report 09:06:40 INFO - PROCESS | 4363 | _x_x_mozilla_page_load 09:06:40 INFO - PROCESS | 4363 | _x_x_mozilla_page_load_details 09:06:40 INFO - PROCESS | 4363 | |i|pagename|runs| 09:06:40 INFO - PROCESS | 4363 | |0;dojo.html;2580.954473721009;2684.463107378522;2692.2730862667067;2701.702812690605;2714.484247992882;4417.204903117437;4559.658025648081;4650.697704649196;4656.743879086649;4665.650076244283;4547.999440123176;4629.143608432442;4640.1879671057595;4729.834455794048;4777.498362671921;4264.083222107254;4289.1636130954475;4303.117860838521;4326.913461730764;4345.565443455661;4354.346847972798;4384.824607015731;4400.031992961543;4400.339949007643;4443.400140980959;4193.601607847249;4194.245035893553;4273.722208056466;4278.443802305712;4359.716618419824;4302.2471067563365;4310.956890431087;4317.633001194902;4343.413639158704;4348.543402942677;4280.229558679436;4299.570042995675;4303.892402689958;4317.76252306123;4334.739915605074;4385.144896745136;4512.751798651073;4518.073794872043;4573.771311434448;4648.418947631546;4809.7114173149375;4814.7351895645725;4819.373481447425;4820.8071677132875;4828.517148285144;4841.564259216688;4843.07981483517;4846.39420072491;4848.490908454597;4858.514148585148;4631.4673812511655;4692.0381321828945;4743.905121897543;4745.786439610226;4750.976245118822;5109.4379618241965;5128.948710512922;5143.948560514422;5150.871228219249;5187.2478490619405;4713.080949214938;4877.609791216694;4942.4316203637045;4946.233333833262;4955.603551715854;4904.730239836843;4914.066327397783;5013.699178049329;5071.340725705709;5133.7689803958165;4907.975460122677;4911.975440122848;4914.729689867092;4917.164082106051;4964.379452568429;4732.1245569569055;4895.902081958341;4911;4911.631627627942;4940.184869496565;4119.855805046869;4121;4139.068709540329;4218.114196018871;4260.147970405931;3667.6332366763645;3685.981570092132;3690.095926498025;3716.832742526593;3722.6091260417265;4329.978350108229;4344.56554344563;4346.304591265382;4357.4988876279;4368.6068253856665;4822.373091498082;4936.481669424658;4938.876528086755;4945.282933974553;4947.035328110984;4295.699301048959;4348.760818154969;4348.93476597845;4357.041450880801;4396.516383197845;4489.079738653633;4497.123061003073;4508;4537.500874903758;4544.659150563721;4637.1421287062;4747.738874361943;4781.713097214179;4792.353032340659;4792.904141917142;4886.780094895667;5030.673006254582;5085.821996230115;5091.87270318245;5111.156659151198;4804.543568361;4823.131836269506;4830.589399901048;4839.540243676845;4867.829625963074;4702.694324868872;4791.47293797689;4979.800807967786;5001.949980500149;5048.318477005704;4918.0901533216465;4926.58124059459;4965.726885021359;4978.377702787152;5045.369328833895;4833.081714474239;4844.8788780279365;4865.051314993542;4865.343178670834;4901.240307752304;4644.5123262056995;4751.61987041029;4820.3492528509605;4860.6111511079735;4883.853484395474;4673.252279635242;4682.765861706969;4716.457607375196;4749.762511874462;4817.855464336076;4847.757612119451;4865.270209468608;4865.9026819464125;4867.342908707279;4913.77887995034;4541.159885421208;4671.509491503479;4738.289256611536;4741;4786.994731106367 09:06:40 INFO - PROCESS | 4363 | |1;ext.html;492.95809856162225;522.3575002746624;528.3659608469837;528.7620570743165;541.4423144161514;24584.508309833793;32854.34291314172;33186;33238.833805831;33285;35556.2888742225;36004.819975900085;36012.459813102825;36025.459618105684;36025.459618105684;6797.796066118024;6889.7588584399555;7536.510126841751;7656.770296891103;7716.421268404864;9644.18024467921;9879.209663226924;9884.505774711235;9891.752706182368;9905.2571057171;9603.039696030375;9721.222302215841;9721.416714997087;9726.513674316291;9733.124018838304;9380.859287110665;9474.857877131848;9476.241900647932;9477.668281610146;9479.90520094804;9656.27577931658;9808.509574521246;9815.116639502408;9825.263105267133;9840.901590984071;35872;36201;36434.45348319777;36442.45336319957;36462;2902.8983985560617;2960.15635543869;2985.477541430241;3020.1845501714633;3533.611302756695;27274;27506;27510.862445687842;28075.719242807514;28763;3261.8532166052582;3283.3597448497553;3289.19414743387;3303.6861498157637;3402.387570237356;215781;219129;219250;219305;219383;45894.082118357444;46669;47079.29381059287;47699.1840652747;56461.43538564644;55189.1721624176;55287;55335.44664553383;55452.72273638606;55775.16337254945;11946.641600751991;11996.940015299868;12035.097367697457;12061.457234424472;12064.396780161132;9287.62849486013;9346.252299815998;9348.906510934803;9358.01740817218;9432.103950124727;19253.22987080501;19322;19333.709994350094;19405.708914366296;19471.221151154077;7557.4331925105835;7759.568302188491;7765.339946104645;7860.882086768703;7916.08964969036;799.152897928198;881.3654168998311;926.9536523173814;960.7934294126796;998.4957596413765;25634.615480767803;25806.612900806504;25826.35434114162;26064.869675651502;26115.477690446085;940.9059094090536;946.3044662173297;951.8905325887473;962.7208109648263;1058.952347144365;13522.864771352357;13695.246761428218;13782.104163229358;13819.723605527834;13887.79168312476;257541;261723;262750;262776;263071;43965.78017109894;44568;44644.77677611656;44683.329750053774;44719;1191.0709646475764;1196.0670676872053;1205.7528206717777;1211.9697007574882;1214.8117041858527;24714.382140445912;25451;25794.226173214833;25860.35349116287;26057.739422605533;39606.603933960294;39997;40240.59759402368;40335.79832100821;40383.59616403798;237551;243150;324481;332342;333840;29318.56022159712;29319.267018324714;29472.55791163177;29492.55761163627;29494.557581636724;37850.810745946095;38824.223515530095;39280.80359598298;39309.80345098256;39317.2136557273;33717.83141084279;35658.82170589131;35841.28317433689;36154.63845361618;36735.63264367322;29948.550771738875;30273.24316892095;30416.391672166876;30452.39095218039;30609;29547.85226073856;30271.394572108875;30452.238694032825;30473.54289685701;30483.69516304897;27058.45883082288;28032.43935121327;28057.29856753516;28179.859100704365;29881.70118298789;23023.88488057549;23301.029014003136;23361.53276934418;23419.414514636588;23535.41161470977 09:06:40 INFO - PROCESS | 4363 | |2;jquery.html;310.95335699645034;324.4597744754983;326.1601376455626;330.36075194498653;331.711411072367;11944.64166075017;12370.938145309261;14938.850611493895;15247.0851748895;15310.693786124271;12138.939305303484;14852.405903763836;15606.531804045868;16102.5974350641;16129.758053629204;4853.8058477661025;4909.263610458424;4979.676321039121;4987.775550100236;5039.949600504003;3523.982380088096;3652.543432070991;4941.530554597308;4969.453360130401;5027.974860125694;5117.360329958755;5137.845864624067;5149.588032957373;5168.198929165986;5179.430262671103;5126.359205099363;5132.794688212467;5343.290147152913;5684.8863022739315;5703.7148142592705;4990.426100998396;5035.0685123252315;5049.84850454487;5050.015247026831;5060.645754797166;10850.403227822466;15955.361785528565;17909.462716118538;18964.81035189658;18969.146388412417;1755.0961254953709;1794.8205179482077;1801.0994502748626;1806.494181629146;1825.0509734937891;8497.362697797627;8636.740897773077;11163.274387164809;11711.7072073198;11874.931256186985;1618.7248167811501;1676.2540669402122;1688.1559220389804;1765.7174852023616;1781.7060185069447;54550;55760.72119639376;56706.149407758916;57028;58056;9208.079192080739;9346.57940392684;9361.689363489117;9388.155066044088;9498.667546635834;11961.820572691417;12005.519779208735;12038.638840834614;12058.276503409648;12133.150679452354;6587.341265873374;6680;6819.318068193141;6844.2129155147795;6921.342472465108;6574.276829548746;6609.636469994197;6674.132362792806;6686.5653732507235;6698.12924319845;3911.941320880189;3960.0226287007654;3986.1031267965054;3997.2405243003736;4033.1328764315813;1555.6810853774948;1604.5587463447646;1611.2588209423561;1616.5231256779277;1692.9492115236562;803.8874557561946;824.789678631945;835.0480452284401;874.5190145419994;916.5050872528893;14005.579832605039;14622.63443413902;14785.704285914222;14830.33263503145;14910.627234319012;780.4185881518305;798.269583331257;818.2717381530442;837.1670188162817;842.0190478092953;6896.586204827727;8694.347923905605;8914.509701966454;9343.205827504602;9359.719208423621;306853;311424;312436;314031;347618;72576.63711681408;73423.63288183631;73826.26173738301;74482.6275868628;74525.62737186279;1081.8377243413393;1088.0262165362115;1089.72212085916;1109.1016276815644;1112.0991996482874;14170.929145354206;14271.14373137615;14370.425182992982;14434.783478248044;14635.414583416545;32403;32937;33246.16884577905;33404;34349.14127146841;41939;43388.783056085784;44107.338389923534;44863;48061.5193848057;7632;8057.476264042818;8296.170382961656;8543.359248056546;8559.315254779727;9401.10689484498;10064.446455444728;13878.236696981763;15385.230738463257;15511.612209694847;10127.139193168663;11080.667579972614;12314;13472.393742281425;13478.393472293574;12566.874331256571;12691.238525688488;13032.152910060815;13065.608031759062;13162.868371316546;9975.750606234902;11972.64082077539;13032.283224422748;13362;13479.123856949267;8709.520976346363;8718.520481373585;8741.956290218508;8742.781430464289;8756.080611535697;12624.684382890502;12636.747265054832;12916.289604071866;13039.804402934153;13993.440262389391 09:06:40 INFO - PROCESS | 4363 | |3;mootools.html;1270.8030255310418;1393.8745512903838;1418.5531557559368;1537.4849425442476;1730.0657644871762;5922.170896074547;6112.938870611298;6356.237251529811;6471;6477.319881412454;6443.645599492026;6471.9352806471925;6500.089987401768;6513.446357059644;6528.020796880471;1684.7978242610843;1717.2015013018943;1988.9502762430945;2022.7977202279728;2023.2109477303864;1980.4949737816837;2015.1234213117268;2015.2946468735972;2016.6067616814653;2016.6672499037716;1967.3409407848387;1988.7315212446279;1997.3907958072782;2012.154894944127;2012.537116463207;2007.8393728501685;2019.4042757386605;2046.9181232750745;2049.8770073795545;2052.035543294649;2063.6285468615642;2064.6283668939586;2080.2303147835246;2084.1038353507984;2088.9164433422643;6741.258461569223;6815.829604259933;6818.454523638097;6820.556663816836;6825.863482730318;4018.517777866675;4064.593540645941;4072.75563466193;4072.8370865165357;4082.5305089914445;2568.1910198287665;2620.973790262092;2628.5925681519393;2630.0663264541004;2645.9867700661566;787.5943888897223;795.1213908630938;815.3477218225455;816.5386556595505;819.1562690428808;8913.153250441197;8927.330450216195;8934.687285945025;8958.776030599221;8987.730368088967;3506.6094065092943;3524.101354154674;3567.7680950738118;3587.3722098632634;3642.0530662028063;7759.262870027338;7763.146053934062;7776.261255180749;7782.143964163937;7802.219778022152;4009.1781184857036;4034.5158580969883;4039.7374170678813;4042.110735638155;4044.130511939888;3664.0839790052487;3676.0442285005556;3678.264347130531;3702.5742039665784;3708.313961917;2899.130260921715;2924.502834518137;3177.1421716136974;3260.6739326067677;3303.1576947878616;997.7356000659686;1006.8389057750725;1009.1876039787894;1014.2849291249652;1018.3482571154467;854.0647990450447;860.9526476043752;862.1680078724062;862.7929296968682;930.7161315798611;6375.6174629522375;6423.807285781434;6425.518086143558;6427.357264273535;6441.227052753699;1021.0759262867117;1029.156092004549;1036.4558606731525;1050.165118730611;1064.984025239622;4887;4908.730019848871;4917.803287868517;4918;4920.4095508538485;7580.469367144247;7661.923380766232;7843.37253019757;7975.521468711896;7977.720779772796;7677.424193185533;7684.923150768421;7687.461877668509;7701.191374905554;7702.422318326036;6265.65538895356;6351.364863513611;6358.904616430757;6400.3599640036555;6410.583312084699;6342.841428964312;6484.643344616092;6520.608763474017;6521.478281737354;6524.347565243438;7160.534565253241;7173.175084865307;7268.491205615556;7372.926270737224;7401.407887369105;7066.187388450394;7233.0597022386755;7283.781486555412;7364.189939106801;7459.589722565094;6044.335123136363;6075.969620151871;6082.695865206633;6137.570370074231;6155.0459678748075;5652.943470565407;5783.94216057834;6208.192934918432;6708.19501659804;6756.69594868242;6038.607490513103;6046.9697651513225;6071.362506936708;6088.299845517645;6100.908486372619;5926.555508336978;5943.613665111754;5978.372270911492;5978.8206353809455;6070.969645151746;6152.907706384497;6224.097505861534;6242.531810114168;6256.280527739368;6256.593321434092;5714;5845.941540584539;5856;5867.119932010232;5873.765049397976;5878.265216847894;5915.349311575809;5972.283326000734;5984.790532331347;5986.102084687332 09:06:40 INFO - PROCESS | 4363 | |4;prototype.html;283.65819187878606;285.16731145056434;288.41883604536855;291.1019504827607;292.7219141815275;4946.307516947631;5166.922496162551;5370.301860758101;5370.43610420906;5456.7544460499275;5277.762500687469;5368.248445217672;5372.9462705372935;5385.542228910547;5386.326709161355;4176.415301857743;4179.623833854953;4182.414461975311;4184.560621134783;4187.769672668002;3909.042284640253;3980.741251818637;4022.557518672944;4179.6447301979215;4181.498220213579;4040.070783719746;4046.4132700758373;4050.6961977851633;4088.3049881520215;4111.48606424197;4078;4092.976755811047;4093.385992101179;4097.508299004124;4110.445089912853;3589.407747721649;3590;3594.6764791168657;3594.712423006153;3595.6044835068124;5008.173651347523;5128.794848206067;5136.922946155811;5142.100132476801;5143.382794064699;4676.929846052312;4681.695689780154;4684.578387945101;4685.859424217245;4689.038747056845;5596.972015139939;5600.131979543177;5602.327720673505;5603.075492543766;5603.915941260884;3677.9080522987138;3748.3627783276906;3796.088938654703;3870.264649716573;3874.8256328465286;5865.149553314788;5871.266091738533;5896.439838215363;5911.408859114097;5917.230760001173;3928.3125453045604;3951.762894226298;3954.2486927483687;3965.40518922164;3970.68234541236;4019.517657881073;4019.618136277049;4025.516937967404;4029.093453972833;4040.373742069984;4563.309487765549;4596.977015114903;4634.37435946143;4647.34937108805;4658.161530924466;5600;5601.243832082698;5602.2717046783655;5602.635828671123;5608.270924779753;1384.8892088632886;1427.800107984883;1432.7206194791916;1433.5341014170435;1434.619825746178;926.5645146781002;936.2182577547824;966.3960024984385;992.2161492421051;993.5777294649745;4957.652964292465;4982.078315511642;4983.551480366785;4986.950130498722;5018.397792264878;5844.620099693507;5847.502962248172;5848.239728835224;5853.619514731528;5859.912101318484;4968.826091086795;4970.254461830682;4974.0051989602225;4979.701217926936;4979.925301120486;3053.6793636668276;3116.6104236970377;3149.6692847251165;3151.0389331253728;3154.4322022035794;5549.972250138723;5588.720563971785;5615.466530679579;5616.241807355955;5618.831435056954;6059.515238780975;6065.090236464477;6069.393060693984;6071.2714474263375;6071.332153463116;5580.748866301026;5593.468620481048;5593.580481463907;5607.52336051432;5617.859553511195;5680.68756218412;5875.853103672443;5891.381404952418;5907.232059832194;5915.822525324075;5413.512783849473;5637.520810731134;5758.798442054675;5770.278715160605;5772;5424.321959755031;5497.36780270274;5507.201455788968;5579.497845193952;5579.832605021856;3817.751846129993;3867.43922131295;3882.96117038826;3905.9609403905597;3916.8824935251987;5815.505682017076;5838.912416313844;5844.853878652898;5852.297724273115;5855.180274761622;5430.647007944471;5598.188262701967;5643.294588176478;5649;5655.151727240782;5611.6352437091455;5642.379338272869;5644.266245388073;5647.576431767552;5649.20911072442;5521.254630624975;5534.944650553443;5540.36285827135;5548.0013597552825;5566.582506312124;5562.860928476821;5704.172894930295;5705.515031222392;5711.029694755302;5712.6286791358425;5561.694106824163;5565.471280228372;5568.415316391883;5568.443155684399;5568.582356323373 09:06:40 INFO - PROCESS | 4363 | |5;yui.html;644.378175061066;722.2741145149126;730.390124246254;765.3685709289836;823.6170180865896;10955.726106847333;11178.16163787715;11193.10455163587;11207.887921120806;11221.214514983943;11173.888261117387;11728.53085876564;11787;11811.11416643753;11813.054955603553;790.2571582712261;794.2057942057942;800.3277247112425;803.04036676172;806.3992325717348;788.538704857659;794.6026986506747;796.4623878881761;797.1510341486298;797.2904115337326;836.3810780022769;846.8941382327209;847.4237518487427;847.4533925617973;847.6100993542977;834.3575446905879;836.9790755231107;838.2748922182329;839.5969934431507;840.1010918317403;617.6232498176109;618.0358640520802;619.102301662591;619.6715740657459;619.6963487890946;10546.894531054668;10633;10686;10700.625478108306;10700.839487407695;8996.235319997808;9315.347925645208;9412.670556530556;9454.05459454056;9454.149126578572;8745.693900713444;8870.689525866628;8875;8903.28773698109;8904.51025193614;2937.720916512928;2946.602208701819;2976.255936015996;3022.07826612883;3023.546468029791;34029.31941361184;34485.13787155316;38298;38595.807020964996;38782.80608596967;7690.577018263937;8994.730158095268;9064.773380665536;9186.219171370374;9300.767480813034;16203.83796162047;16762.58093547671;16870;16881.493555193363;16895.83104168967;6155.261368635703;6257.5932564383165;6460.644664543402;6470.38531339522;6508.414242718178;3387.4410722230555;3500.1949551602765;3505.1237190702323;3522.295540891832;3583.258950709104;2597.948041039169;2648.9205323840315;2651;2654.9601755973677;2665.4002849359126;451.2621863253604;455.6605329029894;456.18798538601345;457.86906341336845;460.9792559334838;400.3714168755027;422.53943201909453;434.49815463140123;448.56937340153166;576.4840467781312;7212.927870721331;7408.2591740826565;7418.517796343221;8110.83778324442;8481.491110533389;409.4002286650072;560.3751816724323;574.9511291540182;604.3865476541314;605.3764622438895;3353.5808023997;3459.8443070061403;3494.178867966026;3533.876314328986;3574.696150827209;45719.77140114278;51433.742831286356;51756.22365664518;51857.2221416679;52022.21966670503;39556.80221598931;39592;40014;40092.59907400947;40264.194716105514;33203.335933281196;34092.48861267083;38598.61401386006;38935.415968759924;39096.21807563776;7484.401247900046;7926.207379262028;7969.561674107979;8185.672573097009;8273.379496537904;29997.250068748457;31111.222219444695;31692.683073168973;31953.201169970936;32007.839960800047;36983.63016369802;38571.614283856805;38673.80663096779;40705.79647101746;41019;9435.292353073684;9937.950310248403;10036.247281454067;10063.89936100659;10119.848202276824;10347.43089130075;10477.423741693976;11156.386398748147;11491;11493.655190344303;10045.296829222176;10175.880653128002;10357.792844143225;10892.40091794959;11587.652370428901;10162.898371016196;10181.440020798927;10202.234832387452;10496.947515262375;11113.611023614134;10155.390676559135;10180.847287290844;10218.284720069523;10874.836877447004;10893.346399216072;9302.720918372459;9388.624455021723;9501.382410143318;9572.234221262142;9690.030996900254;8859;9190.908090919273;9197.54012299369;9258.213051890665;9338.653029142455 09:06:40 INFO - PROCESS | 4363 | __end_tp_report 09:06:40 INFO - PROCESS | 4363 | __start_cc_report 09:06:40 INFO - PROCESS | 4363 | _x_x_mozilla_cycle_collect,955 09:06:40 INFO - PROCESS | 4363 | __end_cc_report 09:06:40 INFO - PROCESS | 4363 | __startTimestamp1452100000284__endTimestamp 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | ------- Summary: start ------- 09:06:40 INFO - PROCESS | 4363 | Number of tests: 6 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | [#0] dojo.html Cycles:165 Average:4597.49 Median:4741.00 stddev:462.63 (9.8%) stddev-sans-first:436.16 09:06:40 INFO - PROCESS | 4363 | Values: 2581.0 2684.5 2692.3 2701.7 2714.5 4417.2 4559.7 4650.7 4656.7 4665.7 4548.0 4629.1 4640.2 4729.8 4777.5 4264.1 4289.2 4303.1 4326.9 4345.6 4354.3 4384.8 4400.0 4400.3 4443.4 4193.6 4194.2 4273.7 4278.4 4359.7 4302.2 4311.0 4317.6 4343.4 4348.5 4280.2 4299.6 4303.9 4317.8 4334.7 4385.1 4512.8 4518.1 4573.8 4648.4 4809.7 4814.7 4819.4 4820.8 4828.5 4841.6 4843.1 4846.4 4848.5 4858.5 4631.5 4692.0 4743.9 4745.8 4751.0 5109.4 5128.9 5143.9 5150.9 5187.2 4713.1 4877.6 4942.4 4946.2 4955.6 4904.7 4914.1 5013.7 5071.3 5133.8 4908.0 4912.0 4914.7 4917.2 4964.4 4732.1 4895.9 4911.0 4911.6 4940.2 4119.9 4121.0 4139.1 4218.1 4260.1 3667.6 3686.0 3690.1 3716.8 3722.6 4330.0 4344.6 4346.3 4357.5 4368.6 4822.4 4936.5 4938.9 4945.3 4947.0 4295.7 4348.8 4348.9 4357.0 4396.5 4489.1 4497.1 4508.0 4537.5 4544.7 4637.1 4747.7 4781.7 4792.4 4792.9 4886.8 5030.7 5085.8 5091.9 5111.2 4804.5 4823.1 4830.6 4839.5 4867.8 4702.7 4791.5 4979.8 5001.9 5048.3 4918.1 4926.6 4965.7 4978.4 5045.4 4833.1 4844.9 4865.1 4865.3 4901.2 4644.5 4751.6 4820.3 4860.6 4883.9 4673.3 4682.8 4716.5 4749.8 4817.9 4847.8 4865.3 4865.9 4867.3 4913.8 4541.2 4671.5 4738.3 4741.0 4787.0 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | [#1] ext.html Cycles:180 Average:41128.03 Median:3468.00 stddev:68248.34 (1967.9%) stddev-sans-first:68371.59 09:06:40 INFO - PROCESS | 4363 | Values: 493.0 522.4 528.4 528.8 541.4 24584.5 32854.3 33186.0 33238.8 33285.0 35556.3 36004.8 36012.5 36025.5 36025.5 6797.8 6889.8 7536.5 7656.8 7716.4 9644.2 9879.2 9884.5 9891.8 9905.3 9603.0 9721.2 9721.4 9726.5 9733.1 9380.9 9474.9 9476.2 9477.7 9479.9 9656.3 9808.5 9815.1 9825.3 9840.9 35872.0 36201.0 36434.5 36442.5 36462.0 2902.9 2960.2 2985.5 3020.2 3533.6 27274.0 27506.0 27510.9 28075.7 28763.0 3261.9 3283.4 3289.2 3303.7 3402.4 215781.0 219129.0 219250.0 219305.0 219383.0 45894.1 46669.0 47079.3 47699.2 56461.4 55189.2 55287.0 55335.4 55452.7 55775.2 11946.6 11996.9 12035.1 12061.5 12064.4 9287.6 9346.3 9348.9 9358.0 9432.1 19253.2 19322.0 19333.7 19405.7 19471.2 7557.4 7759.6 7765.3 7860.9 7916.1 799.2 881.4 927.0 960.8 998.5 25634.6 25806.6 25826.4 26064.9 26115.5 940.9 946.3 951.9 962.7 1059.0 13522.9 13695.2 13782.1 13819.7 13887.8 257541.0 261723.0 262750.0 262776.0 263071.0 43965.8 44568.0 44644.8 44683.3 44719.0 1191.1 1196.1 1205.8 1212.0 1214.8 24714.4 25451.0 25794.2 25860.4 26057.7 39606.6 39997.0 40240.6 40335.8 40383.6 237551.0 243150.0 324481.0 332342.0 333840.0 29318.6 29319.3 29472.6 29492.6 29494.6 37850.8 38824.2 39280.8 39309.8 39317.2 33717.8 35658.8 35841.3 36154.6 36735.6 29948.6 30273.2 30416.4 30452.4 30609.0 29547.9 30271.4 30452.2 30473.5 30483.7 27058.5 28032.4 28057.3 28179.9 29881.7 23023.9 23301.0 23361.5 23419.4 23535.4 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | [#2] jquery.html Cycles:180 Average:21445.94 Median:175570.99 stddev:52731.07 (30.0%) stddev-sans-first:52855.12 09:06:40 INFO - PROCESS | 4363 | Values: 311.0 324.5 326.2 330.4 331.7 11944.6 12370.9 14938.9 15247.1 15310.7 12138.9 14852.4 15606.5 16102.6 16129.8 4853.8 4909.3 4979.7 4987.8 5039.9 3524.0 3652.5 4941.5 4969.5 5028.0 5117.4 5137.8 5149.6 5168.2 5179.4 5126.4 5132.8 5343.3 5684.9 5703.7 4990.4 5035.1 5049.8 5050.0 5060.6 10850.4 15955.4 17909.5 18964.8 18969.1 1755.1 1794.8 1801.1 1806.5 1825.1 8497.4 8636.7 11163.3 11711.7 11874.9 1618.7 1676.3 1688.2 1765.7 1781.7 54550.0 55760.7 56706.1 57028.0 58056.0 9208.1 9346.6 9361.7 9388.2 9498.7 11961.8 12005.5 12038.6 12058.3 12133.2 6587.3 6680.0 6819.3 6844.2 6921.3 6574.3 6609.6 6674.1 6686.6 6698.1 3911.9 3960.0 3986.1 3997.2 4033.1 1555.7 1604.6 1611.3 1616.5 1692.9 803.9 824.8 835.0 874.5 916.5 14005.6 14622.6 14785.7 14830.3 14910.6 780.4 798.3 818.3 837.2 842.0 6896.6 8694.3 8914.5 9343.2 9359.7 306853.0 311424.0 312436.0 314031.0 347618.0 72576.6 73423.6 73826.3 74482.6 74525.6 1081.8 1088.0 1089.7 1109.1 1112.1 14170.9 14271.1 14370.4 14434.8 14635.4 32403.0 32937.0 33246.2 33404.0 34349.1 41939.0 43388.8 44107.3 44863.0 48061.5 7632.0 8057.5 8296.2 8543.4 8559.3 9401.1 10064.4 13878.2 15385.2 15511.6 10127.1 11080.7 12314.0 13472.4 13478.4 12566.9 12691.2 13032.2 13065.6 13162.9 9975.8 11972.6 13032.3 13362.0 13479.1 8709.5 8718.5 8742.0 8742.8 8756.1 12624.7 12636.7 12916.3 13039.8 13993.4 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | [#3] mootools.html Cycles:180 Average:4698.99 Median:6012.35 stddev:2395.63 (39.8%) stddev-sans-first:2388.49 09:06:40 INFO - PROCESS | 4363 | Values: 1270.8 1393.9 1418.6 1537.5 1730.1 5922.2 6112.9 6356.2 6471.0 6477.3 6443.6 6471.9 6500.1 6513.4 6528.0 1684.8 1717.2 1989.0 2022.8 2023.2 1980.5 2015.1 2015.3 2016.6 2016.7 1967.3 1988.7 1997.4 2012.2 2012.5 2007.8 2019.4 2046.9 2049.9 2052.0 2063.6 2064.6 2080.2 2084.1 2088.9 6741.3 6815.8 6818.5 6820.6 6825.9 4018.5 4064.6 4072.8 4072.8 4082.5 2568.2 2621.0 2628.6 2630.1 2646.0 787.6 795.1 815.3 816.5 819.2 8913.2 8927.3 8934.7 8958.8 8987.7 3506.6 3524.1 3567.8 3587.4 3642.1 7759.3 7763.1 7776.3 7782.1 7802.2 4009.2 4034.5 4039.7 4042.1 4044.1 3664.1 3676.0 3678.3 3702.6 3708.3 2899.1 2924.5 3177.1 3260.7 3303.2 997.7 1006.8 1009.2 1014.3 1018.3 854.1 861.0 862.2 862.8 930.7 6375.6 6423.8 6425.5 6427.4 6441.2 1021.1 1029.2 1036.5 1050.2 1065.0 4887.0 4908.7 4917.8 4918.0 4920.4 7580.5 7661.9 7843.4 7975.5 7977.7 7677.4 7684.9 7687.5 7701.2 7702.4 6265.7 6351.4 6358.9 6400.4 6410.6 6342.8 6484.6 6520.6 6521.5 6524.3 7160.5 7173.2 7268.5 7372.9 7401.4 7066.2 7233.1 7283.8 7364.2 7459.6 6044.3 6076.0 6082.7 6137.6 6155.0 5652.9 5783.9 6208.2 6708.2 6756.7 6038.6 6047.0 6071.4 6088.3 6100.9 5926.6 5943.6 5978.4 5978.8 6071.0 6152.9 6224.1 6242.5 6256.3 6256.6 5714.0 5845.9 5856.0 5867.1 5873.8 5878.3 5915.3 5972.3 5984.8 5986.1 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | [#4] prototype.html Cycles:180 Average:4654.34 Median:5371.69 stddev:1389.81 (25.9%) stddev-sans-first:1354.44 09:06:40 INFO - PROCESS | 4363 | Values: 283.7 285.2 288.4 291.1 292.7 4946.3 5166.9 5370.3 5370.4 5456.8 5277.8 5368.2 5372.9 5385.5 5386.3 4176.4 4179.6 4182.4 4184.6 4187.8 3909.0 3980.7 4022.6 4179.6 4181.5 4040.1 4046.4 4050.7 4088.3 4111.5 4078.0 4093.0 4093.4 4097.5 4110.4 3589.4 3590.0 3594.7 3594.7 3595.6 5008.2 5128.8 5136.9 5142.1 5143.4 4676.9 4681.7 4684.6 4685.9 4689.0 5597.0 5600.1 5602.3 5603.1 5603.9 3677.9 3748.4 3796.1 3870.3 3874.8 5865.1 5871.3 5896.4 5911.4 5917.2 3928.3 3951.8 3954.2 3965.4 3970.7 4019.5 4019.6 4025.5 4029.1 4040.4 4563.3 4597.0 4634.4 4647.3 4658.2 5600.0 5601.2 5602.3 5602.6 5608.3 1384.9 1427.8 1432.7 1433.5 1434.6 926.6 936.2 966.4 992.2 993.6 4957.7 4982.1 4983.6 4987.0 5018.4 5844.6 5847.5 5848.2 5853.6 5859.9 4968.8 4970.3 4974.0 4979.7 4979.9 3053.7 3116.6 3149.7 3151.0 3154.4 5550.0 5588.7 5615.5 5616.2 5618.8 6059.5 6065.1 6069.4 6071.3 6071.3 5580.7 5593.5 5593.6 5607.5 5617.9 5680.7 5875.9 5891.4 5907.2 5915.8 5413.5 5637.5 5758.8 5770.3 5772.0 5424.3 5497.4 5507.2 5579.5 5579.8 3817.8 3867.4 3883.0 3906.0 3916.9 5815.5 5838.9 5844.9 5852.3 5855.2 5430.6 5598.2 5643.3 5649.0 5655.2 5611.6 5642.4 5644.3 5647.6 5649.2 5521.3 5534.9 5540.4 5548.0 5566.6 5562.9 5704.2 5705.5 5711.0 5712.6 5561.7 5565.5 5568.4 5568.4 5568.6 09:06:40 INFO - PROCESS | 4363 | 09:06:40 INFO - PROCESS | 4363 | [#5] yui.html Cycles:180 Average:11769.46 Median:428.52 stddev:13204.91 (3081.5%) stddev-sans-first:13215.52 09:06:40 INFO - PROCESS | 4363 | Values: 644.4 722.3 730.4 765.4 823.6 10955.7 11178.2 11193.1 11207.9 11221.2 11173.9 11728.5 11787.0 11811.1 11813.1 790.3 794.2 800.3 803.0 806.4 788.5 794.6 796.5 797.2 797.3 836.4 846.9 847.4 847.5 847.6 834.4 837.0 838.3 839.6 840.1 617.6 618.0 619.1 619.7 619.7 10546.9 10633.0 10686.0 10700.6 10700.8 8996.2 9315.3 9412.7 9454.1 9454.1 8745.7 8870.7 8875.0 8903.3 8904.5 2937.7 2946.6 2976.3 3022.1 3023.5 34029.3 34485.1 38298.0 38595.8 38782.8 7690.6 8994.7 9064.8 9186.2 9300.8 16203.8 16762.6 16870.0 16881.5 16895.8 6155.3 6257.6 6460.6 6470.4 6508.4 3387.4 3500.2 3505.1 3522.3 3583.3 2597.9 2648.9 2651.0 2655.0 2665.4 451.3 455.7 456.2 457.9 461.0 400.4 422.5 434.5 448.6 576.5 7212.9 7408.3 7418.5 8110.8 8481.5 409.4 560.4 575.0 604.4 605.4 3353.6 3459.8 3494.2 3533.9 3574.7 45719.8 51433.7 51756.2 51857.2 52022.2 39556.8 39592.0 40014.0 40092.6 40264.2 33203.3 34092.5 38598.6 38935.4 39096.2 7484.4 7926.2 7969.6 8185.7 8273.4 29997.3 31111.2 31692.7 31953.2 32007.8 36983.6 38571.6 38673.8 40705.8 41019.0 9435.3 9938.0 10036.2 10063.9 10119.8 10347.4 10477.4 11156.4 11491.0 11493.7 10045.3 10175.9 10357.8 10892.4 11587.7 10162.9 10181.4 10202.2 10496.9 11113.6 10155.4 10180.8 10218.3 10874.8 10893.3 9302.7 9388.6 9501.4 9572.2 9690.0 8859.0 9190.9 9197.5 9258.2 9338.7 09:06:40 INFO - PROCESS | 4363 | -------- Summary: end -------- 09:06:40 INFO - PROCESS | 4363 | 09:06:41 INFO - TEST-INFO | 4363: exit 0 09:06:41 INFO - TEST-OK | dromaeo_css | took 1117842ms 09:06:41 INFO - TEST-START | kraken 09:06:41 INFO - operating with platform_type : linux_ 09:06:41 INFO - Initialising browser for kraken test... 09:06:41 INFO - TEST-INFO | started process 4565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf4LVDA/profile http://localhost:41264/getInfo.html) 09:06:45 INFO - PROCESS | 4565 | __metrics Screen width/height:1600/1200 09:06:45 INFO - PROCESS | 4565 | colorDepth:24 09:06:45 INFO - PROCESS | 4565 | Browser inner width/height: 1024/697 09:06:45 INFO - PROCESS | 4565 | __metrics 09:06:45 INFO - PROCESS | 4565 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:06:45 INFO - PROCESS | 4565 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:46 INFO - TEST-INFO | 4565: exit 0 09:06:46 INFO - Browser initialized. 09:06:46 INFO - Running cycle 1/1 for kraken test... 09:06:46 INFO - TEST-INFO | started process 4645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf4LVDA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:58 INFO - PROCESS | 4645 | RSS: Main: 150061056 09:06:58 INFO - PROCESS | 4645 | 09:07:01 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41264/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:02 INFO - PROCESS | 4645 | RSS: Main: 187195392 09:07:02 INFO - PROCESS | 4645 | 09:07:04 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41264/tests/kraken/driver.html?testName=audio-dft) 09:07:05 INFO - PROCESS | 4645 | RSS: Main: 176250880 09:07:05 INFO - PROCESS | 4645 | 09:07:08 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41264/tests/kraken/driver.html?testName=audio-fft) 09:07:08 INFO - PROCESS | 4645 | RSS: Main: 162316288 09:07:08 INFO - PROCESS | 4645 | 09:07:11 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41264/tests/kraken/driver.html?testName=audio-oscillator) 09:07:11 INFO - PROCESS | 4645 | RSS: Main: 162082816 09:07:11 INFO - PROCESS | 4645 | 09:07:13 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:14 INFO - PROCESS | 4645 | RSS: Main: 163450880 09:07:14 INFO - PROCESS | 4645 | 09:07:17 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41264/tests/kraken/driver.html?testName=imaging-darkroom) 09:07:18 INFO - PROCESS | 4645 | RSS: Main: 165253120 09:07:18 INFO - PROCESS | 4645 | 09:07:21 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41264/tests/kraken/driver.html?testName=imaging-desaturate) 09:07:22 INFO - PROCESS | 4645 | RSS: Main: 166207488 09:07:22 INFO - PROCESS | 4645 | 09:07:24 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41264/tests/kraken/driver.html?testName=json-parse-financial) 09:07:25 INFO - PROCESS | 4645 | RSS: Main: 166031360 09:07:25 INFO - PROCESS | 4645 | 09:07:27 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:27 INFO - PROCESS | 4645 | RSS: Main: 173539328 09:07:27 INFO - PROCESS | 4645 | 09:07:29 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:30 INFO - PROCESS | 4645 | RSS: Main: 173346816 09:07:30 INFO - PROCESS | 4645 | 09:07:32 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:32 INFO - PROCESS | 4645 | RSS: Main: 185442304 09:07:32 INFO - PROCESS | 4645 | 09:07:35 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:36 INFO - PROCESS | 4645 | RSS: Main: 188706816 09:07:36 INFO - PROCESS | 4645 | 09:07:38 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:39 INFO - PROCESS | 4645 | RSS: Main: 186761216 09:07:39 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | Cycle 1(1): loaded http://localhost:41264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41264/tests/kraken/driver.html?testName=ai-astar) 09:07:41 INFO - PROCESS | 4645 | RSS: Main: 245944320 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | __start_tp_report 09:07:41 INFO - PROCESS | 4645 | _x_x_mozilla_page_load 09:07:41 INFO - PROCESS | 4645 | _x_x_mozilla_page_load_details 09:07:41 INFO - PROCESS | 4645 | |i|pagename|runs| 09:07:41 INFO - PROCESS | 4645 | |0;ai-astar;113;116;110;114;113;114;104;113;113;120 09:07:41 INFO - PROCESS | 4645 | |1;audio-beat-detection;159;129;155;183;137;152;152;131;174;133 09:07:41 INFO - PROCESS | 4645 | |2;audio-dft;162;162;161;161;164;162;165;163;164;163 09:07:41 INFO - PROCESS | 4645 | |3;audio-fft;72;73;86;104;73;74;72;101;90;72 09:07:41 INFO - PROCESS | 4645 | |4;audio-oscillator;99;99;134;98;99;98;141;99;99;138 09:07:41 INFO - PROCESS | 4645 | |5;imaging-gaussian-blur;109;109;109;112;109;110;110;109;110;109 09:07:41 INFO - PROCESS | 4645 | |6;imaging-darkroom;148;147;146;147;146;148;147;148;148;147 09:07:41 INFO - PROCESS | 4645 | |7;imaging-desaturate;97;95;95;96;96;96;95;96;96;95 09:07:41 INFO - PROCESS | 4645 | |8;json-parse-financial;70;70;69;69;70;70;69;79;67;67 09:07:41 INFO - PROCESS | 4645 | |9;json-stringify-tinderbox;70;71;69;69;69;69;70;69;69;69 09:07:41 INFO - PROCESS | 4645 | |10;stanford-crypto-aes;86;89;97;87;88;88;88;88;88;87 09:07:41 INFO - PROCESS | 4645 | |11;stanford-crypto-ccm;127;120;129;117;128;125;120;124;130;120 09:07:41 INFO - PROCESS | 4645 | |12;stanford-crypto-pbkdf2;138;149;148;152;155;135;148;148;161;137 09:07:41 INFO - PROCESS | 4645 | |13;stanford-crypto-sha256-iterative;71;72;72;72;72;70;71;74;75;71 09:07:41 INFO - PROCESS | 4645 | __end_tp_report 09:07:41 INFO - PROCESS | 4645 | __start_cc_report 09:07:41 INFO - PROCESS | 4645 | _x_x_mozilla_cycle_collect,999 09:07:41 INFO - PROCESS | 4645 | __end_cc_report 09:07:41 INFO - PROCESS | 4645 | __startTimestamp1452100061396__endTimestamp 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | ------- Summary: start ------- 09:07:41 INFO - PROCESS | 4645 | Number of tests: 14 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:4.08 (3.6%) stddev-sans-first:4.33 09:07:41 INFO - PROCESS | 4645 | Values: 113.0 116.0 110.0 114.0 113.0 114.0 104.0 113.0 113.0 120.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:153.50 stddev:18.37 (12.0%) stddev-sans-first:19.22 09:07:41 INFO - PROCESS | 4645 | Values: 159.0 129.0 155.0 183.0 137.0 152.0 152.0 131.0 174.0 133.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 09:07:41 INFO - PROCESS | 4645 | Values: 162.0 162.0 161.0 161.0 164.0 162.0 165.0 163.0 164.0 163.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#3] audio-fft Cycles:10 Average:81.70 Median:73.00 stddev:12.69 (17.4%) stddev-sans-first:12.97 09:07:41 INFO - PROCESS | 4645 | Values: 72.0 73.0 86.0 104.0 73.0 74.0 72.0 101.0 90.0 72.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:99.00 stddev:18.89 (19.1%) stddev-sans-first:19.58 09:07:41 INFO - PROCESS | 4645 | Values: 99.0 99.0 134.0 98.0 99.0 98.0 141.0 99.0 99.0 138.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 09:07:41 INFO - PROCESS | 4645 | Values: 109.0 109.0 109.0 112.0 109.0 110.0 110.0 109.0 110.0 109.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 09:07:41 INFO - PROCESS | 4645 | Values: 148.0 147.0 146.0 147.0 146.0 148.0 147.0 148.0 148.0 147.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 09:07:41 INFO - PROCESS | 4645 | Values: 97.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:3.37 (4.8%) stddev-sans-first:3.57 09:07:41 INFO - PROCESS | 4645 | Values: 70.0 70.0 69.0 69.0 70.0 70.0 69.0 79.0 67.0 67.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 09:07:41 INFO - PROCESS | 4645 | Values: 70.0 71.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.00 stddev:3.06 (3.5%) stddev-sans-first:3.10 09:07:41 INFO - PROCESS | 4645 | Values: 86.0 89.0 97.0 87.0 88.0 88.0 88.0 88.0 88.0 87.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:126.00 stddev:4.52 (3.6%) stddev-sans-first:4.66 09:07:41 INFO - PROCESS | 4645 | Values: 127.0 120.0 129.0 117.0 128.0 125.0 120.0 124.0 130.0 120.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:148.50 stddev:8.28 (5.6%) stddev-sans-first:8.10 09:07:41 INFO - PROCESS | 4645 | Values: 138.0 149.0 148.0 152.0 155.0 135.0 148.0 148.0 161.0 137.0 09:07:41 INFO - PROCESS | 4645 | 09:07:41 INFO - PROCESS | 4645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.49 (2.1%) stddev-sans-first:1.54 09:07:41 INFO - PROCESS | 4645 | Values: 71.0 72.0 72.0 72.0 72.0 70.0 71.0 74.0 75.0 71.0 09:07:41 INFO - PROCESS | 4645 | -------- Summary: end -------- 09:07:41 INFO - PROCESS | 4645 | 09:07:42 INFO - TEST-INFO | 4645: exit 0 09:07:42 INFO - TEST-OK | kraken | took 61234ms 09:07:42 INFO - TEST-START | v8_7 09:07:42 INFO - operating with platform_type : linux_ 09:07:42 INFO - Initialising browser for v8_7 test... 09:07:42 INFO - TEST-INFO | started process 4896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dskQ0/profile http://localhost:41264/getInfo.html) 09:07:47 INFO - PROCESS | 4896 | __metrics Screen width/height:1600/1200 09:07:47 INFO - PROCESS | 4896 | colorDepth:24 09:07:47 INFO - PROCESS | 4896 | Browser inner width/height: 1024/697 09:07:47 INFO - PROCESS | 4896 | __metrics 09:07:47 INFO - PROCESS | 4896 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:07:47 INFO - PROCESS | 4896 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:48 INFO - TEST-INFO | 4896: exit 0 09:07:48 INFO - Browser initialized. 09:07:48 INFO - Running cycle 1/1 for v8_7 test... 09:07:48 INFO - TEST-INFO | started process 4980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dskQ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:00 INFO - PROCESS | 4980 | RSS: Main: 150159360 09:08:00 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | Cycle 1(1): loaded http://localhost:41264/tests/v8_7/run.html (next: http://localhost:41264/tests/v8_7/run.html) 09:08:21 INFO - PROCESS | 4980 | RSS: Main: 449458176 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | __start_tp_report 09:08:21 INFO - PROCESS | 4980 | _x_x_mozilla_page_load 09:08:21 INFO - PROCESS | 4980 | _x_x_mozilla_page_load_details 09:08:21 INFO - PROCESS | 4980 | |i|pagename|runs| 09:08:21 INFO - PROCESS | 4980 | |0;Richards;167.1402306535183 09:08:21 INFO - PROCESS | 4980 | |1;DeltaBlue;190.47619047619048 09:08:21 INFO - PROCESS | 4980 | |2;Encrypt;282.56569652444193 09:08:21 INFO - PROCESS | 4980 | |3;Decrypt;5170.103092783505 09:08:21 INFO - PROCESS | 4980 | |4;RayTrace;1990.0596421471173 09:08:21 INFO - PROCESS | 4980 | |5;Earley;809.0614886731391 09:08:21 INFO - PROCESS | 4980 | |6;Boyer;12243.90243902439 09:08:21 INFO - PROCESS | 4980 | |7;RegExp;26973.684210526317 09:08:21 INFO - PROCESS | 4980 | |8;Splay;610.1281269066504 09:08:21 INFO - PROCESS | 4980 | |9;NavierStokes;4830.917874396136 09:08:21 INFO - PROCESS | 4980 | __end_tp_report 09:08:21 INFO - PROCESS | 4980 | __startTimestamp1452100101901__endTimestamp 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | ------- Summary: start ------- 09:08:21 INFO - PROCESS | 4980 | Number of tests: 10 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 167.1 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#1] DeltaBlue Cycles:1 Average:190.48 Median:190.48 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 190.5 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 282.6 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 5170.1 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 1990.1 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 809.1 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 12243.9 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#7] RegExp Cycles:1 Average:26973.68 Median:26973.68 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 26973.7 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 610.1 09:08:21 INFO - PROCESS | 4980 | 09:08:21 INFO - PROCESS | 4980 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:08:21 INFO - PROCESS | 4980 | Values: 4830.9 09:08:21 INFO - PROCESS | 4980 | -------- Summary: end -------- 09:08:21 INFO - PROCESS | 4980 | 09:08:22 INFO - TEST-INFO | 4980: exit 0 09:08:22 INFO - TEST-OK | v8_7 | took 40489ms 09:08:22 INFO - SUITE-END | took 1219s 09:08:22 INFO - Completed test suite (00:20:19) 09:08:22 INFO - Working with test: dromaeo_css 09:08:22 INFO - Generating results file: dromaeo_css 09:08:22 INFO - Working with test: kraken 09:08:22 INFO - Generating results file: kraken 09:08:22 INFO - javascript benchmark 09:08:22 INFO - Working with test: v8_7 09:08:22 INFO - Generating results file: v8_7 09:08:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:08:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 09:08:23 INFO - process_Request line: dromaeo_css 6161.87 graph.html#tests=[[72,203,35]] 09:08:23 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:08:23 INFO - process_Request line: kraken 1541.90 graph.html#tests=[[232,203,35]] 09:08:23 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:08:23 INFO - process_Request line: v8_7 19640.79 graph.html#tests=[[230,203,35]] 09:08:23 INFO - RETURN: dromaeo_css: 6161.87 09:08:23 INFO - RETURN: kraken: 1541.90 09:08:23 INFO - RETURN: v8_7: 19640.79 09:08:23 INFO - javascript benchmark 09:08:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2580.954473721009, 2684.463107378522, 2692.2730862667067, 2701.702812690605, 2714.484247992882, 4417.204903117437, 4559.658025648081, 4650.697704649196, 4656.743879086649, 4665.650076244283, 4547.999440123176, 4629.143608432442, 4640.1879671057595, 4729.834455794048, 4777.498362671921, 4264.083222107254, 4289.1636130954475, 4303.117860838521, 4326.913461730764, 4345.565443455661, 4354.346847972798, 4384.824607015731, 4400.031992961543, 4400.339949007643, 4443.400140980959, 4193.601607847249, 4194.245035893553, 4273.722208056466, 4278.443802305712, 4359.716618419824, 4302.2471067563365, 4310.956890431087, 4317.633001194902, 4343.413639158704, 4348.543402942677, 4280.229558679436, 4299.570042995675, 4303.892402689958, 4317.76252306123, 4334.739915605074, 4385.144896745136, 4512.751798651073, 4518.073794872043, 4573.771311434448, 4648.418947631546, 4809.7114173149375, 4814.7351895645725, 4819.373481447425, 4820.8071677132875, 4828.517148285144, 4841.564259216688, 4843.07981483517, 4846.39420072491, 4848.490908454597, 4858.514148585148, 4631.4673812511655, 4692.0381321828945, 4743.905121897543, 4745.786439610226, 4750.976245118822, 5109.4379618241965, 5128.948710512922, 5143.948560514422, 5150.871228219249, 5187.2478490619405, 4713.080949214938, 4877.609791216694, 4942.4316203637045, 4946.233333833262, 4955.603551715854, 4904.730239836843, 4914.066327397783, 5013.699178049329, 5071.340725705709, 5133.7689803958165, 4907.975460122677, 4911.975440122848, 4914.729689867092, 4917.164082106051, 4964.379452568429, 4732.1245569569055, 4895.902081958341, 4911.0, 4911.631627627942, 4940.184869496565, 4119.855805046869, 4121.0, 4139.068709540329, 4218.114196018871, 4260.147970405931, 3667.6332366763645, 3685.981570092132, 3690.095926498025, 3716.832742526593, 3722.6091260417265, 4329.978350108229, 4344.56554344563, 4346.304591265382, 4357.4988876279, 4368.6068253856665, 4822.373091498082, 4936.481669424658, 4938.876528086755, 4945.282933974553, 4947.035328110984, 4295.699301048959, 4348.760818154969, 4348.93476597845, 4357.041450880801, 4396.516383197845, 4489.079738653633, 4497.123061003073, 4508.0, 4537.500874903758, 4544.659150563721, 4637.1421287062, 4747.738874361943, 4781.713097214179, 4792.353032340659, 4792.904141917142, 4886.780094895667, 5030.673006254582, 5085.821996230115, 5091.87270318245, 5111.156659151198, 4804.543568361, 4823.131836269506, 4830.589399901048, 4839.540243676845, 4867.829625963074, 4702.694324868872, 4791.47293797689, 4979.800807967786, 5001.949980500149, 5048.318477005704, 4918.0901533216465, 4926.58124059459, 4965.726885021359, 4978.377702787152, 5045.369328833895, 4833.081714474239, 4844.8788780279365, 4865.051314993542, 4865.343178670834, 4901.240307752304, 4644.5123262056995, 4751.61987041029, 4820.3492528509605, 4860.6111511079735, 4883.853484395474, 4673.252279635242, 4682.765861706969, 4716.457607375196, 4749.762511874462, 4817.855464336076, 4847.757612119451, 4865.270209468608, 4865.9026819464125, 4867.342908707279, 4913.77887995034, 4541.159885421208, 4671.509491503479, 4738.289256611536, 4741.0, 4786.994731106367], "unit": "score", "name": "dojo.html", "value": 4569.557233263453}, {"lowerIsBetter": false, "replicates": [492.95809856162225, 522.3575002746624, 528.3659608469837, 528.7620570743165, 541.4423144161514, 24584.508309833793, 32854.34291314172, 33186.0, 33238.833805831, 33285.0, 35556.2888742225, 36004.819975900085, 36012.459813102825, 36025.459618105684, 36025.459618105684, 6797.796066118024, 6889.7588584399555, 7536.510126841751, 7656.770296891103, 7716.421268404864, 9644.18024467921, 9879.209663226924, 9884.505774711235, 9891.752706182368, 9905.2571057171, 9603.039696030375, 9721.222302215841, 9721.416714997087, 9726.513674316291, 9733.124018838304, 9380.859287110665, 9474.857877131848, 9476.241900647932, 9477.668281610146, 9479.90520094804, 9656.27577931658, 9808.509574521246, 9815.116639502408, 9825.263105267133, 9840.901590984071, 35872.0, 36201.0, 36434.45348319777, 36442.45336319957, 36462.0, 2902.8983985560617, 2960.15635543869, 2985.477541430241, 3020.1845501714633, 3533.611302756695, 27274.0, 27506.0, 27510.862445687842, 28075.719242807514, 28763.0, 3261.8532166052582, 3283.3597448497553, 3289.19414743387, 3303.6861498157637, 3402.387570237356, 215781.0, 219129.0, 219250.0, 219305.0, 219383.0, 45894.082118357444, 46669.0, 47079.29381059287, 47699.1840652747, 56461.43538564644, 55189.1721624176, 55287.0, 55335.44664553383, 55452.72273638606, 55775.16337254945, 11946.641600751991, 11996.940015299868, 12035.097367697457, 12061.457234424472, 12064.396780161132, 9287.62849486013, 9346.252299815998, 9348.906510934803, 9358.01740817218, 9432.103950124727, 19253.22987080501, 19322.0, 19333.709994350094, 19405.708914366296, 19471.221151154077, 7557.4331925105835, 7759.568302188491, 7765.339946104645, 7860.882086768703, 7916.08964969036, 799.152897928198, 881.3654168998311, 926.9536523173814, 960.7934294126796, 998.4957596413765, 25634.615480767803, 25806.612900806504, 25826.35434114162, 26064.869675651502, 26115.477690446085, 940.9059094090536, 946.3044662173297, 951.8905325887473, 962.7208109648263, 1058.952347144365, 13522.864771352357, 13695.246761428218, 13782.104163229358, 13819.723605527834, 13887.79168312476, 257541.0, 261723.0, 262750.0, 262776.0, 263071.0, 43965.78017109894, 44568.0, 44644.77677611656, 44683.329750053774, 44719.0, 1191.0709646475764, 1196.0670676872053, 1205.7528206717777, 1211.9697007574882, 1214.8117041858527, 24714.382140445912, 25451.0, 25794.226173214833, 25860.35349116287, 26057.739422605533, 39606.603933960294, 39997.0, 40240.59759402368, 40335.79832100821, 40383.59616403798, 237551.0, 243150.0, 324481.0, 332342.0, 333840.0, 29318.56022159712, 29319.267018324714, 29472.55791163177, 29492.55761163627, 29494.557581636724, 37850.810745946095, 38824.223515530095, 39280.80359598298, 39309.80345098256, 39317.2136557273, 33717.83141084279, 35658.82170589131, 35841.28317433689, 36154.63845361618, 36735.63264367322, 29948.550771738875, 30273.24316892095, 30416.391672166876, 30452.39095218039, 30609.0, 29547.85226073856, 30271.394572108875, 30452.238694032825, 30473.54289685701, 30483.69516304897, 27058.45883082288, 28032.43935121327, 28057.29856753516, 28179.859100704365, 29881.70118298789, 23023.88488057549, 23301.029014003136, 23361.53276934418, 23419.414514636588, 23535.41161470977], "unit": "score", "name": "ext.html", "value": 16803.068509022087}, {"lowerIsBetter": false, "replicates": [310.95335699645034, 324.4597744754983, 326.1601376455626, 330.36075194498653, 331.711411072367, 11944.64166075017, 12370.938145309261, 14938.850611493895, 15247.0851748895, 15310.693786124271, 12138.939305303484, 14852.405903763836, 15606.531804045868, 16102.5974350641, 16129.758053629204, 4853.8058477661025, 4909.263610458424, 4979.676321039121, 4987.775550100236, 5039.949600504003, 3523.982380088096, 3652.543432070991, 4941.530554597308, 4969.453360130401, 5027.974860125694, 5117.360329958755, 5137.845864624067, 5149.588032957373, 5168.198929165986, 5179.430262671103, 5126.359205099363, 5132.794688212467, 5343.290147152913, 5684.8863022739315, 5703.7148142592705, 4990.426100998396, 5035.0685123252315, 5049.84850454487, 5050.015247026831, 5060.645754797166, 10850.403227822466, 15955.361785528565, 17909.462716118538, 18964.81035189658, 18969.146388412417, 1755.0961254953709, 1794.8205179482077, 1801.0994502748626, 1806.494181629146, 1825.0509734937891, 8497.362697797627, 8636.740897773077, 11163.274387164809, 11711.7072073198, 11874.931256186985, 1618.7248167811501, 1676.2540669402122, 1688.1559220389804, 1765.7174852023616, 1781.7060185069447, 54550.0, 55760.72119639376, 56706.149407758916, 57028.0, 58056.0, 9208.079192080739, 9346.57940392684, 9361.689363489117, 9388.155066044088, 9498.667546635834, 11961.820572691417, 12005.519779208735, 12038.638840834614, 12058.276503409648, 12133.150679452354, 6587.341265873374, 6680.0, 6819.318068193141, 6844.2129155147795, 6921.342472465108, 6574.276829548746, 6609.636469994197, 6674.132362792806, 6686.5653732507235, 6698.12924319845, 3911.941320880189, 3960.0226287007654, 3986.1031267965054, 3997.2405243003736, 4033.1328764315813, 1555.6810853774948, 1604.5587463447646, 1611.2588209423561, 1616.5231256779277, 1692.9492115236562, 803.8874557561946, 824.789678631945, 835.0480452284401, 874.5190145419994, 916.5050872528893, 14005.579832605039, 14622.63443413902, 14785.704285914222, 14830.33263503145, 14910.627234319012, 780.4185881518305, 798.269583331257, 818.2717381530442, 837.1670188162817, 842.0190478092953, 6896.586204827727, 8694.347923905605, 8914.509701966454, 9343.205827504602, 9359.719208423621, 306853.0, 311424.0, 312436.0, 314031.0, 347618.0, 72576.63711681408, 73423.63288183631, 73826.26173738301, 74482.6275868628, 74525.62737186279, 1081.8377243413393, 1088.0262165362115, 1089.72212085916, 1109.1016276815644, 1112.0991996482874, 14170.929145354206, 14271.14373137615, 14370.425182992982, 14434.783478248044, 14635.414583416545, 32403.0, 32937.0, 33246.16884577905, 33404.0, 34349.14127146841, 41939.0, 43388.783056085784, 44107.338389923534, 44863.0, 48061.5193848057, 7632.0, 8057.476264042818, 8296.170382961656, 8543.359248056546, 8559.315254779727, 9401.10689484498, 10064.446455444728, 13878.236696981763, 15385.230738463257, 15511.612209694847, 10127.139193168663, 11080.667579972614, 12314.0, 13472.393742281425, 13478.393472293574, 12566.874331256571, 12691.238525688488, 13032.152910060815, 13065.608031759062, 13162.868371316546, 9975.750606234902, 11972.64082077539, 13032.283224422748, 13362.0, 13479.123856949267, 8709.520976346363, 8718.520481373585, 8741.956290218508, 8742.781430464289, 8756.080611535697, 12624.684382890502, 12636.747265054832, 12916.289604071866, 13039.804402934153, 13993.440262389391], "unit": "score", "name": "jquery.html", "value": 7920.082488129244}, {"lowerIsBetter": false, "replicates": [1270.8030255310418, 1393.8745512903838, 1418.5531557559368, 1537.4849425442476, 1730.0657644871762, 5922.170896074547, 6112.938870611298, 6356.237251529811, 6471.0, 6477.319881412454, 6443.645599492026, 6471.9352806471925, 6500.089987401768, 6513.446357059644, 6528.020796880471, 1684.7978242610843, 1717.2015013018943, 1988.9502762430945, 2022.7977202279728, 2023.2109477303864, 1980.4949737816837, 2015.1234213117268, 2015.2946468735972, 2016.6067616814653, 2016.6672499037716, 1967.3409407848387, 1988.7315212446279, 1997.3907958072782, 2012.154894944127, 2012.537116463207, 2007.8393728501685, 2019.4042757386605, 2046.9181232750745, 2049.8770073795545, 2052.035543294649, 2063.6285468615642, 2064.6283668939586, 2080.2303147835246, 2084.1038353507984, 2088.9164433422643, 6741.258461569223, 6815.829604259933, 6818.454523638097, 6820.556663816836, 6825.863482730318, 4018.517777866675, 4064.593540645941, 4072.75563466193, 4072.8370865165357, 4082.5305089914445, 2568.1910198287665, 2620.973790262092, 2628.5925681519393, 2630.0663264541004, 2645.9867700661566, 787.5943888897223, 795.1213908630938, 815.3477218225455, 816.5386556595505, 819.1562690428808, 8913.153250441197, 8927.330450216195, 8934.687285945025, 8958.776030599221, 8987.730368088967, 3506.6094065092943, 3524.101354154674, 3567.7680950738118, 3587.3722098632634, 3642.0530662028063, 7759.262870027338, 7763.146053934062, 7776.261255180749, 7782.143964163937, 7802.219778022152, 4009.1781184857036, 4034.5158580969883, 4039.7374170678813, 4042.110735638155, 4044.130511939888, 3664.0839790052487, 3676.0442285005556, 3678.264347130531, 3702.5742039665784, 3708.313961917, 2899.130260921715, 2924.502834518137, 3177.1421716136974, 3260.6739326067677, 3303.1576947878616, 997.7356000659686, 1006.8389057750725, 1009.1876039787894, 1014.2849291249652, 1018.3482571154467, 854.0647990450447, 860.9526476043752, 862.1680078724062, 862.7929296968682, 930.7161315798611, 6375.6174629522375, 6423.807285781434, 6425.518086143558, 6427.357264273535, 6441.227052753699, 1021.0759262867117, 1029.156092004549, 1036.4558606731525, 1050.165118730611, 1064.984025239622, 4887.0, 4908.730019848871, 4917.803287868517, 4918.0, 4920.4095508538485, 7580.469367144247, 7661.923380766232, 7843.37253019757, 7975.521468711896, 7977.720779772796, 7677.424193185533, 7684.923150768421, 7687.461877668509, 7701.191374905554, 7702.422318326036, 6265.65538895356, 6351.364863513611, 6358.904616430757, 6400.3599640036555, 6410.583312084699, 6342.841428964312, 6484.643344616092, 6520.608763474017, 6521.478281737354, 6524.347565243438, 7160.534565253241, 7173.175084865307, 7268.491205615556, 7372.926270737224, 7401.407887369105, 7066.187388450394, 7233.0597022386755, 7283.781486555412, 7364.189939106801, 7459.589722565094, 6044.335123136363, 6075.969620151871, 6082.695865206633, 6137.570370074231, 6155.0459678748075, 5652.943470565407, 5783.94216057834, 6208.192934918432, 6708.19501659804, 6756.69594868242, 6038.607490513103, 6046.9697651513225, 6071.362506936708, 6088.299845517645, 6100.908486372619, 5926.555508336978, 5943.613665111754, 5978.372270911492, 5978.8206353809455, 6070.969645151746, 6152.907706384497, 6224.097505861534, 6242.531810114168, 6256.280527739368, 6256.593321434092, 5714.0, 5845.941540584539, 5856.0, 5867.119932010232, 5873.765049397976, 5878.265216847894, 5915.349311575809, 5972.283326000734, 5984.790532331347, 5986.102084687332], "unit": "score", "name": "mootools.html", "value": 3870.902553623536}, {"lowerIsBetter": false, "replicates": [283.65819187878606, 285.16731145056434, 288.41883604536855, 291.1019504827607, 292.7219141815275, 4946.307516947631, 5166.922496162551, 5370.301860758101, 5370.43610420906, 5456.7544460499275, 5277.762500687469, 5368.248445217672, 5372.9462705372935, 5385.542228910547, 5386.326709161355, 4176.415301857743, 4179.623833854953, 4182.414461975311, 4184.560621134783, 4187.769672668002, 3909.042284640253, 3980.741251818637, 4022.557518672944, 4179.6447301979215, 4181.498220213579, 4040.070783719746, 4046.4132700758373, 4050.6961977851633, 4088.3049881520215, 4111.48606424197, 4078.0, 4092.976755811047, 4093.385992101179, 4097.508299004124, 4110.445089912853, 3589.407747721649, 3590.0, 3594.6764791168657, 3594.712423006153, 3595.6044835068124, 5008.173651347523, 5128.794848206067, 5136.922946155811, 5142.100132476801, 5143.382794064699, 4676.929846052312, 4681.695689780154, 4684.578387945101, 4685.859424217245, 4689.038747056845, 5596.972015139939, 5600.131979543177, 5602.327720673505, 5603.075492543766, 5603.915941260884, 3677.9080522987138, 3748.3627783276906, 3796.088938654703, 3870.264649716573, 3874.8256328465286, 5865.149553314788, 5871.266091738533, 5896.439838215363, 5911.408859114097, 5917.230760001173, 3928.3125453045604, 3951.762894226298, 3954.2486927483687, 3965.40518922164, 3970.68234541236, 4019.517657881073, 4019.618136277049, 4025.516937967404, 4029.093453972833, 4040.373742069984, 4563.309487765549, 4596.977015114903, 4634.37435946143, 4647.34937108805, 4658.161530924466, 5600.0, 5601.243832082698, 5602.2717046783655, 5602.635828671123, 5608.270924779753, 1384.8892088632886, 1427.800107984883, 1432.7206194791916, 1433.5341014170435, 1434.619825746178, 926.5645146781002, 936.2182577547824, 966.3960024984385, 992.2161492421051, 993.5777294649745, 4957.652964292465, 4982.078315511642, 4983.551480366785, 4986.950130498722, 5018.397792264878, 5844.620099693507, 5847.502962248172, 5848.239728835224, 5853.619514731528, 5859.912101318484, 4968.826091086795, 4970.254461830682, 4974.0051989602225, 4979.701217926936, 4979.925301120486, 3053.6793636668276, 3116.6104236970377, 3149.6692847251165, 3151.0389331253728, 3154.4322022035794, 5549.972250138723, 5588.720563971785, 5615.466530679579, 5616.241807355955, 5618.831435056954, 6059.515238780975, 6065.090236464477, 6069.393060693984, 6071.2714474263375, 6071.332153463116, 5580.748866301026, 5593.468620481048, 5593.580481463907, 5607.52336051432, 5617.859553511195, 5680.68756218412, 5875.853103672443, 5891.381404952418, 5907.232059832194, 5915.822525324075, 5413.512783849473, 5637.520810731134, 5758.798442054675, 5770.278715160605, 5772.0, 5424.321959755031, 5497.36780270274, 5507.201455788968, 5579.497845193952, 5579.832605021856, 3817.751846129993, 3867.43922131295, 3882.96117038826, 3905.9609403905597, 3916.8824935251987, 5815.505682017076, 5838.912416313844, 5844.853878652898, 5852.297724273115, 5855.180274761622, 5430.647007944471, 5598.188262701967, 5643.294588176478, 5649.0, 5655.151727240782, 5611.6352437091455, 5642.379338272869, 5644.266245388073, 5647.576431767552, 5649.20911072442, 5521.254630624975, 5534.944650553443, 5540.36285827135, 5548.0013597552825, 5566.582506312124, 5562.860928476821, 5704.172894930295, 5705.515031222392, 5711.029694755302, 5712.6286791358425, 5561.694106824163, 5565.471280228372, 5568.415316391883, 5568.443155684399, 5568.582356323373], "unit": "score", "name": "prototype.html", "value": 4201.4856962695185}, {"lowerIsBetter": false, "replicates": [644.378175061066, 722.2741145149126, 730.390124246254, 765.3685709289836, 823.6170180865896, 10955.726106847333, 11178.16163787715, 11193.10455163587, 11207.887921120806, 11221.214514983943, 11173.888261117387, 11728.53085876564, 11787.0, 11811.11416643753, 11813.054955603553, 790.2571582712261, 794.2057942057942, 800.3277247112425, 803.04036676172, 806.3992325717348, 788.538704857659, 794.6026986506747, 796.4623878881761, 797.1510341486298, 797.2904115337326, 836.3810780022769, 846.8941382327209, 847.4237518487427, 847.4533925617973, 847.6100993542977, 834.3575446905879, 836.9790755231107, 838.2748922182329, 839.5969934431507, 840.1010918317403, 617.6232498176109, 618.0358640520802, 619.102301662591, 619.6715740657459, 619.6963487890946, 10546.894531054668, 10633.0, 10686.0, 10700.625478108306, 10700.839487407695, 8996.235319997808, 9315.347925645208, 9412.670556530556, 9454.05459454056, 9454.149126578572, 8745.693900713444, 8870.689525866628, 8875.0, 8903.28773698109, 8904.51025193614, 2937.720916512928, 2946.602208701819, 2976.255936015996, 3022.07826612883, 3023.546468029791, 34029.31941361184, 34485.13787155316, 38298.0, 38595.807020964996, 38782.80608596967, 7690.577018263937, 8994.730158095268, 9064.773380665536, 9186.219171370374, 9300.767480813034, 16203.83796162047, 16762.58093547671, 16870.0, 16881.493555193363, 16895.83104168967, 6155.261368635703, 6257.5932564383165, 6460.644664543402, 6470.38531339522, 6508.414242718178, 3387.4410722230555, 3500.1949551602765, 3505.1237190702323, 3522.295540891832, 3583.258950709104, 2597.948041039169, 2648.9205323840315, 2651.0, 2654.9601755973677, 2665.4002849359126, 451.2621863253604, 455.6605329029894, 456.18798538601345, 457.86906341336845, 460.9792559334838, 400.3714168755027, 422.53943201909453, 434.49815463140123, 448.56937340153166, 576.4840467781312, 7212.927870721331, 7408.2591740826565, 7418.517796343221, 8110.83778324442, 8481.491110533389, 409.4002286650072, 560.3751816724323, 574.9511291540182, 604.3865476541314, 605.3764622438895, 3353.5808023997, 3459.8443070061403, 3494.178867966026, 3533.876314328986, 3574.696150827209, 45719.77140114278, 51433.742831286356, 51756.22365664518, 51857.2221416679, 52022.21966670503, 39556.80221598931, 39592.0, 40014.0, 40092.59907400947, 40264.194716105514, 33203.335933281196, 34092.48861267083, 38598.61401386006, 38935.415968759924, 39096.21807563776, 7484.401247900046, 7926.207379262028, 7969.561674107979, 8185.672573097009, 8273.379496537904, 29997.250068748457, 31111.222219444695, 31692.683073168973, 31953.201169970936, 32007.839960800047, 36983.63016369802, 38571.614283856805, 38673.80663096779, 40705.79647101746, 41019.0, 9435.292353073684, 9937.950310248403, 10036.247281454067, 10063.89936100659, 10119.848202276824, 10347.43089130075, 10477.423741693976, 11156.386398748147, 11491.0, 11493.655190344303, 10045.296829222176, 10175.880653128002, 10357.792844143225, 10892.40091794959, 11587.652370428901, 10162.898371016196, 10181.440020798927, 10202.234832387452, 10496.947515262375, 11113.611023614134, 10155.390676559135, 10180.847287290844, 10218.284720069523, 10874.836877447004, 10893.346399216072, 9302.720918372459, 9388.624455021723, 9501.382410143318, 9572.234221262142, 9690.030996900254, 8859.0, 9190.908090919273, 9197.54012299369, 9258.213051890665, 9338.653029142455], "unit": "score", "name": "yui.html", "value": 5533.772955104183}], "name": "dromaeo_css", "value": 6161.871331560832}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 116.0, 110.0, 114.0, 113.0, 114.0, 104.0, 113.0, 113.0, 120.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 155.0, 183.0, 137.0, 152.0, 152.0, 131.0, 174.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 164.0, 162.0, 165.0, 163.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 104.0, 73.0, 74.0, 72.0, 101.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 134.0, 98.0, 99.0, 98.0, 141.0, 99.0, 99.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 112.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 79.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [86.0, 89.0, 97.0, 87.0, 88.0, 88.0, 88.0, 88.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [127.0, 120.0, 129.0, 117.0, 128.0, 125.0, 120.0, 124.0, 130.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 148.0, 152.0, 155.0, 135.0, 148.0, 148.0, 161.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 72.0, 72.0, 70.0, 71.0, 74.0, 75.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1541.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [190.47619047619048], "unit": "score", "name": "DeltaBlue", "value": 347.1194999999999}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [809.0614886731391], "unit": "score", "name": "Earley", "value": 823.7482679999999}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26973.684210526317], "unit": "score", "name": "RegExp", "value": 33.77310243902437}, {"lowerIsBetter": false, "replicates": [610.1281269066504], "unit": "score", "name": "Splay", "value": 133.56374900000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19640.790601487715}]} 09:08:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19640.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1541.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6161.87"}}} 09:08:23 INFO - Return code: 0 09:08:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:08:23 INFO - # TBPL SUCCESS # 09:08:23 INFO - Running post-action listener: _resource_record_post_action 09:08:23 INFO - Running post-run listener: _resource_record_post_run 09:08:24 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 547278848; Read time: 0; Write time: 505008 09:08:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231313408; Read time: 0; Write time: 275732 09:08:24 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 315101184; Read time: 0; Write time: 229228 09:08:24 INFO - Running post-run listener: _upload_blobber_files 09:08:24 INFO - Blob upload gear active. 09:08:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:24 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 09:08:24 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'] 09:08:24 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 09:08:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:25 INFO - (blobuploader) - INFO - Done attempting. 09:08:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:26 INFO - (blobuploader) - INFO - Done attempting. 09:08:26 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:26 INFO - Return code: 0 09:08:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/af6ae32855c9e4f7092c115db1feb29a9069edfdad3d163b2db8b982b19cc241012173600d19f40c9d2d376eea21cbbc376ecf44e9d321548dd367bb5f770560", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ad29a7de1380323fed3a108b6d950ef6c177eb03576bb3c015d21af993b839a86a15b4164f4a2de3d943bec60d79377529c5b157e9abeef10fb2e15ae3608bf3"} 09:08:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:26 INFO - Contents: 09:08:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/af6ae32855c9e4f7092c115db1feb29a9069edfdad3d163b2db8b982b19cc241012173600d19f40c9d2d376eea21cbbc376ecf44e9d321548dd367bb5f770560", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ad29a7de1380323fed3a108b6d950ef6c177eb03576bb3c015d21af993b839a86a15b4164f4a2de3d943bec60d79377529c5b157e9abeef10fb2e15ae3608bf3"} 09:08:26 INFO - Copying logs to upload dir... 09:08:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.615013 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 09:08:25.514654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 09:08:25.517692) ========= 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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 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/af6ae32855c9e4f7092c115db1feb29a9069edfdad3d163b2db8b982b19cc241012173600d19f40c9d2d376eea21cbbc376ecf44e9d321548dd367bb5f770560", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ad29a7de1380323fed3a108b6d950ef6c177eb03576bb3c015d21af993b839a86a15b4164f4a2de3d943bec60d79377529c5b157e9abeef10fb2e15ae3608bf3"} build_url:https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/XLlEPXkoRAKodq0Cv4V10g/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/af6ae32855c9e4f7092c115db1feb29a9069edfdad3d163b2db8b982b19cc241012173600d19f40c9d2d376eea21cbbc376ecf44e9d321548dd367bb5f770560", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ad29a7de1380323fed3a108b6d950ef6c177eb03576bb3c015d21af993b839a86a15b4164f4a2de3d943bec60d79377529c5b157e9abeef10fb2e15ae3608bf3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 09:08:25.542485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 09:08:25.542832) ========= 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=52faae308a556c440401f8e5000001e8-1452098832.647337-1481471856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 09:08:25.627408) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 09:08:25.627839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 09:08:25.628179) ========= ========= Total master_lag: 0.22 =========