builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1452516549.91 results: success (0) buildid: 20160111032131 builduid: ff68467f2f404aa483a43d0f108592d6 revision: 482979bdfdca489e2e0a3d67f1039a1c9e74b0db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.914012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.914498) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.914788) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004912 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.938860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.939156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.953374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:09.953884) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004658 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.003016) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.003305) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.003661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.003929) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 04:49:10-- 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% 35.5M=0s 2016-01-11 04:49:10 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167521 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.184016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.184367) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.235733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:10.236123) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 482979bdfdca489e2e0a3d67f1039a1c9e74b0db --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 482979bdfdca489e2e0a3d67f1039a1c9e74b0db --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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 04:49:11,018 truncating revision to first 12 chars 2016-01-11 04:49:11,018 Setting DEBUG logging. 2016-01-11 04:49:11,018 attempt 1/10 2016-01-11 04:49:11,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/482979bdfdca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 04:49:11,285 unpacking tar archive at: b2g-inbound-482979bdfdca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.923479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:11.173666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:11.174119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:11.183291) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:11.183674) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:49:11.184220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-11 04:49:11.184602) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:12 INFO - MultiFileLogger online at 20160111 04:49:12 in /builds/slave/test 04:49:12 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 04:49:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:12 INFO - {'append_to_log': False, 04:49:12 INFO - 'base_work_dir': '/builds/slave/test', 04:49:12 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 04:49:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:12 INFO - 'branch': 'B2G-Inbound-Non-PGO', 04:49:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:12 INFO - 'config_files': ('talos/linux_config.py',), 04:49:12 INFO - 'default_actions': ('clobber', 04:49:12 INFO - 'read-buildbot-config', 04:49:12 INFO - 'download-and-extract', 04:49:12 INFO - 'populate-webroot', 04:49:12 INFO - 'create-virtualenv', 04:49:12 INFO - 'install', 04:49:12 INFO - 'run-tests'), 04:49:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:12 INFO - 'download_minidump_stackwalk': True, 04:49:12 INFO - 'download_symbols': 'ondemand', 04:49:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:12 INFO - 'installer_path': 'installer.exe', 04:49:12 INFO - 'log_level': 'info', 04:49:12 INFO - 'log_name': 'talos', 04:49:12 INFO - 'log_to_console': True, 04:49:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:12 INFO - 'opt_config_files': (), 04:49:12 INFO - 'pip_index': False, 04:49:12 INFO - 'sps_profile': False, 04:49:12 INFO - 'sps_profile_interval': 0, 04:49:12 INFO - 'suite': 'dromaeojs', 04:49:12 INFO - 'system_bits': '32', 04:49:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:12 INFO - 'title': 'talos-linux64-ix-057', 04:49:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:12 INFO - 'use_talos_json': True, 04:49:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:12 INFO - 'work_dir': 'build'} 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running clobber step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: clobber 04:49:12 INFO - rmtree: /builds/slave/test/build 04:49:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:12 INFO - Running post-action listener: _resource_record_post_action 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running read-buildbot-config step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: read_buildbot_config 04:49:12 INFO - Using buildbot properties: 04:49:12 INFO - { 04:49:12 INFO - "project": "", 04:49:12 INFO - "product": "firefox", 04:49:12 INFO - "script_repo_revision": "production", 04:49:12 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:49:12 INFO - "repository": "", 04:49:12 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 04:49:12 INFO - "buildid": "20160111032131", 04:49:12 INFO - "pgo_build": "False", 04:49:12 INFO - "basedir": "/builds/slave/test", 04:49:12 INFO - "buildnumber": 332, 04:49:12 INFO - "slavename": "talos-linux64-ix-057", 04:49:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:49:12 INFO - "platform": "ubuntu64_hw", 04:49:12 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 04:49:12 INFO - "branch": "b2g-inbound", 04:49:12 INFO - "repo_path": "integration/b2g-inbound", 04:49:12 INFO - "revision": "482979bdfdca489e2e0a3d67f1039a1c9e74b0db", 04:49:12 INFO - "stage_platform": "linux64", 04:49:12 INFO - "builduid": "ff68467f2f404aa483a43d0f108592d6", 04:49:12 INFO - "slavebuilddir": "test" 04:49:12 INFO - } 04:49:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:49:12 INFO - Running post-action listener: _resource_record_post_action 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running download-and-extract step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: download_and_extract 04:49:12 INFO - mkdir: /builds/slave/test/build/tests 04:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:12 INFO - https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/test_packages.json 04:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/test_packages.json 04:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:49:13 INFO - Downloaded 1302 bytes. 04:49:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:49:13 INFO - Using the following test package requirements: 04:49:13 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:49:13 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:49:13 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'jsshell-linux-x86_64.zip'], 04:49:13 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:49:13 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:49:13 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:49:13 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:49:13 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:49:13 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:49:13 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:49:13 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:49:13 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')]} 04:49:13 INFO - https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:15 INFO - Downloaded 22761327 bytes. 04:49:15 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 04:49:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:49:15 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 04:49:16 INFO - Return code: 0 04:49:16 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 04:49: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')]} 04:49:16 INFO - https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:19 INFO - Downloaded 22761327 bytes. 04:49: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 04:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:49: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 04:49:20 INFO - Return code: 0 04:49: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')]} 04:49:20 INFO - https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:49:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:49:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:49:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:22 INFO - Downloaded 11132285 bytes. 04:49:22 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 04:49:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:49:22 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 04:49:22 INFO - Return code: 0 04:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:22 INFO - https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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 04:49:25 INFO - Downloaded 54053569 bytes. 04:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:49:25 INFO - mkdir: /builds/slave/test/properties 04:49:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:25 INFO - Contents: 04:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:49:25 INFO - Running post-action listener: _resource_record_post_action 04:49:25 INFO - Running post-action listener: set_extra_try_arguments 04:49:25 INFO - ##### 04:49:25 INFO - ##### Running populate-webroot step. 04:49:25 INFO - ##### 04:49:25 INFO - Running pre-action listener: _resource_record_pre_action 04:49:25 INFO - Running main action method: populate_webroot 04:49:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:25 INFO - '--tppagecycles', 04:49:25 INFO - '7'], 04:49:25 INFO - 'tests': ['tsvgm']}}, 04:49:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:49:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:49:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:49:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'tests': ['damp', 'tps']}, 04:49:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['damp', 'tps']}, 04:49:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:49:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:25 INFO - 'other': {'tests': ['a11yr', 04:49:25 INFO - 'ts_paint', 04:49:25 INFO - 'tpaint', 04:49:25 INFO - 'sessionrestore', 04:49:25 INFO - 'sessionrestore_no_auto_restore']}, 04:49:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['a11yr', 04:49:25 INFO - 'ts_paint', 04:49:25 INFO - 'tpaint', 04:49:25 INFO - 'sessionrestore', 04:49:25 INFO - 'sessionrestore_no_auto_restore']}, 04:49:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['a11yr', 04:49:25 INFO - 'ts_paint', 04:49:25 INFO - 'tpaint', 04:49:25 INFO - 'sessionrestore', 04:49:25 INFO - 'sessionrestore_no_auto_restore']}, 04:49:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['a11yr', 04:49:25 INFO - 'ts_paint', 04:49:25 INFO - 'tpaint', 04:49:25 INFO - 'sessionrestore', 04:49:25 INFO - 'sessionrestore_no_auto_restore']}, 04:49:25 INFO - 'other_l64': {'tests': ['a11yr', 04:49:25 INFO - 'ts_paint', 04:49:25 INFO - 'tpaint', 04:49:25 INFO - 'sessionrestore', 04:49:25 INFO - 'sessionrestore_no_auto_restore']}, 04:49:25 INFO - 'other_nol64': {'tests': ['a11yr', 04:49:25 INFO - 'ts_paint', 04:49:25 INFO - 'tpaint', 04:49:25 INFO - 'sessionrestore', 04:49:25 INFO - 'sessionrestore_no_auto_restore']}, 04:49:25 INFO - 'svgr': {'tests': ['tsvgx', 04:49:25 INFO - 'tsvgr_opacity', 04:49:25 INFO - 'tart', 04:49:25 INFO - 'tscrollx', 04:49:25 INFO - 'cart']}, 04:49:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['tsvgx', 04:49:25 INFO - 'tsvgr_opacity', 04:49:25 INFO - 'tart', 04:49:25 INFO - 'tscrollx', 04:49:25 INFO - 'cart']}, 04:49:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'tests': ['tp5o']}, 04:49:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'talos_options': ['--e10s'], 04:49:25 INFO - 'tests': ['tp5o']}, 04:49:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'talos_options': ['--xperf_path', 04:49:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:25 INFO - 'tests': ['tp5n']}, 04:49:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:25 INFO - 'talos_options': ['--e10s', 04:49:25 INFO - '--xperf_path', 04:49:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:25 INFO - 'tests': ['tp5n']}}, 04:49:25 INFO - 'talos.zip': {'path': '', 04:49:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:25 INFO - Running post-action listener: _resource_record_post_action 04:49:25 INFO - ##### 04:49:25 INFO - ##### Running create-virtualenv step. 04:49:25 INFO - ##### 04:49:25 INFO - Running pre-action listener: _resource_record_pre_action 04:49:25 INFO - Running main action method: create_virtualenv 04:49:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:25 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 04:49:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:25 INFO - Using real prefix '/usr' 04:49:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:27 INFO - Installing pip.................done. 04:49:27 INFO - Return code: 0 04:49:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:27 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')]} 04:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:27 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')]} 04:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:27 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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49:27 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 04:49:27 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 04:49:27 INFO - Using env: {'DISPLAY': ':0', 04:49:27 INFO - 'HOME': '/home/cltbld', 04:49:27 INFO - 'LANG': 'en_US.UTF-8', 04:49:27 INFO - 'LANGUAGE': 'en_US:en', 04:49:27 INFO - 'LOGNAME': 'cltbld', 04:49:27 INFO - 'MAIL': '/var/mail/cltbld', 04:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:27 INFO - 'MOZ_NO_REMOTE': '1', 04:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:27 INFO - 'NO_EM_RESTART': '1', 04:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:27 INFO - 'PWD': '/builds/slave/test', 04:49:27 INFO - 'SHELL': '/bin/bash', 04:49:27 INFO - 'SHLVL': '1', 04:49:27 INFO - 'TERM': 'linux', 04:49:27 INFO - 'TMOUT': '86400', 04:49:27 INFO - 'USER': 'cltbld', 04:49:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:27 INFO - '_': '/tools/buildbot/bin/python'} 04:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:28 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 04:49:28 INFO - Cleaning up... 04:49:28 INFO - Return code: 0 04:49:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', '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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:49: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 psutil>=0.7.1 04:49:28 INFO - Using env: {'DISPLAY': ':0', 04:49:28 INFO - 'HOME': '/home/cltbld', 04:49:28 INFO - 'LANG': 'en_US.UTF-8', 04:49:28 INFO - 'LANGUAGE': 'en_US:en', 04:49:28 INFO - 'LOGNAME': 'cltbld', 04:49:28 INFO - 'MAIL': '/var/mail/cltbld', 04:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:28 INFO - 'MOZ_NO_REMOTE': '1', 04:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:28 INFO - 'NO_EM_RESTART': '1', 04:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:28 INFO - 'PWD': '/builds/slave/test', 04:49:28 INFO - 'SHELL': '/bin/bash', 04:49:28 INFO - 'SHLVL': '1', 04:49:28 INFO - 'TERM': 'linux', 04:49:28 INFO - 'TMOUT': '86400', 04:49:28 INFO - 'USER': 'cltbld', 04:49:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:28 INFO - '_': '/tools/buildbot/bin/python'} 04:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:28 INFO - Downloading/unpacking psutil>=0.7.1 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:49:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:30 INFO - Installing collected packages: psutil 04:49:30 INFO - Running setup.py install for psutil 04:49:30 INFO - building 'psutil._psutil_linux' extension 04:49:30 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 04:49:30 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 04:49:30 INFO - building 'psutil._psutil_posix' extension 04:49:30 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 04:49:30 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 04:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:30 INFO - Successfully installed psutil 04:49:30 INFO - Cleaning up... 04:49:30 INFO - Return code: 0 04:49:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', '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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:49: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 mozsystemmonitor==0.0.0 04:49:30 INFO - Using env: {'DISPLAY': ':0', 04:49:30 INFO - 'HOME': '/home/cltbld', 04:49:30 INFO - 'LANG': 'en_US.UTF-8', 04:49:30 INFO - 'LANGUAGE': 'en_US:en', 04:49:30 INFO - 'LOGNAME': 'cltbld', 04:49:30 INFO - 'MAIL': '/var/mail/cltbld', 04:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:30 INFO - 'MOZ_NO_REMOTE': '1', 04:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:30 INFO - 'NO_EM_RESTART': '1', 04:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:30 INFO - 'PWD': '/builds/slave/test', 04:49:30 INFO - 'SHELL': '/bin/bash', 04:49:30 INFO - 'SHLVL': '1', 04:49:30 INFO - 'TERM': 'linux', 04:49:30 INFO - 'TMOUT': '86400', 04:49:30 INFO - 'USER': 'cltbld', 04:49:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:30 INFO - '_': '/tools/buildbot/bin/python'} 04:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:49:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:49:32 INFO - Installing collected packages: mozsystemmonitor 04:49:32 INFO - Running setup.py install for mozsystemmonitor 04:49:32 INFO - Successfully installed mozsystemmonitor 04:49:32 INFO - Cleaning up... 04:49:32 INFO - Return code: 0 04:49:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49:32 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 04:49:32 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 04:49:32 INFO - Using env: {'DISPLAY': ':0', 04:49:32 INFO - 'HOME': '/home/cltbld', 04:49:32 INFO - 'LANG': 'en_US.UTF-8', 04:49:32 INFO - 'LANGUAGE': 'en_US:en', 04:49:32 INFO - 'LOGNAME': 'cltbld', 04:49:32 INFO - 'MAIL': '/var/mail/cltbld', 04:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:32 INFO - 'MOZ_NO_REMOTE': '1', 04:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:32 INFO - 'NO_EM_RESTART': '1', 04:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:32 INFO - 'PWD': '/builds/slave/test', 04:49:32 INFO - 'SHELL': '/bin/bash', 04:49:32 INFO - 'SHLVL': '1', 04:49:32 INFO - 'TERM': 'linux', 04:49:32 INFO - 'TMOUT': '86400', 04:49:32 INFO - 'USER': 'cltbld', 04:49:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:32 INFO - '_': '/tools/buildbot/bin/python'} 04:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:35 INFO - Downloading docopt-0.6.1.tar.gz 04:49:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:35 INFO - Running setup.py install for blobuploader 04:49:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:35 INFO - Running setup.py install for requests 04:49:35 INFO - Running setup.py install for docopt 04:49:35 INFO - Successfully installed blobuploader requests docopt 04:49:35 INFO - Cleaning up... 04:49:35 INFO - Return code: 0 04:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:35 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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49:35 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 04:49:35 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 04:49:35 INFO - Using env: {'DISPLAY': ':0', 04:49:35 INFO - 'HOME': '/home/cltbld', 04:49:35 INFO - 'LANG': 'en_US.UTF-8', 04:49:35 INFO - 'LANGUAGE': 'en_US:en', 04:49:35 INFO - 'LOGNAME': 'cltbld', 04:49:35 INFO - 'MAIL': '/var/mail/cltbld', 04:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:35 INFO - 'MOZ_NO_REMOTE': '1', 04:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:35 INFO - 'NO_EM_RESTART': '1', 04:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:35 INFO - 'PWD': '/builds/slave/test', 04:49:35 INFO - 'SHELL': '/bin/bash', 04:49:35 INFO - 'SHLVL': '1', 04:49:35 INFO - 'TERM': 'linux', 04:49:35 INFO - 'TMOUT': '86400', 04:49:35 INFO - 'USER': 'cltbld', 04:49:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:35 INFO - '_': '/tools/buildbot/bin/python'} 04:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:36 INFO - Running setup.py (path:/tmp/pip-e4MWVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:36 INFO - Running setup.py (path:/tmp/pip-AAHwGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:36 INFO - Running setup.py (path:/tmp/pip-pDJoq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:36 INFO - Running setup.py (path:/tmp/pip-HgmEuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:36 INFO - Running setup.py (path:/tmp/pip-EIIpxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:36 INFO - Running setup.py (path:/tmp/pip-Zgfu3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:36 INFO - Running setup.py (path:/tmp/pip-tgabSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:36 INFO - Running setup.py (path:/tmp/pip-5M1no7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:36 INFO - Running setup.py (path:/tmp/pip-uLUl5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:36 INFO - Running setup.py (path:/tmp/pip-_DQH2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:36 INFO - Running setup.py (path:/tmp/pip-i4OnTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:36 INFO - Running setup.py (path:/tmp/pip-813nO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:37 INFO - Running setup.py (path:/tmp/pip-LwMYm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:37 INFO - Running setup.py (path:/tmp/pip-CT2J8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:37 INFO - Running setup.py (path:/tmp/pip-dgEodH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:37 INFO - Running setup.py (path:/tmp/pip-NornTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:37 INFO - Running setup.py (path:/tmp/pip-NNBz1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:37 INFO - Running setup.py install for manifestparser 04:49:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for mozcrash 04:49:37 INFO - Running setup.py install for mozdebug 04:49:37 INFO - Running setup.py install for mozdevice 04:49:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for mozfile 04:49:37 INFO - Running setup.py install for mozhttpd 04:49:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for mozinfo 04:49:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Running setup.py install for mozInstall 04:49:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Running setup.py install for mozleak 04:49:38 INFO - Running setup.py install for mozlog 04:49:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Running setup.py install for moznetwork 04:49:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Running setup.py install for mozprocess 04:49:38 INFO - Running setup.py install for mozprofile 04:49:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Running setup.py install for mozrunner 04:49:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:38 INFO - Running setup.py install for mozscreenshot 04:49:38 INFO - Running setup.py install for moztest 04:49:39 INFO - Running setup.py install for mozversion 04:49:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:39 INFO - Cleaning up... 04:49:39 INFO - Return code: 0 04:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:39 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')]} 04:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:39 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')]} 04:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:39 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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49:39 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 04:49:39 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 04:49:39 INFO - Using env: {'DISPLAY': ':0', 04:49:39 INFO - 'HOME': '/home/cltbld', 04:49:39 INFO - 'LANG': 'en_US.UTF-8', 04:49:39 INFO - 'LANGUAGE': 'en_US:en', 04:49:39 INFO - 'LOGNAME': 'cltbld', 04:49:39 INFO - 'MAIL': '/var/mail/cltbld', 04:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:39 INFO - 'MOZ_NO_REMOTE': '1', 04:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:39 INFO - 'NO_EM_RESTART': '1', 04:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:39 INFO - 'PWD': '/builds/slave/test', 04:49:39 INFO - 'SHELL': '/bin/bash', 04:49:39 INFO - 'SHLVL': '1', 04:49:39 INFO - 'TERM': 'linux', 04:49:39 INFO - 'TMOUT': '86400', 04:49:39 INFO - 'USER': 'cltbld', 04:49:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:39 INFO - '_': '/tools/buildbot/bin/python'} 04:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:39 INFO - Running setup.py (path:/tmp/pip-nqnYYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:39 INFO - Running setup.py (path:/tmp/pip-i9mMcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:39 INFO - Running setup.py (path:/tmp/pip-NaZ3NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:39 INFO - Running setup.py (path:/tmp/pip-TMhGb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:39 INFO - Running setup.py (path:/tmp/pip-O_9ByQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:39 INFO - Running setup.py (path:/tmp/pip-Uv881p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:39 INFO - Running setup.py (path:/tmp/pip-u3IM6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:39 INFO - Running setup.py (path:/tmp/pip-82G3_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:39 INFO - Running setup.py (path:/tmp/pip-bgxG2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:40 INFO - Running setup.py (path:/tmp/pip-vZ7sHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:40 INFO - Running setup.py (path:/tmp/pip-g6iW9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:40 INFO - Running setup.py (path:/tmp/pip-D1QOws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:40 INFO - Running setup.py (path:/tmp/pip-VKQvAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:40 INFO - Running setup.py (path:/tmp/pip-SSeGpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:40 INFO - Running setup.py (path:/tmp/pip-jojAIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:40 INFO - Running setup.py (path:/tmp/pip-nHjhbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:40 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)) 04:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:40 INFO - Running setup.py (path:/tmp/pip-1tVNK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:40 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)) 04:49:40 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)) 04:49:40 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)) 04:49:40 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)) 04:49:40 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)) 04:49:40 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)) 04:49:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:40 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 04:49:40 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 04:49:40 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 04:49:40 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 04:49:40 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 04:49:40 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 04:49:42 INFO - Downloading blessings-1.5.1.tar.gz 04:49:42 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 04:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:42 INFO - Installing collected packages: blessings 04:49:42 INFO - Running setup.py install for blessings 04:49:42 INFO - Successfully installed blessings 04:49:42 INFO - Cleaning up... 04:49:42 INFO - Return code: 0 04:49:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:42 INFO - Reading from file tmpfile_stdout 04:49:42 INFO - Current package versions: 04:49:42 INFO - argparse == 1.2.1 04:49:42 INFO - blessings == 1.5.1 04:49:42 INFO - blobuploader == 1.2.4 04:49:42 INFO - docopt == 0.6.1 04:49:42 INFO - manifestparser == 1.1 04:49:42 INFO - mozInstall == 1.12 04:49:42 INFO - mozcrash == 0.16 04:49:42 INFO - mozdebug == 0.1 04:49:42 INFO - mozdevice == 0.47 04:49:42 INFO - mozfile == 1.2 04:49:42 INFO - mozhttpd == 0.7 04:49:42 INFO - mozinfo == 0.9 04:49:42 INFO - mozleak == 0.1 04:49:42 INFO - mozlog == 3.1 04:49:42 INFO - moznetwork == 0.27 04:49:42 INFO - mozprocess == 0.22 04:49:42 INFO - mozprofile == 0.28 04:49:42 INFO - mozrunner == 6.11 04:49:42 INFO - mozscreenshot == 0.1 04:49:42 INFO - mozsystemmonitor == 0.0 04:49:42 INFO - moztest == 0.7 04:49:42 INFO - mozversion == 1.4 04:49:42 INFO - psutil == 3.1.1 04:49:42 INFO - requests == 1.2.3 04:49:42 INFO - wsgiref == 0.1.2 04:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:42 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')]} 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 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')]} 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 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 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49:42 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 04:49:42 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 04:49:42 INFO - Using env: {'DISPLAY': ':0', 04:49:42 INFO - 'HOME': '/home/cltbld', 04:49:42 INFO - 'LANG': 'en_US.UTF-8', 04:49:42 INFO - 'LANGUAGE': 'en_US:en', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MAIL': '/var/mail/cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SHLVL': '1', 04:49:42 INFO - 'TERM': 'linux', 04:49:42 INFO - 'TMOUT': '86400', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - '_': '/tools/buildbot/bin/python'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 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)) 04:49:42 INFO - Cleaning up... 04:49:43 INFO - Return code: 0 04:49:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49: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', 'jsonschema'] in /builds/slave/test/build 04:49: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 jsonschema 04:49:43 INFO - Using env: {'DISPLAY': ':0', 04:49:43 INFO - 'HOME': '/home/cltbld', 04:49:43 INFO - 'LANG': 'en_US.UTF-8', 04:49:43 INFO - 'LANGUAGE': 'en_US:en', 04:49:43 INFO - 'LOGNAME': 'cltbld', 04:49:43 INFO - 'MAIL': '/var/mail/cltbld', 04:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:43 INFO - 'MOZ_NO_REMOTE': '1', 04:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:43 INFO - 'NO_EM_RESTART': '1', 04:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:43 INFO - 'PWD': '/builds/slave/test', 04:49:43 INFO - 'SHELL': '/bin/bash', 04:49:43 INFO - 'SHLVL': '1', 04:49:43 INFO - 'TERM': 'linux', 04:49:43 INFO - 'TMOUT': '86400', 04:49:43 INFO - 'USER': 'cltbld', 04:49:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:43 INFO - '_': '/tools/buildbot/bin/python'} 04:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:43 INFO - Downloading/unpacking jsonschema 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:44 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 04:49:44 INFO - Downloading/unpacking functools32 (from jsonschema) 04:49:44 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 04:49:44 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 04:49:44 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 04:49:44 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 04:49:44 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 04:49:44 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 04:49:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:45 INFO - warning: no files found matching '*.txt' 04:49:45 INFO - no previously-included directories found matching 'build' 04:49:45 INFO - no previously-included directories found matching 'dist' 04:49:45 INFO - no previously-included directories found matching '.git*' 04:49:45 INFO - Installing collected packages: jsonschema, functools32 04:49:45 INFO - Running setup.py install for functools32 04:49:45 INFO - warning: no files found matching '*.txt' 04:49:45 INFO - no previously-included directories found matching 'build' 04:49:45 INFO - no previously-included directories found matching 'dist' 04:49:45 INFO - no previously-included directories found matching '.git*' 04:49:45 INFO - Successfully installed jsonschema functools32 04:49:45 INFO - Cleaning up... 04:49:45 INFO - Return code: 0 04:49:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86f596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', '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 04:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:49:45 INFO - Using env: {'DISPLAY': ':0', 04:49:45 INFO - 'HOME': '/home/cltbld', 04:49:45 INFO - 'LANG': 'en_US.UTF-8', 04:49:45 INFO - 'LANGUAGE': 'en_US:en', 04:49:45 INFO - 'LOGNAME': 'cltbld', 04:49:45 INFO - 'MAIL': '/var/mail/cltbld', 04:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:45 INFO - 'MOZ_NO_REMOTE': '1', 04:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:45 INFO - 'NO_EM_RESTART': '1', 04:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:45 INFO - 'PWD': '/builds/slave/test', 04:49:45 INFO - 'SHELL': '/bin/bash', 04:49:45 INFO - 'SHLVL': '1', 04:49:45 INFO - 'TERM': 'linux', 04:49:45 INFO - 'TMOUT': '86400', 04:49:45 INFO - 'USER': 'cltbld', 04:49:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:45 INFO - '_': '/tools/buildbot/bin/python'} 04:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:45 INFO - Downloading/unpacking flake8 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:49:47 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 04:49:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:49:47 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 04:49:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 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 04:49:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:49:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:47 INFO - no previously-included directories found matching 'docs/_build' 04:49:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:49:48 INFO - Running setup.py install for pep8 04:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:48 INFO - no previously-included directories found matching 'docs/_build' 04:49:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:49:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:49:48 INFO - Cleaning up... 04:49:48 INFO - Return code: 0 04:49:48 INFO - Running post-action listener: _resource_record_post_action 04:49:48 INFO - Running post-action listener: _start_resource_monitoring 04:49:48 INFO - Starting resource monitoring. 04:49:48 INFO - ##### 04:49:48 INFO - ##### Running install step. 04:49:48 INFO - ##### 04:49:48 INFO - Running pre-action listener: _resource_record_pre_action 04:49:48 INFO - Running main action method: install 04:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:48 INFO - Reading from file tmpfile_stdout 04:49:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:48 INFO - Reading from file tmpfile_stdout 04:49:48 INFO - Output received: 04:49:48 INFO - Usage: mozinstall [options] installer 04:49:48 INFO - Options: 04:49:48 INFO - -h, --help show this help message and exit 04:49:48 INFO - -d DEST, --destination=DEST 04:49:48 INFO - Directory to install application into. [default: 04:49:48 INFO - "/builds/slave/test"] 04:49:48 INFO - --app=APP Application being installed. [default: firefox] 04:49:48 INFO - mkdir: /builds/slave/test/build/application 04:49:48 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'] 04:49:48 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 04:50:04 INFO - Reading from file tmpfile_stdout 04:50:04 INFO - Output received: 04:50:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:50:04 INFO - Running post-action listener: _resource_record_post_action 04:50:04 INFO - ##### 04:50:04 INFO - ##### Running run-tests step. 04:50:04 INFO - ##### 04:50:04 INFO - Running pre-action listener: _resource_record_pre_action 04:50:04 INFO - Running main action method: run_tests 04:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:04 INFO - Python 2.7.3 04:50:04 INFO - Return code: 0 04:50:04 INFO - grabbing minidump binary from tooltool 04:50:04 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')]} 04:50:04 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 0x13d03d0>, '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 0x133bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:04 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 04:50:04 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 04:50:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:04 INFO - Return code: 0 04:50:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:50:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:50:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:50:05 INFO - Return code: 0 04:50:05 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/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:50:05 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/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 04:50:05 INFO - Using env: {'DISPLAY': ':0', 04:50:05 INFO - 'HOME': '/home/cltbld', 04:50:05 INFO - 'LANG': 'en_US.UTF-8', 04:50:05 INFO - 'LANGUAGE': 'en_US:en', 04:50:05 INFO - 'LOGNAME': 'cltbld', 04:50:05 INFO - 'MAIL': '/var/mail/cltbld', 04:50:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:05 INFO - 'MOZ_NO_REMOTE': '1', 04:50:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:05 INFO - 'NO_EM_RESTART': '1', 04:50:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:05 INFO - 'PWD': '/builds/slave/test', 04:50:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:05 INFO - 'SHELL': '/bin/bash', 04:50:05 INFO - 'SHLVL': '1', 04:50:05 INFO - 'TERM': 'linux', 04:50:05 INFO - 'TMOUT': '86400', 04:50:05 INFO - 'USER': 'cltbld', 04:50:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995', 04:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:05 INFO - '_': '/tools/buildbot/bin/python'} 04:50:05 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/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:50:05 INFO - mozversion application_buildid: 20160111032131 04:50:05 INFO - mozversion application_changeset: 482979bdfdca489e2e0a3d67f1039a1c9e74b0db 04:50:05 INFO - mozversion application_display_name: Nightly 04:50:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:05 INFO - mozversion application_name: Firefox 04:50:05 INFO - mozversion application_remotingname: firefox 04:50:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:50:05 INFO - mozversion application_vendor: Mozilla 04:50:05 INFO - mozversion application_version: 46.0a1 04:50:05 INFO - mozversion platform_buildid: 20160111032131 04:50:05 INFO - mozversion platform_changeset: 482979bdfdca489e2e0a3d67f1039a1c9e74b0db 04:50:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:50:05 INFO - mozversion platform_version: 46.0a1 04:50:05 INFO - using testdate: 1452516605 04:50:05 INFO - actual date: 1452516605 04:50:07 INFO - starting webserver on 'localhost:51385' 04:50:07 INFO - SUITE-START | Running 3 tests 04:50:07 INFO - TEST-START | dromaeo_css 04:50:07 INFO - operating with platform_type : linux_ 04:50:07 INFO - Initialising browser for dromaeo_css test... 04:50:07 INFO - TEST-INFO | started process 28794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxgMc3i/profile http://localhost:51385/getInfo.html) 04:50:11 INFO - PROCESS | 28794 | __metrics Screen width/height:1600/1200 04:50:11 INFO - PROCESS | 28794 | colorDepth:24 04:50:11 INFO - PROCESS | 28794 | Browser inner width/height: 1024/697 04:50:11 INFO - PROCESS | 28794 | __metrics 04:50:11 INFO - PROCESS | 28794 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:50:11 INFO - PROCESS | 28794 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:12 INFO - TEST-INFO | 28794: exit 0 04:50:12 INFO - Browser initialized. 04:50:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:12 INFO - TEST-INFO | started process 28889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxgMc3i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:24 INFO - PROCESS | 28889 | RSS: Main: 149037056 04:50:24 INFO - PROCESS | 28889 | 04:51:16 INFO - PROCESS | 28889 | 1452516676078 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] 04:53:28 INFO - PROCESS | 28889 | Cycle 1(1): loaded http://localhost:51385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51385/tests/dromaeo/cssquery-ext.html) 04:53:29 INFO - PROCESS | 28889 | RSS: Main: 244715520 04:53:29 INFO - PROCESS | 28889 | 04:56:31 INFO - PROCESS | 28889 | Cycle 1(1): loaded http://localhost:51385/tests/dromaeo/cssquery-ext.html (next: http://localhost:51385/tests/dromaeo/cssquery-jquery.html) 04:56:32 INFO - PROCESS | 28889 | RSS: Main: 238153728 04:56:32 INFO - PROCESS | 28889 | 04:59:34 INFO - PROCESS | 28889 | Cycle 1(1): loaded http://localhost:51385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51385/tests/dromaeo/cssquery-mootools.html) 04:59:35 INFO - PROCESS | 28889 | RSS: Main: 234745856 04:59:35 INFO - PROCESS | 28889 | 05:02:37 INFO - PROCESS | 28889 | Cycle 1(1): loaded http://localhost:51385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51385/tests/dromaeo/cssquery-prototype.html) 05:02:37 INFO - PROCESS | 28889 | RSS: Main: 214528000 05:02:37 INFO - PROCESS | 28889 | 05:05:40 INFO - PROCESS | 28889 | Cycle 1(1): loaded http://localhost:51385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51385/tests/dromaeo/cssquery-yui.html) 05:05:41 INFO - PROCESS | 28889 | RSS: Main: 215261184 05:05:41 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | Cycle 1(1): loaded http://localhost:51385/tests/dromaeo/cssquery-yui.html (next: http://localhost:51385/tests/dromaeo/cssquery-dojo.html) 05:08:43 INFO - PROCESS | 28889 | RSS: Main: 248500224 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | __start_tp_report 05:08:43 INFO - PROCESS | 28889 | _x_x_mozilla_page_load 05:08:43 INFO - PROCESS | 28889 | _x_x_mozilla_page_load_details 05:08:43 INFO - PROCESS | 28889 | |i|pagename|runs| 05:08:43 INFO - PROCESS | 28889 | |0;dojo.html;2578.417725624024;2689.6503454550916;2689.784817214623;2705.1884434669605;2713.4708731797296;4478.955210447894;4606.401167848179;4609.308603709445;4625.051864367801;4636;4521.434820647419;4606.884827879305;4613.054323863608;4646.512116227798;4682.836100736475;4133.793310334487;4217.85237516687;4261.87214383569;4269.850555230568;4304.139172165564;4272.935905961397;4346.6739994500385;4347.260965635834;4348.9782551087355;4358.259095953696;4122.484689413824;4211.136716973013;4213.325867861158;4223.070924396628;4298.871033868989;4267.97866010668;4280.5719428057255;4304.4834619845815;4312.417823593806;4317.050248945227;4247.086876321606;4257.638100761408;4264.637505812009;4284.143171365708;4300.483941926957;4346.8043938022865;4456.598906098467;4459.019015816515;4465.397171381855;4633.212353899845;4837.540433658797;4872.6832755870755;4874.195757699975;4878.414590249157;4923.384576927884;4918.139325618003;4919.483454237289;4919.7540122993705;4922.532359425884;4961.627877909135;4450.755208463565;4541.477730061019;4551.544845515488;4560.954390456053;4612.58486736192;4979.228219625964;4984.152694042022;4993.350864387679;5041.420236672756;5043.268726034705;4800.855974320776;4804.2073057945045;4806.639502037361;4831.4202295724735;4851.611871050308;4811.759412029384;4899.681520701214;4928.704277743347;4932.26016097581;4932.334134891816;4875.195592727231;4948.331975183304;4958.677685950402;4986.551210391082;4994.90010199794;4875.780589873464;4881.925976285212;4888.9755551222015;4893.902121957541;4936.333594964705;4064.3293856513937;4199.853005144866;4208.284591619432;4209.410682504452;4233.216854881856;3608.927821443609;3622.855085796539;3651.2879988402537;3689.3912504436466;3698.964289998805;4257.042165512735;4279.443672322578;4284.464441944757;4285.196458630219;4316.028893499;4963.032208719265;4963.776630051656;4971.676841005323;4974.875628109254;4991.176455884811;4102.097538541516;4166.791660416967;4201.87394378163;4202.411662367271;4260.701750877471;4463.397441345442;4473.776311184428;4479.977600111979;4495.887602809956;4530.977345113253;4722.55135762109;4725.9054818904115;4726.196546587157;4740.3837501124635;4767.261074533453;4779.856604301876;4899.853004409873;4903.092927808367;4918.2376731606655;4956.405231372259;4694.248920172892;4713.787879545497;4720.0323933592845;4721.929171062368;4756.9762151189025;4882.048000639841;4883.096627123993;4890.119778439915;4890.388701412324;4938.407391113089;4712.222483290218;4830.203016502378;4842;4865.489123641966;4961.479044700254;4773.9761301193275;4809.062232864558;4815.109204797123;4815.879603009953;4867.853964381075;4810.56704896547;4814.831480898151;4816.34979277793;4817.470078291455;4823.493533178966;4529.796159172911;4655.324977878121;4659.044895796286;4681.789319480564;4688.882777930579;4860.295257187759;4863.197572400514;4876.097921884463;4876.829310974099;4879.707217566957;4776.188048031773;4776.21192503233;4778.116048530894;4783.880402989953;4804.5435683611395 05:08:43 INFO - PROCESS | 28889 | |1;ext.html;472.38118065334413;481.0691312310679;488.3773189183792;489.8065264220632;512.9871753206168;24836.627450588232;25257.747422525794;25290.494190116187;25291.49417011663;32052.35895282093;35701.89428215756;36144;36166.8191659042;36196.09509762257;36308.81845590768;7619;7814.843703125934;7815.609219539028;7830.530168189898;7830.765077047698;6769.661516924134;7016.543924644881;9550;9746.90253097467;9797.06927841854;9655.951720241388;9731.270154738388;9750.561224744868;9767.316287859852;9808.264380171515;6817.181938167402;7029.718811247544;9239.122283383067;9303.860442093373;9329.440233585972;9498.857517137249;9808.803823923481;9820.361676491006;9820.4107753535;9821.656242031566;32854;33189.6681033189;33200;33262.168445788804;33306.500402493984;2742.424090940905;2786.9303267418272;3026;3137.1686503076476;3462.117160124177;25046.874765626057;25104.623430648557;25957.480850383075;27325.453490930267;27638.170854874385;3308.3714094322004;3434.5957829519434;3462.272922686239;3468.236987862666;3574.3208790330013;228259.60884693943;229093;229954;230026;230675;45162.774186129514;54756.524347564926;54929;55299.170512442346;55419.44580554224;40700.185996279906;64198;65829.34170658328;65837.67081164659;65908;12457.12800103984;12726.045546584044;12728.109032367645;12735.490580376681;12736.490540378467;9505.714828555154;9670.129688327943;9696.466694331879;9705.902940970642;9708.417494950325;18495.722564161548;18528.42508386775;18560.907195463937;18581.44255672332;18676.719849202273;6806.8298292542095;6969.756058537927;7069.434445244368;7195.352418282275;7207.423406127497;773.2190487607556;796.1451899148328;827.664795757719;840.9873851892227;961.4663861556903;25612;25953.22140335793;27231.319217019733;28367.29081772931;28811.279718006797;934.3786382055993;952.64752041745;1007.909288164054;1068.8770791358938;1096.4353358020626;12887.355632218352;12936.417861196269;13040.80438793419;13041.673958151123;13121.212727236396;255681;260228;260568;261475;261964;42840.14319713588;43030.35454468185;43121;43135.568644313156;43144.56855431406;1196.2224554039944;1211.309553554483;1211.3640338822013;1218.0560065948782;1340.028479352481;21306;23874.52250955006;24494;24795.87602061978;24989.87505062463;35201.82399087988;35792.64207357893;35889.46165807567;35895.28209435849;36011.819940900124;163151;163495.1825240914;163681;163918;163939;23505;24052.87973560191;26824.731752683005;27200.319992000357;27277.181684549494;34049.48925766165;35126.47310290399;35333;35369.115772105906;35576.28847423089;29230.415391691622;29959.899004901752;29989.400211996075;30301.636426360426;30585.847070764503;30173;30256.697433025387;30409.695903040687;30440;30536.389272214874;30033.549496758;30184.396312074074;30528.08415747531;30534.236644084074;30571;26494.730340884555;27503.724962750915;27652.446951060465;27663.44673106567;27699.86150069237;21763.932426419466;21996.450088747908;22038.559228815655;22067.558648827253;22082 05:08:43 INFO - PROCESS | 28889 | |2;jquery.html;335.22395654060864;336.2400973799213;336.4952571143285;338.0703066566941;342.0115865149716;11924.82112768307;12446.751064978718;14546.709065818677;14955.551333459987;14956.5513034609;9783.364081334708;9834.40993540388;10249;10290.176785857133;12024.639260822189;4316.072044510437;4485.641148708112;4493.820247190109;4493.820247190125;4494.8202071917085;3356.3790698720813;3514.0512061743316;4362.890927726817;5023.120953833083;5197.558207552363;5107.252298263539;5207.3490813648295;5216.321878155834;5233.947660523384;5236.895262094756;5657.547396208293;5766.538676905838;5799.072148456226;5799.3910639382675;5811.651300921937;4861.854144375674;5013.398392192924;5016;5117.795288188468;5118.692878427269;11639.534418623245;11819.409029548488;11832.940835295854;14965.625859353604;18237.7264341035;1633.8774591905656;1635.1660653066901;1680.7899012623423;1752.0801579171036;1769.4514700442903;8720.43317184381;8897.199252067345;9111.407758495743;9210.815783684357;12478.689737577604;1689.400262906675;1690.0318864584222;1732.7141021731525;1799.1543974332044;1807.1145138881984;48291.275630865566;50715.492845071814;50986.74506627443;51457;51670;9475.857862132074;9507.809843803085;9601.663941762004;9622.807543849083;9672.419654820733;12344.567940122231;12381.319027453577;12402.875971240172;12419.379031048411;12419.565315213924;6508.707108180143;6558.901616475757;6641.33586641332;6680.365365290289;6682.398584127452;6184.5980011299125;6190.380961903864;6245.937540624535;6253.343398943137;6268.717907694165;4028.7582745035393;4059;4076.898077548085;4116.897077573085;4144.150449157915;1559.8518140776607;1643.4248013195286;2743.492453896036;2793.8044336896223;2827.3497095668113;765.1201118713524;768.6233745464793;816.5713000674574;826.7023871406288;863.8574635185249;12692.301923394301;14032.228227447384;14323;14639.560813175622;14702.705945881022;791.9088859888512;811.0956283743701;896.5651658945407;899.7840518275567;950.092661508258;6269.7178626961895;8808.603612837438;8925.73222803317;8928.508932008803;9097.954510227406;450155;452169;469078;469981;471882;62129;64817.67591162108;65611.67194163999;65804.67097664576;66155;1099.406320586874;1100.884407137255;1115.0856297835696;1115.2193464574668;1117.1566914590828;13510.527131550742;13847.653808654864;13945.58163255104;13963.241520147756;14131.293435327987;32021.8398908004;32088.35823283568;32129;32405;32512.512312314862;41106.79446602748;42215.73352799421;42575;42583.57416425796;42698.57301426946;6474.773382931575;6502.739890404331;6641.169853768279;6651.933480665131;6837.735019021497;9101.681441149529;10041.744781902262;10330.121939635215;10397.11624511925;10587.258891877802;8571.657133714582;9024.007359190615;9032;9129.406588571721;9226.723198304062;8871.201591856763;9072.50101244438;9294.209992150743;9480.668176613786;9561.760955976157;5940.940590594038;8347.707830225912;8783.152020659276;8844.823103537765;9187.448753074837;6545.541812073109;6765.323467653196;6843.076184715199;6884.001819736211;6957.512974091967;8307.833843322978;8366.665333386596;8457.61940712657;8675.132486751274;8744.562771861509 05:08:43 INFO - PROCESS | 28889 | |3;mootools.html;1198.7482628647983;1391.6451304917248;1406.880415164711;1513.1450730337358;1707.2488105233704;6598.274189839114;7121.608311542863;7209.062821833168;7246.927530724691;7274.563526188433;7200.171980222276;7257.5282606630535;7284.417246620271;7287.890681639779;7289.416846652269;2138.422625891005;2165.263810304496;2165.8700477971374;2167.8374121940838;2184.8361372897098;2145.5279838435517;2169.5010147665967;2178.2485042660337;2179.1610230061383;2193.9122435102577;2161.3948094533557;2190.87950162741;2193.1008286602496;2201.0975500044983;2206.5476577301615;2200.04298130313;2200.6258935980923;2203.0967303405687;2205.492736670567;2207.128184367182;2073.968890466644;2113.2709215320688;2113.8837363944976;2115.079940226007;2116.333354993172;7770.49491783038;7802.063752349698;7823.687052517893;7832.765017049498;7838.8432231355055;4361.978190109061;4467.776611169461;4468.664850136221;4486.147631949919;4493.910121797546;2763.281546797827;2810.4519618674367;2904.564315352693;2908.9127326180246;2917.168606947031;881.4534988307227;917.3257655623112;918.3938600523622;1713.8029126650345;1718.2267979409316;9817.312788104835;9840.704778856645;9857.75355616101;9858.654947076819;9877.802443951152;3882.7087968402484;3917.4319723640483;3954.62431069048;3978.4827972363987;4044.2315959967514;8202.343812494986;8212.712555060543;8213.835723285501;8222.38332125093;8226.753197404087;4476.239039363316;4486.977565112219;4489.618382437529;4490.618297444688;4494.16857881293;3403.4724617684296;3475.6176820549717;3893.53277606689;4139;4139.296319625671;3279;3291.588551431071;3299.7690161688934;3305.5372247885316;3315.353506066294;873.8988874018783;960.188640598693;972.4457059476031;981.5828272983953;983.1839573154265;1133.4729350851894;1135.3131355529952;1156.5605070073486;1161.6282789507445;1162.9302241865514;6602.60384376939;6646.6042131153;6662.0340050692375;6669.466442684574;6679.398854103154;1016.832222683249;1021.6730646193296;1028.4098213137895;1035.0736091198335;1062.5377960587168;5587.972060139673;5679.204911312419;5688.061469857427;5694.345150307768;5696;9286.210672092948;9432.669856554987;9629.229661627052;9633.710988670351;9639.807203855884;9562.565615157642;9575.616975321049;9691.07934746198;9711.931687514369;9718.951405242928;6976.19773726028;7022.367986881205;7096.254893236239;7135.82160445993;7169.494406174762;6906.965465172642;6952.478564107813;6955.895661565181;6961;6961.199462061928;8312.792180195302;8524.190201930807;8619.353548483763;8631.827363452821;8652.480851148952;8443.493390396596;8567.357448191286;8585.141485851365;8586.184312490303;8591.097934716765;5358.437364076872;5505.779768809363;5988.191594134736;6126.387361263838;6242.28213755424;6813;6898.034275201576;6936.653167341512;6973.476989225727;6984;6238.75044998195;6384.425401713868;6391.424771770563;6429.292777794345;6479.2224933006455;6208.751649933952;6290.0879372491645;6306.432421082125;6309.873802523832;6411.102445657705;6491.35086491366;6526.543141980016;6540.901886471802;6652.669466106895;6656.600603963778;6239.563230573816;6268.968655156695;6328.272248691275;6333.936660633519;6334.606386594942;6240.251169859464;6285.779997700059;6288.434040936338;6301.8109456716375;6305.936940630535 05:08:43 INFO - PROCESS | 28889 | |4;prototype.html;304.16506689138316;308.9057837359606;314.6868865478849;316.3988421998202;319.8608605256712;5209.322788037554;5316.255724198606;5318.734063296829;5330.733463326833;5331.57347412207;5242.18746094355;5244.921326180111;5250.65870718403;5252.290940723001;5292.788288468457;3918.941215881764;4044.716869819114;4140.0891803803115;4143.150654115914;4146.63161156819;4057.573954734755;4112.6298633123015;4119.711620186573;4126.257273690734;4147.751134931914;4067.9186416271655;4069.2878746219294;4076.3274059780247;4096.40602112695;4098.692598055143;3896.084420161246;4002.579729128458;4013.7591744495426;4082.3060079786505;4098.467199264106;3608.116011577154;3612.3317186320614;3619.914025792252;3653.5615726113037;3654.4152935530456;5125.948740512585;5126.436092029874;5131;5143.794248230066;5150.871228219287;4813.687110337852;4829.9034019319415;4832.081904438145;4832.444268909086;4837.0567739290855;5529.170624406331;5646.435356464362;5652.576056795757;5665.206871038058;5679.744411501492;4046.5144182698264;4048.332025215836;4050.3519436889956;4052.331365324718;4056.2293164298985;5947.078202878561;5948.613340132921;5952.761889524414;5960.046392577166;5960.642361458283;4166.604172603597;4172.99848036469;4173.10278290163;4177.185448837447;4180.853670121531;4134.565870583606;4225.640820530228;4231.0268638212765;4245.575442455792;4266.402703621496;4800.591949684246;4814.20565606678;4814.735189564538;4819.927701084486;4820.614350851994;5658.236138121383;5659.8019069333195;5659.858503537444;5665.235193248941;5665.348484924204;1461.2912737322604;1488.1443170176974;1489.1437423481325;1489.4340150742648;1492.3433689176727;1015.817152912468;1026.8459731040405;1028.4343611013912;1035.746242170673;1045.8954104589632;4946.802127914843;4952.752362381866;4959.330490383752;4966.801327946841;4970.875728106754;5859.794907178229;5861.032929566659;5865.794697185578;5866.5893387462465;5870.55970802183;4953.25701144824;4954.9752251238515;4962;4965.503449655005;4970.17992031318;2912.359280958186;2995.7453616442845;3108.3161704424992;3114.5483904833673;3143.512755522898;5487.341519017744;5581.441855814467;5591.384947655754;5591.692456914909;5595.804146854841;6071.058985857199;6076.149339092531;6076.939230607726;6079.939200608026;6085.269767627825;5574.944250557523;5579.944200558105;5583.664980101207;5584.46947539983;5587.608867379326;5738.618473333519;5906.970465147647;5947.078202878561;5947.375525569752;5956.702164891824;5794.971025144847;5800.4489573490455;5805.593608447368;5808.593398462067;5810.448007439287;5606.887862242814;5608.887822243614;5612.494875461228;5614.775408983595;5618;3884.087239498772;4030.7581545107387;4060.1067765091634;4066.044479547363;4067.2272268268935;5799.536037117105;5804.158397032322;5829.15477255804;5871.060630299132;5878.588498805043;5657.5473962082115;5664.915026274692;5669.518090962314;5673.404292549223;5686;5673.517750991212;5675.943240567707;5678.829635110953;5679.37526872052;5680.261565996394;5352.732363381893;5487.6981766003255;5488.753006114654;5493.670379777066;5558.610897237155;5698.629589076697;5705.572082093942;5705.800296989585;5706.9727449059565;5711.914321285267;5356.866078347916;5431.646942948853;5517.641353312022;5615.241942337732;5618.438156184349 05:08:43 INFO - PROCESS | 28889 | |5;yui.html;645.4803882874287;703.2861645429887;727.9126504819423;743.3904198557182;755.3768141283442;10003.449810260432;10078.949605251973;10079.344842585246;10101;10123.08892199702;10193.337433066845;10219.693409197718;10243.078122968931;10283.691489255316;10319.845202321952;614.4469977020694;621.0404924391826;773.5165521549018;775.6664634207289;789.0176729971193;786.3041208530464;791.0151860933117;793.1909452358591;794.4438892775051;795.0260930360291;827.3174630929477;828.9253967142956;829.4442723375353;829.5893532701322;829.7676650537859;641.1696852575902;650.7331993882509;813.1624426840305;824.1675907333636;825.4840724547158;608.5223099866628;608.8477880529867;609.2506217352636;609.6646844235697;609.704293417692;9947.05502977216;9988.200943924468;9992.600295988152;10023.2482563808;10034.799304013952;10465.68602941913;10745.247832651718;11002.394868282241;11181.32912025281;11191.440427978569;8946.150115738994;9036.909630903672;9071.092890710943;9084.954575227148;9103.544822758835;3195.3928753536984;3264.461363874958;3275.279438523521;3282.2450836307544;3341.599008119017;38666.806665966775;38727.612723872684;38743.418848717294;38776.80611596952;38818.417723734165;8261;9001.144891235323;9055.456672599665;9125.17873391398;9150.267978561698;16306.673866522604;16532.75200871988;16540.338386464406;16557.83442165587;16571.585710357096;6007.849803754941;6078.848028799315;6163.691815409212;6165.260168779775;6217.253929528395;3654.068212605822;3664.5785734640326;3691.8892433227047;3741.7567858089137;3784.394496880486;2585.728498507667;2609.6868375795025;2620.4497055618535;2632.1182403894527;2633.038940786599;470.2569939495657;479.8392538499572;483.2099517289257;487.89998050399583;489.64500736966124;400.47737702298195;402.4707509624834;433.8655016944757;525.5952916254539;530.9867253318621;7149.96425017882;7225.494215404871;7290.671919763623;7439.739609113655;7487.66305516253;453.1684359200903;485.761976631448;507.4418140045994;558.8546977785805;574.643720893049;3355.5973283205685;3438.617017584744;3473.120266026237;3532.7350448716447;3588.8026158561006;47781.76109119432;48209.5179048212;48215.51784482181;48417.5158248413;48469.757651212225;41788.16423671509;42267.36598951018;42314.15371692549;42430.36354454685;42823.571764282584;38145.04637384087;38375;38422.46310147618;38719.41920871189;39491.40762888501;6912.965435172792;6946;6987.545809522365;7198.6604353586345;7199.604021778852;28589.28526786847;28755.424891501636;28768.42463150767;29119;29228.415431691672;35419;35535;36749;38449.6155038446;38477.6152238474;8827.602757876039;8855.424397414148;8874.86687699672;8876.245519130945;8899.599518021576;9360.4383736976;9373;9386.718398448058;9408.623655053721;9443.716688499357;8611.268042216481;8729.6944606941;8737.301015918838;8742.956285218534;8760.167784060504;8470.788230294293;8479.95760021196;8496.745097647081;8567.100454452193;8632.39573229893;8728.78178045554;8789.077146899483;8800.647974081221;8819.691310804092;8830.690925817566;7626.313631773167;7934.127246002819;7980.8004799878145;8048.83902321962;8681.705451683385;8253.917460825554;8816.559172041501;8989.595468204077;9019.413738107001;9080.273578113867 05:08:43 INFO - PROCESS | 28889 | __end_tp_report 05:08:43 INFO - PROCESS | 28889 | __start_cc_report 05:08:43 INFO - PROCESS | 28889 | _x_x_mozilla_cycle_collect,830 05:08:43 INFO - PROCESS | 28889 | __end_cc_report 05:08:43 INFO - PROCESS | 28889 | __startTimestamp1452517723869__endTimestamp 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | ------- Summary: start ------- 05:08:43 INFO - PROCESS | 28889 | Number of tests: 6 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | [#0] dojo.html Cycles:165 Average:4558.21 Median:4713.79 stddev:459.86 (9.8%) stddev-sans-first:434.25 05:08:43 INFO - PROCESS | 28889 | Values: 2578.4 2689.7 2689.8 2705.2 2713.5 4479.0 4606.4 4609.3 4625.1 4636.0 4521.4 4606.9 4613.1 4646.5 4682.8 4133.8 4217.9 4261.9 4269.9 4304.1 4272.9 4346.7 4347.3 4349.0 4358.3 4122.5 4211.1 4213.3 4223.1 4298.9 4268.0 4280.6 4304.5 4312.4 4317.1 4247.1 4257.6 4264.6 4284.1 4300.5 4346.8 4456.6 4459.0 4465.4 4633.2 4837.5 4872.7 4874.2 4878.4 4923.4 4918.1 4919.5 4919.8 4922.5 4961.6 4450.8 4541.5 4551.5 4561.0 4612.6 4979.2 4984.2 4993.4 5041.4 5043.3 4800.9 4804.2 4806.6 4831.4 4851.6 4811.8 4899.7 4928.7 4932.3 4932.3 4875.2 4948.3 4958.7 4986.6 4994.9 4875.8 4881.9 4889.0 4893.9 4936.3 4064.3 4199.9 4208.3 4209.4 4233.2 3608.9 3622.9 3651.3 3689.4 3699.0 4257.0 4279.4 4284.5 4285.2 4316.0 4963.0 4963.8 4971.7 4974.9 4991.2 4102.1 4166.8 4201.9 4202.4 4260.7 4463.4 4473.8 4480.0 4495.9 4531.0 4722.6 4725.9 4726.2 4740.4 4767.3 4779.9 4899.9 4903.1 4918.2 4956.4 4694.2 4713.8 4720.0 4721.9 4757.0 4882.0 4883.1 4890.1 4890.4 4938.4 4712.2 4830.2 4842.0 4865.5 4961.5 4774.0 4809.1 4815.1 4815.9 4867.9 4810.6 4814.8 4816.3 4817.5 4823.5 4529.8 4655.3 4659.0 4681.8 4688.9 4860.3 4863.2 4876.1 4876.8 4879.7 4776.2 4776.2 4778.1 4783.9 4804.5 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | [#1] ext.html Cycles:180 Average:37082.53 Median:17594.76 stddev:57787.39 (328.4%) stddev-sans-first:57884.11 05:08:43 INFO - PROCESS | 28889 | Values: 472.4 481.1 488.4 489.8 513.0 24836.6 25257.7 25290.5 25291.5 32052.4 35701.9 36144.0 36166.8 36196.1 36308.8 7619.0 7814.8 7815.6 7830.5 7830.8 6769.7 7016.5 9550.0 9746.9 9797.1 9656.0 9731.3 9750.6 9767.3 9808.3 6817.2 7029.7 9239.1 9303.9 9329.4 9498.9 9808.8 9820.4 9820.4 9821.7 32854.0 33189.7 33200.0 33262.2 33306.5 2742.4 2786.9 3026.0 3137.2 3462.1 25046.9 25104.6 25957.5 27325.5 27638.2 3308.4 3434.6 3462.3 3468.2 3574.3 228259.6 229093.0 229954.0 230026.0 230675.0 45162.8 54756.5 54929.0 55299.2 55419.4 40700.2 64198.0 65829.3 65837.7 65908.0 12457.1 12726.0 12728.1 12735.5 12736.5 9505.7 9670.1 9696.5 9705.9 9708.4 18495.7 18528.4 18560.9 18581.4 18676.7 6806.8 6969.8 7069.4 7195.4 7207.4 773.2 796.1 827.7 841.0 961.5 25612.0 25953.2 27231.3 28367.3 28811.3 934.4 952.6 1007.9 1068.9 1096.4 12887.4 12936.4 13040.8 13041.7 13121.2 255681.0 260228.0 260568.0 261475.0 261964.0 42840.1 43030.4 43121.0 43135.6 43144.6 1196.2 1211.3 1211.4 1218.1 1340.0 21306.0 23874.5 24494.0 24795.9 24989.9 35201.8 35792.6 35889.5 35895.3 36011.8 163151.0 163495.2 163681.0 163918.0 163939.0 23505.0 24052.9 26824.7 27200.3 27277.2 34049.5 35126.5 35333.0 35369.1 35576.3 29230.4 29959.9 29989.4 30301.6 30585.8 30173.0 30256.7 30409.7 30440.0 30536.4 30033.5 30184.4 30528.1 30534.2 30571.0 26494.7 27503.7 27652.4 27663.4 27699.9 21763.9 21996.5 22038.6 22067.6 22082.0 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | [#2] jquery.html Cycles:180 Average:24100.22 Median:27869.31 stddev:75647.55 (271.4%) stddev-sans-first:75838.71 05:08:43 INFO - PROCESS | 28889 | Values: 335.2 336.2 336.5 338.1 342.0 11924.8 12446.8 14546.7 14955.6 14956.6 9783.4 9834.4 10249.0 10290.2 12024.6 4316.1 4485.6 4493.8 4493.8 4494.8 3356.4 3514.1 4362.9 5023.1 5197.6 5107.3 5207.3 5216.3 5233.9 5236.9 5657.5 5766.5 5799.1 5799.4 5811.7 4861.9 5013.4 5016.0 5117.8 5118.7 11639.5 11819.4 11832.9 14965.6 18237.7 1633.9 1635.2 1680.8 1752.1 1769.5 8720.4 8897.2 9111.4 9210.8 12478.7 1689.4 1690.0 1732.7 1799.2 1807.1 48291.3 50715.5 50986.7 51457.0 51670.0 9475.9 9507.8 9601.7 9622.8 9672.4 12344.6 12381.3 12402.9 12419.4 12419.6 6508.7 6558.9 6641.3 6680.4 6682.4 6184.6 6190.4 6245.9 6253.3 6268.7 4028.8 4059.0 4076.9 4116.9 4144.2 1559.9 1643.4 2743.5 2793.8 2827.3 765.1 768.6 816.6 826.7 863.9 12692.3 14032.2 14323.0 14639.6 14702.7 791.9 811.1 896.6 899.8 950.1 6269.7 8808.6 8925.7 8928.5 9098.0 450155.0 452169.0 469078.0 469981.0 471882.0 62129.0 64817.7 65611.7 65804.7 66155.0 1099.4 1100.9 1115.1 1115.2 1117.2 13510.5 13847.7 13945.6 13963.2 14131.3 32021.8 32088.4 32129.0 32405.0 32512.5 41106.8 42215.7 42575.0 42583.6 42698.6 6474.8 6502.7 6641.2 6651.9 6837.7 9101.7 10041.7 10330.1 10397.1 10587.3 8571.7 9024.0 9032.0 9129.4 9226.7 8871.2 9072.5 9294.2 9480.7 9561.8 5940.9 8347.7 8783.2 8844.8 9187.4 6545.5 6765.3 6843.1 6884.0 6957.5 8307.8 8366.7 8457.6 8675.1 8744.6 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | [#3] mootools.html Cycles:180 Average:5194.23 Median:6303.87 stddev:2732.98 (43.4%) stddev-sans-first:2724.15 05:08:43 INFO - PROCESS | 28889 | Values: 1198.7 1391.6 1406.9 1513.1 1707.2 6598.3 7121.6 7209.1 7246.9 7274.6 7200.2 7257.5 7284.4 7287.9 7289.4 2138.4 2165.3 2165.9 2167.8 2184.8 2145.5 2169.5 2178.2 2179.2 2193.9 2161.4 2190.9 2193.1 2201.1 2206.5 2200.0 2200.6 2203.1 2205.5 2207.1 2074.0 2113.3 2113.9 2115.1 2116.3 7770.5 7802.1 7823.7 7832.8 7838.8 4362.0 4467.8 4468.7 4486.1 4493.9 2763.3 2810.5 2904.6 2908.9 2917.2 881.5 917.3 918.4 1713.8 1718.2 9817.3 9840.7 9857.8 9858.7 9877.8 3882.7 3917.4 3954.6 3978.5 4044.2 8202.3 8212.7 8213.8 8222.4 8226.8 4476.2 4487.0 4489.6 4490.6 4494.2 3403.5 3475.6 3893.5 4139.0 4139.3 3279.0 3291.6 3299.8 3305.5 3315.4 873.9 960.2 972.4 981.6 983.2 1133.5 1135.3 1156.6 1161.6 1162.9 6602.6 6646.6 6662.0 6669.5 6679.4 1016.8 1021.7 1028.4 1035.1 1062.5 5588.0 5679.2 5688.1 5694.3 5696.0 9286.2 9432.7 9629.2 9633.7 9639.8 9562.6 9575.6 9691.1 9711.9 9719.0 6976.2 7022.4 7096.3 7135.8 7169.5 6907.0 6952.5 6955.9 6961.0 6961.2 8312.8 8524.2 8619.4 8631.8 8652.5 8443.5 8567.4 8585.1 8586.2 8591.1 5358.4 5505.8 5988.2 6126.4 6242.3 6813.0 6898.0 6936.7 6973.5 6984.0 6238.8 6384.4 6391.4 6429.3 6479.2 6208.8 6290.1 6306.4 6309.9 6411.1 6491.4 6526.5 6540.9 6652.7 6656.6 6239.6 6269.0 6328.3 6333.9 6334.6 6240.3 6285.8 6288.4 6301.8 6305.9 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | [#4] prototype.html Cycles:180 Average:4696.18 Median:5225.76 stddev:1378.84 (26.4%) stddev-sans-first:1342.72 05:08:43 INFO - PROCESS | 28889 | Values: 304.2 308.9 314.7 316.4 319.9 5209.3 5316.3 5318.7 5330.7 5331.6 5242.2 5244.9 5250.7 5252.3 5292.8 3918.9 4044.7 4140.1 4143.2 4146.6 4057.6 4112.6 4119.7 4126.3 4147.8 4067.9 4069.3 4076.3 4096.4 4098.7 3896.1 4002.6 4013.8 4082.3 4098.5 3608.1 3612.3 3619.9 3653.6 3654.4 5125.9 5126.4 5131.0 5143.8 5150.9 4813.7 4829.9 4832.1 4832.4 4837.1 5529.2 5646.4 5652.6 5665.2 5679.7 4046.5 4048.3 4050.4 4052.3 4056.2 5947.1 5948.6 5952.8 5960.0 5960.6 4166.6 4173.0 4173.1 4177.2 4180.9 4134.6 4225.6 4231.0 4245.6 4266.4 4800.6 4814.2 4814.7 4819.9 4820.6 5658.2 5659.8 5659.9 5665.2 5665.3 1461.3 1488.1 1489.1 1489.4 1492.3 1015.8 1026.8 1028.4 1035.7 1045.9 4946.8 4952.8 4959.3 4966.8 4970.9 5859.8 5861.0 5865.8 5866.6 5870.6 4953.3 4955.0 4962.0 4965.5 4970.2 2912.4 2995.7 3108.3 3114.5 3143.5 5487.3 5581.4 5591.4 5591.7 5595.8 6071.1 6076.1 6076.9 6079.9 6085.3 5574.9 5579.9 5583.7 5584.5 5587.6 5738.6 5907.0 5947.1 5947.4 5956.7 5795.0 5800.4 5805.6 5808.6 5810.4 5606.9 5608.9 5612.5 5614.8 5618.0 3884.1 4030.8 4060.1 4066.0 4067.2 5799.5 5804.2 5829.2 5871.1 5878.6 5657.5 5664.9 5669.5 5673.4 5686.0 5673.5 5675.9 5678.8 5679.4 5680.3 5352.7 5487.7 5488.8 5493.7 5558.6 5698.6 5705.6 5705.8 5707.0 5711.9 5356.9 5431.6 5517.6 5615.2 5618.4 05:08:43 INFO - PROCESS | 28889 | 05:08:43 INFO - PROCESS | 28889 | [#5] yui.html Cycles:180 Average:11390.93 Median:609.05 stddev:13184.80 (2164.8%) stddev-sans-first:13197.10 05:08:43 INFO - PROCESS | 28889 | Values: 645.5 703.3 727.9 743.4 755.4 10003.4 10078.9 10079.3 10101.0 10123.1 10193.3 10219.7 10243.1 10283.7 10319.8 614.4 621.0 773.5 775.7 789.0 786.3 791.0 793.2 794.4 795.0 827.3 828.9 829.4 829.6 829.8 641.2 650.7 813.2 824.2 825.5 608.5 608.8 609.3 609.7 609.7 9947.1 9988.2 9992.6 10023.2 10034.8 10465.7 10745.2 11002.4 11181.3 11191.4 8946.2 9036.9 9071.1 9085.0 9103.5 3195.4 3264.5 3275.3 3282.2 3341.6 38666.8 38727.6 38743.4 38776.8 38818.4 8261.0 9001.1 9055.5 9125.2 9150.3 16306.7 16532.8 16540.3 16557.8 16571.6 6007.8 6078.8 6163.7 6165.3 6217.3 3654.1 3664.6 3691.9 3741.8 3784.4 2585.7 2609.7 2620.4 2632.1 2633.0 470.3 479.8 483.2 487.9 489.6 400.5 402.5 433.9 525.6 531.0 7150.0 7225.5 7290.7 7439.7 7487.7 453.2 485.8 507.4 558.9 574.6 3355.6 3438.6 3473.1 3532.7 3588.8 47781.8 48209.5 48215.5 48417.5 48469.8 41788.2 42267.4 42314.2 42430.4 42823.6 38145.0 38375.0 38422.5 38719.4 39491.4 6913.0 6946.0 6987.5 7198.7 7199.6 28589.3 28755.4 28768.4 29119.0 29228.4 35419.0 35535.0 36749.0 38449.6 38477.6 8827.6 8855.4 8874.9 8876.2 8899.6 9360.4 9373.0 9386.7 9408.6 9443.7 8611.3 8729.7 8737.3 8743.0 8760.2 8470.8 8480.0 8496.7 8567.1 8632.4 8728.8 8789.1 8800.6 8819.7 8830.7 7626.3 7934.1 7980.8 8048.8 8681.7 8253.9 8816.6 8989.6 9019.4 9080.3 05:08:43 INFO - PROCESS | 28889 | -------- Summary: end -------- 05:08:43 INFO - PROCESS | 28889 | 05:08:44 INFO - TEST-INFO | 28889: exit 0 05:08:44 INFO - TEST-OK | dromaeo_css | took 1117589ms 05:08:44 INFO - TEST-START | kraken 05:08:44 INFO - operating with platform_type : linux_ 05:08:44 INFO - Initialising browser for kraken test... 05:08:44 INFO - TEST-INFO | started process 29079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZAg0S3/profile http://localhost:51385/getInfo.html) 05:08:48 INFO - PROCESS | 29079 | __metrics Screen width/height:1600/1200 05:08:48 INFO - PROCESS | 29079 | colorDepth:24 05:08:48 INFO - PROCESS | 29079 | Browser inner width/height: 1024/697 05:08:48 INFO - PROCESS | 29079 | __metrics 05:08:48 INFO - PROCESS | 29079 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:08:48 INFO - PROCESS | 29079 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:50 INFO - TEST-INFO | 29079: exit 0 05:08:50 INFO - Browser initialized. 05:08:50 INFO - Running cycle 1/1 for kraken test... 05:08:50 INFO - TEST-INFO | started process 29160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZAg0S3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:02 INFO - PROCESS | 29160 | RSS: Main: 149180416 05:09:02 INFO - PROCESS | 29160 | 05:09:04 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51385/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:05 INFO - PROCESS | 29160 | RSS: Main: 187019264 05:09:05 INFO - PROCESS | 29160 | 05:09:07 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51385/tests/kraken/driver.html?testName=audio-dft) 05:09:08 INFO - PROCESS | 29160 | RSS: Main: 176857088 05:09:08 INFO - PROCESS | 29160 | 05:09:11 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51385/tests/kraken/driver.html?testName=audio-fft) 05:09:12 INFO - PROCESS | 29160 | RSS: Main: 161296384 05:09:12 INFO - PROCESS | 29160 | 05:09:14 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51385/tests/kraken/driver.html?testName=audio-oscillator) 05:09:14 INFO - PROCESS | 29160 | RSS: Main: 163414016 05:09:14 INFO - PROCESS | 29160 | 05:09:16 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:17 INFO - PROCESS | 29160 | RSS: Main: 164179968 05:09:17 INFO - PROCESS | 29160 | 05:09:20 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51385/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:21 INFO - PROCESS | 29160 | RSS: Main: 164691968 05:09:21 INFO - PROCESS | 29160 | 05:09:24 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51385/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:25 INFO - PROCESS | 29160 | RSS: Main: 167108608 05:09:25 INFO - PROCESS | 29160 | 05:09:27 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51385/tests/kraken/driver.html?testName=json-parse-financial) 05:09:28 INFO - PROCESS | 29160 | RSS: Main: 165928960 05:09:28 INFO - PROCESS | 29160 | 05:09:30 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:30 INFO - PROCESS | 29160 | RSS: Main: 177434624 05:09:30 INFO - PROCESS | 29160 | 05:09:32 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:33 INFO - PROCESS | 29160 | RSS: Main: 176758784 05:09:33 INFO - PROCESS | 29160 | 05:09:35 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:35 INFO - PROCESS | 29160 | RSS: Main: 184373248 05:09:35 INFO - PROCESS | 29160 | 05:09:38 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:39 INFO - PROCESS | 29160 | RSS: Main: 192307200 05:09:39 INFO - PROCESS | 29160 | 05:09:41 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:42 INFO - PROCESS | 29160 | RSS: Main: 192729088 05:09:42 INFO - PROCESS | 29160 | 05:09:43 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:51385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51385/tests/kraken/driver.html?testName=ai-astar) 05:09:44 INFO - PROCESS | 29160 | RSS: Main: 249131008 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | __start_tp_report 05:09:44 INFO - PROCESS | 29160 | _x_x_mozilla_page_load 05:09:44 INFO - PROCESS | 29160 | _x_x_mozilla_page_load_details 05:09:44 INFO - PROCESS | 29160 | |i|pagename|runs| 05:09:44 INFO - PROCESS | 29160 | |0;ai-astar;111;113;109;113;113;112;102;112;112;118 05:09:44 INFO - PROCESS | 29160 | |1;audio-beat-detection;165;133;157;164;134;152;154;132;165;132 05:09:44 INFO - PROCESS | 29160 | |2;audio-dft;159;160;161;160;161;161;161;163;161;163 05:09:44 INFO - PROCESS | 29160 | |3;audio-fft;73;72;86;102;72;72;72;106;95;73 05:09:44 INFO - PROCESS | 29160 | |4;audio-oscillator;98;98;134;96;98;98;133;97;97;134 05:09:44 INFO - PROCESS | 29160 | |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;109 05:09:44 INFO - PROCESS | 29160 | |6;imaging-darkroom;147;147;147;146;146;147;147;146;147;147 05:09:44 INFO - PROCESS | 29160 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 05:09:44 INFO - PROCESS | 29160 | |8;json-parse-financial;70;73;71;71;70;70;70;81;68;68 05:09:44 INFO - PROCESS | 29160 | |9;json-stringify-tinderbox;67;67;67;67;67;69;67;68;71;67 05:09:44 INFO - PROCESS | 29160 | |10;stanford-crypto-aes;81;84;83;89;81;82;82;90;83;83 05:09:44 INFO - PROCESS | 29160 | |11;stanford-crypto-ccm;121;120;124;117;133;124;124;121;120;123 05:09:44 INFO - PROCESS | 29160 | |12;stanford-crypto-pbkdf2;150;138;151;148;141;138;140;148;148;137 05:09:44 INFO - PROCESS | 29160 | |13;stanford-crypto-sha256-iterative;70;71;70;68;69;69;69;70;69;69 05:09:44 INFO - PROCESS | 29160 | __end_tp_report 05:09:44 INFO - PROCESS | 29160 | __start_cc_report 05:09:44 INFO - PROCESS | 29160 | _x_x_mozilla_cycle_collect,1012 05:09:44 INFO - PROCESS | 29160 | __end_cc_report 05:09:44 INFO - PROCESS | 29160 | __startTimestamp1452517784188__endTimestamp 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | ------- Summary: start ------- 05:09:44 INFO - PROCESS | 29160 | Number of tests: 14 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:4.03 (3.6%) stddev-sans-first:4.28 05:09:44 INFO - PROCESS | 29160 | Values: 111.0 113.0 109.0 113.0 113.0 112.0 102.0 112.0 112.0 118.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:155.50 stddev:14.51 (9.3%) stddev-sans-first:14.15 05:09:44 INFO - PROCESS | 29160 | Values: 165.0 133.0 157.0 164.0 134.0 152.0 154.0 132.0 165.0 132.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.09 05:09:44 INFO - PROCESS | 29160 | Values: 159.0 160.0 161.0 160.0 161.0 161.0 161.0 163.0 161.0 163.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#3] audio-fft Cycles:10 Average:82.30 Median:72.50 stddev:13.83 (19.1%) stddev-sans-first:14.26 05:09:44 INFO - PROCESS | 29160 | Values: 73.0 72.0 86.0 102.0 72.0 72.0 72.0 106.0 95.0 73.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:97.50 stddev:17.52 (18.0%) stddev-sans-first:18.18 05:09:44 INFO - PROCESS | 29160 | Values: 98.0 98.0 134.0 96.0 98.0 98.0 133.0 97.0 97.0 134.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:09:44 INFO - PROCESS | 29160 | Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:09:44 INFO - PROCESS | 29160 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:09:44 INFO - PROCESS | 29160 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:70.50 stddev:3.74 (5.3%) stddev-sans-first:3.94 05:09:44 INFO - PROCESS | 29160 | Values: 70.0 73.0 71.0 71.0 70.0 70.0 70.0 81.0 68.0 68.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 05:09:44 INFO - PROCESS | 29160 | Values: 67.0 67.0 67.0 67.0 67.0 69.0 67.0 68.0 71.0 67.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:3.16 (3.8%) stddev-sans-first:3.18 05:09:44 INFO - PROCESS | 29160 | Values: 81.0 84.0 83.0 89.0 81.0 82.0 82.0 90.0 83.0 83.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:123.50 stddev:4.27 (3.5%) stddev-sans-first:4.48 05:09:44 INFO - PROCESS | 29160 | Values: 121.0 120.0 124.0 117.0 133.0 124.0 124.0 121.0 120.0 123.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:148.00 stddev:5.57 (3.8%) stddev-sans-first:5.45 05:09:44 INFO - PROCESS | 29160 | Values: 150.0 138.0 151.0 148.0 141.0 138.0 140.0 148.0 148.0 137.0 05:09:44 INFO - PROCESS | 29160 | 05:09:44 INFO - PROCESS | 29160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 05:09:44 INFO - PROCESS | 29160 | Values: 70.0 71.0 70.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 05:09:44 INFO - PROCESS | 29160 | -------- Summary: end -------- 05:09:44 INFO - PROCESS | 29160 | 05:09:45 INFO - TEST-INFO | 29160: exit 0 05:09:45 INFO - TEST-OK | kraken | took 60511ms 05:09:45 INFO - TEST-START | v8_7 05:09:45 INFO - operating with platform_type : linux_ 05:09:45 INFO - Initialising browser for v8_7 test... 05:09:45 INFO - TEST-INFO | started process 29411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpICaRec/profile http://localhost:51385/getInfo.html) 05:09:49 INFO - PROCESS | 29411 | __metrics Screen width/height:1600/1200 05:09:49 INFO - PROCESS | 29411 | colorDepth:24 05:09:49 INFO - PROCESS | 29411 | Browser inner width/height: 1024/697 05:09:49 INFO - PROCESS | 29411 | __metrics 05:09:49 INFO - PROCESS | 29411 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:09:49 INFO - PROCESS | 29411 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:50 INFO - TEST-INFO | 29411: exit 0 05:09:50 INFO - Browser initialized. 05:09:50 INFO - Running cycle 1/1 for v8_7 test... 05:09:50 INFO - TEST-INFO | started process 29493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpICaRec/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:02 INFO - PROCESS | 29493 | RSS: Main: 148881408 05:10:02 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | Cycle 1(1): loaded http://localhost:51385/tests/v8_7/run.html (next: http://localhost:51385/tests/v8_7/run.html) 05:10:25 INFO - PROCESS | 29493 | RSS: Main: 448565248 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | __start_tp_report 05:10:25 INFO - PROCESS | 29493 | _x_x_mozilla_page_load 05:10:25 INFO - PROCESS | 29493 | _x_x_mozilla_page_load_details 05:10:25 INFO - PROCESS | 29493 | |i|pagename|runs| 05:10:25 INFO - PROCESS | 29493 | |0;Richards;167.84155756965424 05:10:25 INFO - PROCESS | 29493 | |1;DeltaBlue;188.11136192626034 05:10:25 INFO - PROCESS | 29493 | |2;Encrypt;278.6291446085261 05:10:25 INFO - PROCESS | 29493 | |3;Decrypt;5175.257731958763 05:10:25 INFO - PROCESS | 29493 | |4;RayTrace;2085.4166666666665 05:10:25 INFO - PROCESS | 29493 | |5;Earley;800.640512409928 05:10:25 INFO - PROCESS | 29493 | |6;Boyer;12144.578313253012 05:10:25 INFO - PROCESS | 29493 | |7;RegExp;44043.47826086957 05:10:25 INFO - PROCESS | 29493 | |8;Splay;601.5485407980941 05:10:25 INFO - PROCESS | 29493 | |9;NavierStokes;4854.368932038835 05:10:25 INFO - PROCESS | 29493 | __end_tp_report 05:10:25 INFO - PROCESS | 29493 | __startTimestamp1452517825549__endTimestamp 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | ------- Summary: start ------- 05:10:25 INFO - PROCESS | 29493 | Number of tests: 10 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 167.8 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 188.1 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 278.6 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 5175.3 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#4] RayTrace Cycles:1 Average:2085.42 Median:2085.42 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 2085.4 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#5] Earley Cycles:1 Average:800.64 Median:800.64 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 800.6 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 12144.6 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#7] RegExp Cycles:1 Average:44043.48 Median:44043.48 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 44043.5 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#8] Splay Cycles:1 Average:601.55 Median:601.55 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 601.5 05:10:25 INFO - PROCESS | 29493 | 05:10:25 INFO - PROCESS | 29493 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:10:25 INFO - PROCESS | 29493 | Values: 4854.4 05:10:25 INFO - PROCESS | 29493 | -------- Summary: end -------- 05:10:25 INFO - PROCESS | 29493 | 05:10:26 INFO - TEST-INFO | 29493: exit 0 05:10:26 INFO - TEST-OK | v8_7 | took 41355ms 05:10:26 INFO - SUITE-END | took 1219s 05:10:26 INFO - Completed test suite (00:20:19) 05:10:26 INFO - Working with test: dromaeo_css 05:10:26 INFO - Generating results file: dromaeo_css 05:10:26 INFO - Working with test: kraken 05:10:26 INFO - Generating results file: kraken 05:10:26 INFO - javascript benchmark 05:10:26 INFO - Working with test: v8_7 05:10:26 INFO - Generating results file: v8_7 05:10:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:10:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 05:10:27 INFO - process_Request line: dromaeo_css 6100.65 graph.html#tests=[[72,203,35]] 05:10:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:10:27 INFO - process_Request line: kraken 1522.40 graph.html#tests=[[232,203,35]] 05:10:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:10:27 INFO - process_Request line: v8_7 18734.53 graph.html#tests=[[230,203,35]] 05:10:27 INFO - RETURN: dromaeo_css: 6100.65 05:10:27 INFO - RETURN: kraken: 1522.40 05:10:27 INFO - RETURN: v8_7: 18734.53 05:10:27 INFO - javascript benchmark 05:10:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2578.417725624024, 2689.6503454550916, 2689.784817214623, 2705.1884434669605, 2713.4708731797296, 4478.955210447894, 4606.401167848179, 4609.308603709445, 4625.051864367801, 4636.0, 4521.434820647419, 4606.884827879305, 4613.054323863608, 4646.512116227798, 4682.836100736475, 4133.793310334487, 4217.85237516687, 4261.87214383569, 4269.850555230568, 4304.139172165564, 4272.935905961397, 4346.6739994500385, 4347.260965635834, 4348.9782551087355, 4358.259095953696, 4122.484689413824, 4211.136716973013, 4213.325867861158, 4223.070924396628, 4298.871033868989, 4267.97866010668, 4280.5719428057255, 4304.4834619845815, 4312.417823593806, 4317.050248945227, 4247.086876321606, 4257.638100761408, 4264.637505812009, 4284.143171365708, 4300.483941926957, 4346.8043938022865, 4456.598906098467, 4459.019015816515, 4465.397171381855, 4633.212353899845, 4837.540433658797, 4872.6832755870755, 4874.195757699975, 4878.414590249157, 4923.384576927884, 4918.139325618003, 4919.483454237289, 4919.7540122993705, 4922.532359425884, 4961.627877909135, 4450.755208463565, 4541.477730061019, 4551.544845515488, 4560.954390456053, 4612.58486736192, 4979.228219625964, 4984.152694042022, 4993.350864387679, 5041.420236672756, 5043.268726034705, 4800.855974320776, 4804.2073057945045, 4806.639502037361, 4831.4202295724735, 4851.611871050308, 4811.759412029384, 4899.681520701214, 4928.704277743347, 4932.26016097581, 4932.334134891816, 4875.195592727231, 4948.331975183304, 4958.677685950402, 4986.551210391082, 4994.90010199794, 4875.780589873464, 4881.925976285212, 4888.9755551222015, 4893.902121957541, 4936.333594964705, 4064.3293856513937, 4199.853005144866, 4208.284591619432, 4209.410682504452, 4233.216854881856, 3608.927821443609, 3622.855085796539, 3651.2879988402537, 3689.3912504436466, 3698.964289998805, 4257.042165512735, 4279.443672322578, 4284.464441944757, 4285.196458630219, 4316.028893499, 4963.032208719265, 4963.776630051656, 4971.676841005323, 4974.875628109254, 4991.176455884811, 4102.097538541516, 4166.791660416967, 4201.87394378163, 4202.411662367271, 4260.701750877471, 4463.397441345442, 4473.776311184428, 4479.977600111979, 4495.887602809956, 4530.977345113253, 4722.55135762109, 4725.9054818904115, 4726.196546587157, 4740.3837501124635, 4767.261074533453, 4779.856604301876, 4899.853004409873, 4903.092927808367, 4918.2376731606655, 4956.405231372259, 4694.248920172892, 4713.787879545497, 4720.0323933592845, 4721.929171062368, 4756.9762151189025, 4882.048000639841, 4883.096627123993, 4890.119778439915, 4890.388701412324, 4938.407391113089, 4712.222483290218, 4830.203016502378, 4842.0, 4865.489123641966, 4961.479044700254, 4773.9761301193275, 4809.062232864558, 4815.109204797123, 4815.879603009953, 4867.853964381075, 4810.56704896547, 4814.831480898151, 4816.34979277793, 4817.470078291455, 4823.493533178966, 4529.796159172911, 4655.324977878121, 4659.044895796286, 4681.789319480564, 4688.882777930579, 4860.295257187759, 4863.197572400514, 4876.097921884463, 4876.829310974099, 4879.707217566957, 4776.188048031773, 4776.21192503233, 4778.116048530894, 4783.880402989953, 4804.5435683611395], "unit": "score", "name": "dojo.html", "value": 4530.403194658633}, {"lowerIsBetter": false, "replicates": [472.38118065334413, 481.0691312310679, 488.3773189183792, 489.8065264220632, 512.9871753206168, 24836.627450588232, 25257.747422525794, 25290.494190116187, 25291.49417011663, 32052.35895282093, 35701.89428215756, 36144.0, 36166.8191659042, 36196.09509762257, 36308.81845590768, 7619.0, 7814.843703125934, 7815.609219539028, 7830.530168189898, 7830.765077047698, 6769.661516924134, 7016.543924644881, 9550.0, 9746.90253097467, 9797.06927841854, 9655.951720241388, 9731.270154738388, 9750.561224744868, 9767.316287859852, 9808.264380171515, 6817.181938167402, 7029.718811247544, 9239.122283383067, 9303.860442093373, 9329.440233585972, 9498.857517137249, 9808.803823923481, 9820.361676491006, 9820.4107753535, 9821.656242031566, 32854.0, 33189.6681033189, 33200.0, 33262.168445788804, 33306.500402493984, 2742.424090940905, 2786.9303267418272, 3026.0, 3137.1686503076476, 3462.117160124177, 25046.874765626057, 25104.623430648557, 25957.480850383075, 27325.453490930267, 27638.170854874385, 3308.3714094322004, 3434.5957829519434, 3462.272922686239, 3468.236987862666, 3574.3208790330013, 228259.60884693943, 229093.0, 229954.0, 230026.0, 230675.0, 45162.774186129514, 54756.524347564926, 54929.0, 55299.170512442346, 55419.44580554224, 40700.185996279906, 64198.0, 65829.34170658328, 65837.67081164659, 65908.0, 12457.12800103984, 12726.045546584044, 12728.109032367645, 12735.490580376681, 12736.490540378467, 9505.714828555154, 9670.129688327943, 9696.466694331879, 9705.902940970642, 9708.417494950325, 18495.722564161548, 18528.42508386775, 18560.907195463937, 18581.44255672332, 18676.719849202273, 6806.8298292542095, 6969.756058537927, 7069.434445244368, 7195.352418282275, 7207.423406127497, 773.2190487607556, 796.1451899148328, 827.664795757719, 840.9873851892227, 961.4663861556903, 25612.0, 25953.22140335793, 27231.319217019733, 28367.29081772931, 28811.279718006797, 934.3786382055993, 952.64752041745, 1007.909288164054, 1068.8770791358938, 1096.4353358020626, 12887.355632218352, 12936.417861196269, 13040.80438793419, 13041.673958151123, 13121.212727236396, 255681.0, 260228.0, 260568.0, 261475.0, 261964.0, 42840.14319713588, 43030.35454468185, 43121.0, 43135.568644313156, 43144.56855431406, 1196.2224554039944, 1211.309553554483, 1211.3640338822013, 1218.0560065948782, 1340.028479352481, 21306.0, 23874.52250955006, 24494.0, 24795.87602061978, 24989.87505062463, 35201.82399087988, 35792.64207357893, 35889.46165807567, 35895.28209435849, 36011.819940900124, 163151.0, 163495.1825240914, 163681.0, 163918.0, 163939.0, 23505.0, 24052.87973560191, 26824.731752683005, 27200.319992000357, 27277.181684549494, 34049.48925766165, 35126.47310290399, 35333.0, 35369.115772105906, 35576.28847423089, 29230.415391691622, 29959.899004901752, 29989.400211996075, 30301.636426360426, 30585.847070764503, 30173.0, 30256.697433025387, 30409.695903040687, 30440.0, 30536.389272214874, 30033.549496758, 30184.396312074074, 30528.08415747531, 30534.236644084074, 30571.0, 26494.730340884555, 27503.724962750915, 27652.446951060465, 27663.44673106567, 27699.86150069237, 21763.932426419466, 21996.450088747908, 22038.559228815655, 22067.558648827253, 22082.0], "unit": "score", "name": "ext.html", "value": 16022.816447358307}, {"lowerIsBetter": false, "replicates": [335.22395654060864, 336.2400973799213, 336.4952571143285, 338.0703066566941, 342.0115865149716, 11924.82112768307, 12446.751064978718, 14546.709065818677, 14955.551333459987, 14956.5513034609, 9783.364081334708, 9834.40993540388, 10249.0, 10290.176785857133, 12024.639260822189, 4316.072044510437, 4485.641148708112, 4493.820247190109, 4493.820247190125, 4494.8202071917085, 3356.3790698720813, 3514.0512061743316, 4362.890927726817, 5023.120953833083, 5197.558207552363, 5107.252298263539, 5207.3490813648295, 5216.321878155834, 5233.947660523384, 5236.895262094756, 5657.547396208293, 5766.538676905838, 5799.072148456226, 5799.3910639382675, 5811.651300921937, 4861.854144375674, 5013.398392192924, 5016.0, 5117.795288188468, 5118.692878427269, 11639.534418623245, 11819.409029548488, 11832.940835295854, 14965.625859353604, 18237.7264341035, 1633.8774591905656, 1635.1660653066901, 1680.7899012623423, 1752.0801579171036, 1769.4514700442903, 8720.43317184381, 8897.199252067345, 9111.407758495743, 9210.815783684357, 12478.689737577604, 1689.400262906675, 1690.0318864584222, 1732.7141021731525, 1799.1543974332044, 1807.1145138881984, 48291.275630865566, 50715.492845071814, 50986.74506627443, 51457.0, 51670.0, 9475.857862132074, 9507.809843803085, 9601.663941762004, 9622.807543849083, 9672.419654820733, 12344.567940122231, 12381.319027453577, 12402.875971240172, 12419.379031048411, 12419.565315213924, 6508.707108180143, 6558.901616475757, 6641.33586641332, 6680.365365290289, 6682.398584127452, 6184.5980011299125, 6190.380961903864, 6245.937540624535, 6253.343398943137, 6268.717907694165, 4028.7582745035393, 4059.0, 4076.898077548085, 4116.897077573085, 4144.150449157915, 1559.8518140776607, 1643.4248013195286, 2743.492453896036, 2793.8044336896223, 2827.3497095668113, 765.1201118713524, 768.6233745464793, 816.5713000674574, 826.7023871406288, 863.8574635185249, 12692.301923394301, 14032.228227447384, 14323.0, 14639.560813175622, 14702.705945881022, 791.9088859888512, 811.0956283743701, 896.5651658945407, 899.7840518275567, 950.092661508258, 6269.7178626961895, 8808.603612837438, 8925.73222803317, 8928.508932008803, 9097.954510227406, 450155.0, 452169.0, 469078.0, 469981.0, 471882.0, 62129.0, 64817.67591162108, 65611.67194163999, 65804.67097664576, 66155.0, 1099.406320586874, 1100.884407137255, 1115.0856297835696, 1115.2193464574668, 1117.1566914590828, 13510.527131550742, 13847.653808654864, 13945.58163255104, 13963.241520147756, 14131.293435327987, 32021.8398908004, 32088.35823283568, 32129.0, 32405.0, 32512.512312314862, 41106.79446602748, 42215.73352799421, 42575.0, 42583.57416425796, 42698.57301426946, 6474.773382931575, 6502.739890404331, 6641.169853768279, 6651.933480665131, 6837.735019021497, 9101.681441149529, 10041.744781902262, 10330.121939635215, 10397.11624511925, 10587.258891877802, 8571.657133714582, 9024.007359190615, 9032.0, 9129.406588571721, 9226.723198304062, 8871.201591856763, 9072.50101244438, 9294.209992150743, 9480.668176613786, 9561.760955976157, 5940.940590594038, 8347.707830225912, 8783.152020659276, 8844.823103537765, 9187.448753074837, 6545.541812073109, 6765.323467653196, 6843.076184715199, 6884.001819736211, 6957.512974091967, 8307.833843322978, 8366.665333386596, 8457.61940712657, 8675.132486751274, 8744.562771861509], "unit": "score", "name": "jquery.html", "value": 7381.109319057881}, {"lowerIsBetter": false, "replicates": [1198.7482628647983, 1391.6451304917248, 1406.880415164711, 1513.1450730337358, 1707.2488105233704, 6598.274189839114, 7121.608311542863, 7209.062821833168, 7246.927530724691, 7274.563526188433, 7200.171980222276, 7257.5282606630535, 7284.417246620271, 7287.890681639779, 7289.416846652269, 2138.422625891005, 2165.263810304496, 2165.8700477971374, 2167.8374121940838, 2184.8361372897098, 2145.5279838435517, 2169.5010147665967, 2178.2485042660337, 2179.1610230061383, 2193.9122435102577, 2161.3948094533557, 2190.87950162741, 2193.1008286602496, 2201.0975500044983, 2206.5476577301615, 2200.04298130313, 2200.6258935980923, 2203.0967303405687, 2205.492736670567, 2207.128184367182, 2073.968890466644, 2113.2709215320688, 2113.8837363944976, 2115.079940226007, 2116.333354993172, 7770.49491783038, 7802.063752349698, 7823.687052517893, 7832.765017049498, 7838.8432231355055, 4361.978190109061, 4467.776611169461, 4468.664850136221, 4486.147631949919, 4493.910121797546, 2763.281546797827, 2810.4519618674367, 2904.564315352693, 2908.9127326180246, 2917.168606947031, 881.4534988307227, 917.3257655623112, 918.3938600523622, 1713.8029126650345, 1718.2267979409316, 9817.312788104835, 9840.704778856645, 9857.75355616101, 9858.654947076819, 9877.802443951152, 3882.7087968402484, 3917.4319723640483, 3954.62431069048, 3978.4827972363987, 4044.2315959967514, 8202.343812494986, 8212.712555060543, 8213.835723285501, 8222.38332125093, 8226.753197404087, 4476.239039363316, 4486.977565112219, 4489.618382437529, 4490.618297444688, 4494.16857881293, 3403.4724617684296, 3475.6176820549717, 3893.53277606689, 4139.0, 4139.296319625671, 3279.0, 3291.588551431071, 3299.7690161688934, 3305.5372247885316, 3315.353506066294, 873.8988874018783, 960.188640598693, 972.4457059476031, 981.5828272983953, 983.1839573154265, 1133.4729350851894, 1135.3131355529952, 1156.5605070073486, 1161.6282789507445, 1162.9302241865514, 6602.60384376939, 6646.6042131153, 6662.0340050692375, 6669.466442684574, 6679.398854103154, 1016.832222683249, 1021.6730646193296, 1028.4098213137895, 1035.0736091198335, 1062.5377960587168, 5587.972060139673, 5679.204911312419, 5688.061469857427, 5694.345150307768, 5696.0, 9286.210672092948, 9432.669856554987, 9629.229661627052, 9633.710988670351, 9639.807203855884, 9562.565615157642, 9575.616975321049, 9691.07934746198, 9711.931687514369, 9718.951405242928, 6976.19773726028, 7022.367986881205, 7096.254893236239, 7135.82160445993, 7169.494406174762, 6906.965465172642, 6952.478564107813, 6955.895661565181, 6961.0, 6961.199462061928, 8312.792180195302, 8524.190201930807, 8619.353548483763, 8631.827363452821, 8652.480851148952, 8443.493390396596, 8567.357448191286, 8585.141485851365, 8586.184312490303, 8591.097934716765, 5358.437364076872, 5505.779768809363, 5988.191594134736, 6126.387361263838, 6242.28213755424, 6813.0, 6898.034275201576, 6936.653167341512, 6973.476989225727, 6984.0, 6238.75044998195, 6384.425401713868, 6391.424771770563, 6429.292777794345, 6479.2224933006455, 6208.751649933952, 6290.0879372491645, 6306.432421082125, 6309.873802523832, 6411.102445657705, 6491.35086491366, 6526.543141980016, 6540.901886471802, 6652.669466106895, 6656.600603963778, 6239.563230573816, 6268.968655156695, 6328.272248691275, 6333.936660633519, 6334.606386594942, 6240.251169859464, 6285.779997700059, 6288.434040936338, 6301.8109456716375, 6305.936940630535], "unit": "score", "name": "mootools.html", "value": 4264.212900514883}, {"lowerIsBetter": false, "replicates": [304.16506689138316, 308.9057837359606, 314.6868865478849, 316.3988421998202, 319.8608605256712, 5209.322788037554, 5316.255724198606, 5318.734063296829, 5330.733463326833, 5331.57347412207, 5242.18746094355, 5244.921326180111, 5250.65870718403, 5252.290940723001, 5292.788288468457, 3918.941215881764, 4044.716869819114, 4140.0891803803115, 4143.150654115914, 4146.63161156819, 4057.573954734755, 4112.6298633123015, 4119.711620186573, 4126.257273690734, 4147.751134931914, 4067.9186416271655, 4069.2878746219294, 4076.3274059780247, 4096.40602112695, 4098.692598055143, 3896.084420161246, 4002.579729128458, 4013.7591744495426, 4082.3060079786505, 4098.467199264106, 3608.116011577154, 3612.3317186320614, 3619.914025792252, 3653.5615726113037, 3654.4152935530456, 5125.948740512585, 5126.436092029874, 5131.0, 5143.794248230066, 5150.871228219287, 4813.687110337852, 4829.9034019319415, 4832.081904438145, 4832.444268909086, 4837.0567739290855, 5529.170624406331, 5646.435356464362, 5652.576056795757, 5665.206871038058, 5679.744411501492, 4046.5144182698264, 4048.332025215836, 4050.3519436889956, 4052.331365324718, 4056.2293164298985, 5947.078202878561, 5948.613340132921, 5952.761889524414, 5960.046392577166, 5960.642361458283, 4166.604172603597, 4172.99848036469, 4173.10278290163, 4177.185448837447, 4180.853670121531, 4134.565870583606, 4225.640820530228, 4231.0268638212765, 4245.575442455792, 4266.402703621496, 4800.591949684246, 4814.20565606678, 4814.735189564538, 4819.927701084486, 4820.614350851994, 5658.236138121383, 5659.8019069333195, 5659.858503537444, 5665.235193248941, 5665.348484924204, 1461.2912737322604, 1488.1443170176974, 1489.1437423481325, 1489.4340150742648, 1492.3433689176727, 1015.817152912468, 1026.8459731040405, 1028.4343611013912, 1035.746242170673, 1045.8954104589632, 4946.802127914843, 4952.752362381866, 4959.330490383752, 4966.801327946841, 4970.875728106754, 5859.794907178229, 5861.032929566659, 5865.794697185578, 5866.5893387462465, 5870.55970802183, 4953.25701144824, 4954.9752251238515, 4962.0, 4965.503449655005, 4970.17992031318, 2912.359280958186, 2995.7453616442845, 3108.3161704424992, 3114.5483904833673, 3143.512755522898, 5487.341519017744, 5581.441855814467, 5591.384947655754, 5591.692456914909, 5595.804146854841, 6071.058985857199, 6076.149339092531, 6076.939230607726, 6079.939200608026, 6085.269767627825, 5574.944250557523, 5579.944200558105, 5583.664980101207, 5584.46947539983, 5587.608867379326, 5738.618473333519, 5906.970465147647, 5947.078202878561, 5947.375525569752, 5956.702164891824, 5794.971025144847, 5800.4489573490455, 5805.593608447368, 5808.593398462067, 5810.448007439287, 5606.887862242814, 5608.887822243614, 5612.494875461228, 5614.775408983595, 5618.0, 3884.087239498772, 4030.7581545107387, 4060.1067765091634, 4066.044479547363, 4067.2272268268935, 5799.536037117105, 5804.158397032322, 5829.15477255804, 5871.060630299132, 5878.588498805043, 5657.5473962082115, 5664.915026274692, 5669.518090962314, 5673.404292549223, 5686.0, 5673.517750991212, 5675.943240567707, 5678.829635110953, 5679.37526872052, 5680.261565996394, 5352.732363381893, 5487.6981766003255, 5488.753006114654, 5493.670379777066, 5558.610897237155, 5698.629589076697, 5705.572082093942, 5705.800296989585, 5706.9727449059565, 5711.914321285267, 5356.866078347916, 5431.646942948853, 5517.641353312022, 5615.241942337732, 5618.438156184349], "unit": "score", "name": "prototype.html", "value": 4258.474164720826}, {"lowerIsBetter": false, "replicates": [645.4803882874287, 703.2861645429887, 727.9126504819423, 743.3904198557182, 755.3768141283442, 10003.449810260432, 10078.949605251973, 10079.344842585246, 10101.0, 10123.08892199702, 10193.337433066845, 10219.693409197718, 10243.078122968931, 10283.691489255316, 10319.845202321952, 614.4469977020694, 621.0404924391826, 773.5165521549018, 775.6664634207289, 789.0176729971193, 786.3041208530464, 791.0151860933117, 793.1909452358591, 794.4438892775051, 795.0260930360291, 827.3174630929477, 828.9253967142956, 829.4442723375353, 829.5893532701322, 829.7676650537859, 641.1696852575902, 650.7331993882509, 813.1624426840305, 824.1675907333636, 825.4840724547158, 608.5223099866628, 608.8477880529867, 609.2506217352636, 609.6646844235697, 609.704293417692, 9947.05502977216, 9988.200943924468, 9992.600295988152, 10023.2482563808, 10034.799304013952, 10465.68602941913, 10745.247832651718, 11002.394868282241, 11181.32912025281, 11191.440427978569, 8946.150115738994, 9036.909630903672, 9071.092890710943, 9084.954575227148, 9103.544822758835, 3195.3928753536984, 3264.461363874958, 3275.279438523521, 3282.2450836307544, 3341.599008119017, 38666.806665966775, 38727.612723872684, 38743.418848717294, 38776.80611596952, 38818.417723734165, 8261.0, 9001.144891235323, 9055.456672599665, 9125.17873391398, 9150.267978561698, 16306.673866522604, 16532.75200871988, 16540.338386464406, 16557.83442165587, 16571.585710357096, 6007.849803754941, 6078.848028799315, 6163.691815409212, 6165.260168779775, 6217.253929528395, 3654.068212605822, 3664.5785734640326, 3691.8892433227047, 3741.7567858089137, 3784.394496880486, 2585.728498507667, 2609.6868375795025, 2620.4497055618535, 2632.1182403894527, 2633.038940786599, 470.2569939495657, 479.8392538499572, 483.2099517289257, 487.89998050399583, 489.64500736966124, 400.47737702298195, 402.4707509624834, 433.8655016944757, 525.5952916254539, 530.9867253318621, 7149.96425017882, 7225.494215404871, 7290.671919763623, 7439.739609113655, 7487.66305516253, 453.1684359200903, 485.761976631448, 507.4418140045994, 558.8546977785805, 574.643720893049, 3355.5973283205685, 3438.617017584744, 3473.120266026237, 3532.7350448716447, 3588.8026158561006, 47781.76109119432, 48209.5179048212, 48215.51784482181, 48417.5158248413, 48469.757651212225, 41788.16423671509, 42267.36598951018, 42314.15371692549, 42430.36354454685, 42823.571764282584, 38145.04637384087, 38375.0, 38422.46310147618, 38719.41920871189, 39491.40762888501, 6912.965435172792, 6946.0, 6987.545809522365, 7198.6604353586345, 7199.604021778852, 28589.28526786847, 28755.424891501636, 28768.42463150767, 29119.0, 29228.415431691672, 35419.0, 35535.0, 36749.0, 38449.6155038446, 38477.6152238474, 8827.602757876039, 8855.424397414148, 8874.86687699672, 8876.245519130945, 8899.599518021576, 9360.4383736976, 9373.0, 9386.718398448058, 9408.623655053721, 9443.716688499357, 8611.268042216481, 8729.6944606941, 8737.301015918838, 8742.956285218534, 8760.167784060504, 8470.788230294293, 8479.95760021196, 8496.745097647081, 8567.100454452193, 8632.39573229893, 8728.78178045554, 8789.077146899483, 8800.647974081221, 8819.691310804092, 8830.690925817566, 7626.313631773167, 7934.127246002819, 7980.8004799878145, 8048.83902321962, 8681.705451683385, 8253.917460825554, 8816.559172041501, 8989.595468204077, 9019.413738107001, 9080.273578113867], "unit": "score", "name": "yui.html", "value": 5298.201091650794}], "name": "dromaeo_css", "value": 6100.655829693741}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 109.0, 113.0, 113.0, 112.0, 102.0, 112.0, 112.0, 118.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [165.0, 133.0, 157.0, 164.0, 134.0, 152.0, 154.0, 132.0, 165.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 86.0, 102.0, 72.0, 72.0, 72.0, 106.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 134.0, 96.0, 98.0, 98.0, 133.0, 97.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 71.0, 71.0, 70.0, 70.0, 70.0, 81.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 67.0, 68.0, 71.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 83.0, 89.0, 81.0, 82.0, 82.0, 90.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 124.0, 117.0, 133.0, 124.0, 124.0, 121.0, 120.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 151.0, 148.0, 141.0, 138.0, 140.0, 148.0, 148.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1522.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2085.4166666666665], "unit": "score", "name": "RayTrace", "value": 354.83988011988015}, {"lowerIsBetter": false, "replicates": [800.640512409928], "unit": "score", "name": "Earley", "value": 832.4122870000002}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [44043.47826086957], "unit": "score", "name": "RegExp", "value": 20.683766041460988}, {"lowerIsBetter": false, "replicates": [601.5485407980941], "unit": "score", "name": "Splay", "value": 135.468701980198}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 18734.534941398644}]} 05:10:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "18734.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1522.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6100.65"}}} 05:10:27 INFO - Return code: 0 05:10:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:10:27 INFO - # TBPL SUCCESS # 05:10:27 INFO - Running post-action listener: _resource_record_post_action 05:10:27 INFO - Running post-run listener: _resource_record_post_run 05:10:28 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 0; Write bytes: 551227392; Read time: 0; Write time: 389232 05:10:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 231915520; Read time: 0; Write time: 213864 05:10:28 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 319311872; Read time: 0; Write time: 175368 05:10:28 INFO - Running post-run listener: _upload_blobber_files 05:10:28 INFO - Blob upload gear active. 05:10:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:28 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 05:10:28 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'] 05:10:28 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 05:10:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:29 INFO - (blobuploader) - INFO - Done attempting. 05:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:10:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:30 INFO - (blobuploader) - INFO - Done attempting. 05:10:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:30 INFO - Return code: 0 05:10:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/5f9b025fe641aca77b7c4a4ec99e724859a1ab8ef861bc8b85053bcd41837e6b5d8dde58b6392d50bfc54998cc9844cdf6718776c0dc6eb32389a5581cac76fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6f64a0949567d449fecd4402b4f25e5f9250fffcc9359ef262dacb82d9e4f665892e62a8364c1f850cd97c82c58e99abe86da359126343b31e7ad8039a65975a"} 05:10:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:30 INFO - Contents: 05:10:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/5f9b025fe641aca77b7c4a4ec99e724859a1ab8ef861bc8b85053bcd41837e6b5d8dde58b6392d50bfc54998cc9844cdf6718776c0dc6eb32389a5581cac76fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6f64a0949567d449fecd4402b4f25e5f9250fffcc9359ef262dacb82d9e4f665892e62a8364c1f850cd97c82c58e99abe86da359126343b31e7ad8039a65975a"} 05:10:30 INFO - Copying logs to upload dir... 05:10:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.693105 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-11 05:10:29.887838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:10:29.890864) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 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/5f9b025fe641aca77b7c4a4ec99e724859a1ab8ef861bc8b85053bcd41837e6b5d8dde58b6392d50bfc54998cc9844cdf6718776c0dc6eb32389a5581cac76fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6f64a0949567d449fecd4402b4f25e5f9250fffcc9359ef262dacb82d9e4f665892e62a8364c1f850cd97c82c58e99abe86da359126343b31e7ad8039a65975a"} build_url:https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/YsBDRn7PQ0SxrbqxKoTvIQ/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/5f9b025fe641aca77b7c4a4ec99e724859a1ab8ef861bc8b85053bcd41837e6b5d8dde58b6392d50bfc54998cc9844cdf6718776c0dc6eb32389a5581cac76fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6f64a0949567d449fecd4402b4f25e5f9250fffcc9359ef262dacb82d9e4f665892e62a8364c1f850cd97c82c58e99abe86da359126343b31e7ad8039a65975a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:10:29.915221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:10:29.915555) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452516549.951534-425560995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:10:29.998207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:10:29.998524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:10:29.998802) ========= ========= Total master_lag: 0.23 =========