builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1461934661.03 results: success (0) buildid: 20160429030215 builduid: 29582e4dd47643738e0a948071b178d8 revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.028966) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.029448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.029743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.053796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.054126) ========= 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=745a4373a2a16df560f216e000000264-1461934080.772365-746088716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 05:57:41-- 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% 223M=0s 2016-04-29 05:57:41 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.141460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.141867) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=745a4373a2a16df560f216e000000264-1461934080.772365-746088716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015520 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.195473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.195916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 --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=745a4373a2a16df560f216e000000264-1461934080.772365-746088716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 05:57:41,598 truncating revision to first 12 chars 2016-04-29 05:57:41,598 Setting DEBUG logging. 2016-04-29 05:57:41,598 attempt 1/10 2016-04-29 05:57:41,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3fd523d75b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 05:57:41,861 unpacking tar archive at: mozilla-central-8c3fd523d75b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.782821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.783160) ========= script_repo_revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.783561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.783844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:41.795548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-29 05:57:41.795891) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=745a4373a2a16df560f216e000000264-1461934080.772365-746088716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:42 INFO - MultiFileLogger online at 20160429 05:57:42 in /builds/slave/test 05:57:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:57:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:42 INFO - {'append_to_log': False, 05:57:42 INFO - 'base_work_dir': '/builds/slave/test', 05:57:42 INFO - 'blob_upload_branch': 'Firefox', 05:57:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:42 INFO - 'branch': 'Firefox', 05:57:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:42 INFO - 'config_files': ('talos/linux_config.py',), 05:57:42 INFO - 'default_actions': ('clobber', 05:57:42 INFO - 'read-buildbot-config', 05:57:42 INFO - 'download-and-extract', 05:57:42 INFO - 'populate-webroot', 05:57:42 INFO - 'create-virtualenv', 05:57:42 INFO - 'install', 05:57:42 INFO - 'run-tests'), 05:57:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:42 INFO - 'download_minidump_stackwalk': True, 05:57:42 INFO - 'download_symbols': 'ondemand', 05:57:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:42 INFO - 'installer_path': 'installer.exe', 05:57:42 INFO - 'log_level': 'info', 05:57:42 INFO - 'log_name': 'talos', 05:57:42 INFO - 'log_to_console': True, 05:57:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:42 INFO - 'opt_config_files': (), 05:57:42 INFO - 'pip_index': False, 05:57:42 INFO - 'sps_profile': False, 05:57:42 INFO - 'sps_profile_interval': 0, 05:57:42 INFO - 'suite': 'dromaeojs', 05:57:42 INFO - 'system_bits': '32', 05:57:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:42 INFO - 'title': 'talos-linux64-ix-032', 05:57:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:42 INFO - 'use_talos_json': True, 05:57:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:42 INFO - 'work_dir': 'build'} 05:57:42 INFO - ##### 05:57:42 INFO - ##### Running clobber step. 05:57:42 INFO - ##### 05:57:42 INFO - Running pre-action listener: _resource_record_pre_action 05:57:42 INFO - Running main action method: clobber 05:57:42 INFO - rmtree: /builds/slave/test/build 05:57:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:43 INFO - Running post-action listener: _resource_record_post_action 05:57:43 INFO - ##### 05:57:43 INFO - ##### Running read-buildbot-config step. 05:57:43 INFO - ##### 05:57:43 INFO - Running pre-action listener: _resource_record_pre_action 05:57:43 INFO - Running main action method: read_buildbot_config 05:57:43 INFO - Using buildbot properties: 05:57:43 INFO - { 05:57:43 INFO - "project": "", 05:57:43 INFO - "product": "firefox", 05:57:43 INFO - "script_repo_revision": "production", 05:57:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:57:43 INFO - "repository": "", 05:57:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:57:43 INFO - "buildid": "20160429030215", 05:57:43 INFO - "stage_platform": "linux64-pgo", 05:57:43 INFO - "basedir": "/builds/slave/test", 05:57:43 INFO - "nightly_build": "True", 05:57:43 INFO - "buildnumber": 758, 05:57:43 INFO - "slavename": "talos-linux64-ix-032", 05:57:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:57:43 INFO - "platform": "ubuntu64_hw", 05:57:43 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:57:43 INFO - "branch": "mozilla-central", 05:57:43 INFO - "repo_path": "mozilla-central", 05:57:43 INFO - "revision": "8c3fd523d75bd30f691ca2d6cfdad18d576392a1", 05:57:43 INFO - "pgo_build": "True", 05:57:43 INFO - "builduid": "29582e4dd47643738e0a948071b178d8", 05:57:43 INFO - "slavebuilddir": "test" 05:57:43 INFO - } 05:57:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:57:43 INFO - Running post-action listener: _resource_record_post_action 05:57:43 INFO - ##### 05:57:43 INFO - ##### Running download-and-extract step. 05:57:43 INFO - ##### 05:57:43 INFO - Running pre-action listener: _resource_record_pre_action 05:57:43 INFO - Running main action method: download_and_extract 05:57:43 INFO - mkdir: /builds/slave/test/build/tests 05:57: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')]} 05:57:43 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:57:50 INFO - Downloaded 1361 bytes. 05:57:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:50 INFO - Using the following test package requirements: 05:57:50 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:50 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:57:50 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:57:50 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'jsshell-linux-x86_64.zip'], 05:57:50 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:57:50 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:50 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:57:50 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:57:50 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:57:50 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:57:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:50 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:02 INFO - Downloaded 23873520 bytes. 05:58:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:03 INFO - Return code: 0 05:58:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:58:03 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')]} 05:58:03 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:04 INFO - Downloaded 23873520 bytes. 05:58:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:06 INFO - Return code: 0 05:58:06 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')]} 05:58:06 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:07 INFO - Downloaded 10840145 bytes. 05:58:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:58:07 INFO - Return code: 0 05:58:07 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')]} 05:58:07 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:58:12 INFO - Downloaded 58392596 bytes. 05:58:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:12 INFO - mkdir: /builds/slave/test/properties 05:58:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:12 INFO - Contents: 05:58:12 INFO - build_url:https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:12 INFO - Running post-action listener: _resource_record_post_action 05:58:12 INFO - Running post-action listener: set_extra_try_arguments 05:58:12 INFO - ##### 05:58:12 INFO - ##### Running populate-webroot step. 05:58:12 INFO - ##### 05:58:12 INFO - Running pre-action listener: _resource_record_pre_action 05:58:12 INFO - Running main action method: populate_webroot 05:58:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:12 INFO - '--tppagecycles', 05:58:12 INFO - '7'], 05:58:12 INFO - 'tests': ['tsvgm']}}, 05:58:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['damp', 'tps']}, 05:58:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'tests': ['damp', 'tps']}, 05:58:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['dromaeo_dom']}, 05:58:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['a11yr', 05:58:12 INFO - 'ts_paint', 05:58:12 INFO - 'tpaint', 05:58:12 INFO - 'sessionrestore', 05:58:12 INFO - 'sessionrestore_no_auto_restore', 05:58:12 INFO - 'tabpaint']}, 05:58:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:12 INFO - 'ts_paint', 05:58:12 INFO - 'tpaint', 05:58:12 INFO - 'sessionrestore', 05:58:12 INFO - 'sessionrestore_no_auto_restore', 05:58:12 INFO - 'tabpaint']}, 05:58:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:12 INFO - 'ts_paint', 05:58:12 INFO - 'tpaint', 05:58:12 INFO - 'sessionrestore', 05:58:12 INFO - 'sessionrestore_no_auto_restore', 05:58:12 INFO - 'tabpaint']}, 05:58:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:12 INFO - 'ts_paint', 05:58:12 INFO - 'tpaint', 05:58:12 INFO - 'sessionrestore', 05:58:12 INFO - 'sessionrestore_no_auto_restore', 05:58:12 INFO - 'tabpaint']}, 05:58:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['a11yr', 05:58:12 INFO - 'ts_paint', 05:58:12 INFO - 'tpaint', 05:58:12 INFO - 'sessionrestore', 05:58:12 INFO - 'sessionrestore_no_auto_restore', 05:58:12 INFO - 'tabpaint']}, 05:58:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['a11yr', 05:58:12 INFO - 'ts_paint', 05:58:12 INFO - 'tpaint', 05:58:12 INFO - 'sessionrestore', 05:58:12 INFO - 'sessionrestore_no_auto_restore', 05:58:12 INFO - 'tabpaint']}, 05:58:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['tsvgx', 05:58:12 INFO - 'tsvgr_opacity', 05:58:12 INFO - 'tart', 05:58:12 INFO - 'tscrollx', 05:58:12 INFO - 'cart']}, 05:58:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:12 INFO - 'tsvgr_opacity', 05:58:12 INFO - 'tart', 05:58:12 INFO - 'tscrollx', 05:58:12 INFO - 'cart']}, 05:58:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'talos_options': ['--disable-e10s'], 05:58:12 INFO - 'tests': ['tp5o']}, 05:58:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'tests': ['tp5o']}, 05:58:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'talos_options': ['--disable-e10s', 05:58:12 INFO - '--xperf_path', 05:58:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:12 INFO - 'tests': ['tp5n']}, 05:58:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:12 INFO - 'talos_options': ['--xperf_path', 05:58:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:12 INFO - 'tests': ['tp5n']}}, 05:58:12 INFO - 'talos.zip': {'path': '', 05:58:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:12 INFO - Running post-action listener: _resource_record_post_action 05:58:12 INFO - ##### 05:58:12 INFO - ##### Running create-virtualenv step. 05:58:12 INFO - ##### 05:58:12 INFO - Running pre-action listener: _resource_record_pre_action 05:58:12 INFO - Running main action method: create_virtualenv 05:58:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:12 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 05:58:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:13 INFO - Using real prefix '/usr' 05:58:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:15 INFO - Installing pip.................done. 05:58:15 INFO - Return code: 0 05:58:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:15 INFO - Using env: {'DISPLAY': ':0', 05:58:15 INFO - 'HOME': '/home/cltbld', 05:58:15 INFO - 'LANG': 'en_US.UTF-8', 05:58:15 INFO - 'LANGUAGE': 'en_US:en', 05:58:15 INFO - 'LOGNAME': 'cltbld', 05:58:15 INFO - 'MAIL': '/var/mail/cltbld', 05:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:15 INFO - 'MOZ_NO_REMOTE': '1', 05:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:15 INFO - 'NO_EM_RESTART': '1', 05:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:15 INFO - 'PWD': '/builds/slave/test', 05:58:15 INFO - 'SHELL': '/bin/bash', 05:58:15 INFO - 'SHLVL': '1', 05:58:15 INFO - 'TERM': 'linux', 05:58:15 INFO - 'TMOUT': '86400', 05:58:15 INFO - 'USER': 'cltbld', 05:58:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:15 INFO - '_': '/tools/buildbot/bin/python'} 05:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:15 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 05:58:15 INFO - Cleaning up... 05:58:15 INFO - Return code: 0 05:58:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:15 INFO - Using env: {'DISPLAY': ':0', 05:58:15 INFO - 'HOME': '/home/cltbld', 05:58:15 INFO - 'LANG': 'en_US.UTF-8', 05:58:15 INFO - 'LANGUAGE': 'en_US:en', 05:58:15 INFO - 'LOGNAME': 'cltbld', 05:58:15 INFO - 'MAIL': '/var/mail/cltbld', 05:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:15 INFO - 'MOZ_NO_REMOTE': '1', 05:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:15 INFO - 'NO_EM_RESTART': '1', 05:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:15 INFO - 'PWD': '/builds/slave/test', 05:58:15 INFO - 'SHELL': '/bin/bash', 05:58:15 INFO - 'SHLVL': '1', 05:58:15 INFO - 'TERM': 'linux', 05:58:15 INFO - 'TMOUT': '86400', 05:58:15 INFO - 'USER': 'cltbld', 05:58:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:15 INFO - '_': '/tools/buildbot/bin/python'} 05:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:15 INFO - Downloading/unpacking psutil>=0.7.1 05:58:15 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 05:58:15 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 05:58:15 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 05:58:15 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 05:58:15 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 05:58:15 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 05:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:17 INFO - Installing collected packages: psutil 05:58:17 INFO - Running setup.py install for psutil 05:58:17 INFO - building 'psutil._psutil_linux' extension 05:58:17 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 05:58:18 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 05:58:18 INFO - building 'psutil._psutil_posix' extension 05:58:18 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 05:58:18 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 05:58:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:18 INFO - Successfully installed psutil 05:58:18 INFO - Cleaning up... 05:58:18 INFO - Return code: 0 05:58:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:18 INFO - Using env: {'DISPLAY': ':0', 05:58:18 INFO - 'HOME': '/home/cltbld', 05:58:18 INFO - 'LANG': 'en_US.UTF-8', 05:58:18 INFO - 'LANGUAGE': 'en_US:en', 05:58:18 INFO - 'LOGNAME': 'cltbld', 05:58:18 INFO - 'MAIL': '/var/mail/cltbld', 05:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:18 INFO - 'MOZ_NO_REMOTE': '1', 05:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:18 INFO - 'NO_EM_RESTART': '1', 05:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:18 INFO - 'PWD': '/builds/slave/test', 05:58:18 INFO - 'SHELL': '/bin/bash', 05:58:18 INFO - 'SHLVL': '1', 05:58:18 INFO - 'TERM': 'linux', 05:58:18 INFO - 'TMOUT': '86400', 05:58:18 INFO - 'USER': 'cltbld', 05:58:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:18 INFO - '_': '/tools/buildbot/bin/python'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:58:18 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 05:58:18 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 05:58:18 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 05:58:18 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 05:58:18 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 05:58:18 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 05:58:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:58:20 INFO - Installing collected packages: mozsystemmonitor 05:58:20 INFO - Running setup.py install for mozsystemmonitor 05:58:20 INFO - Successfully installed mozsystemmonitor 05:58:20 INFO - Cleaning up... 05:58:20 INFO - Return code: 0 05:58:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:20 INFO - Using env: {'DISPLAY': ':0', 05:58:20 INFO - 'HOME': '/home/cltbld', 05:58:20 INFO - 'LANG': 'en_US.UTF-8', 05:58:20 INFO - 'LANGUAGE': 'en_US:en', 05:58:20 INFO - 'LOGNAME': 'cltbld', 05:58:20 INFO - 'MAIL': '/var/mail/cltbld', 05:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:20 INFO - 'MOZ_NO_REMOTE': '1', 05:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:20 INFO - 'NO_EM_RESTART': '1', 05:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:20 INFO - 'PWD': '/builds/slave/test', 05:58:20 INFO - 'SHELL': '/bin/bash', 05:58:20 INFO - 'SHLVL': '1', 05:58:20 INFO - 'TERM': 'linux', 05:58:20 INFO - 'TMOUT': '86400', 05:58:20 INFO - 'USER': 'cltbld', 05:58:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:20 INFO - '_': '/tools/buildbot/bin/python'} 05:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 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 05:58:23 INFO - Downloading docopt-0.6.1.tar.gz 05:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:23 INFO - Running setup.py install for blobuploader 05:58:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:23 INFO - Running setup.py install for requests 05:58:24 INFO - Running setup.py install for docopt 05:58:24 INFO - Successfully installed blobuploader requests docopt 05:58:24 INFO - Cleaning up... 05:58:24 INFO - Return code: 0 05:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:24 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')]} 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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')]} 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:58:24 INFO - Using env: {'DISPLAY': ':0', 05:58:24 INFO - 'HOME': '/home/cltbld', 05:58:24 INFO - 'LANG': 'en_US.UTF-8', 05:58:24 INFO - 'LANGUAGE': 'en_US:en', 05:58:24 INFO - 'LOGNAME': 'cltbld', 05:58:24 INFO - 'MAIL': '/var/mail/cltbld', 05:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:24 INFO - 'MOZ_NO_REMOTE': '1', 05:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:24 INFO - 'NO_EM_RESTART': '1', 05:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:24 INFO - 'PWD': '/builds/slave/test', 05:58:24 INFO - 'SHELL': '/bin/bash', 05:58:24 INFO - 'SHLVL': '1', 05:58:24 INFO - 'TERM': 'linux', 05:58:24 INFO - 'TMOUT': '86400', 05:58:24 INFO - 'USER': 'cltbld', 05:58:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:24 INFO - '_': '/tools/buildbot/bin/python'} 05:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:24 INFO - Running setup.py (path:/tmp/pip-_GFjIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:24 INFO - Running setup.py (path:/tmp/pip-_9XuVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:24 INFO - Running setup.py (path:/tmp/pip-mnvSKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:24 INFO - Running setup.py (path:/tmp/pip-IZF0sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:24 INFO - Running setup.py (path:/tmp/pip-FgT20Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:24 INFO - Running setup.py (path:/tmp/pip-pLAgut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:25 INFO - Running setup.py (path:/tmp/pip-ggNMxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:25 INFO - Running setup.py (path:/tmp/pip-RyA9hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:25 INFO - Running setup.py (path:/tmp/pip-AJef4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:25 INFO - Running setup.py (path:/tmp/pip-B2HFyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:25 INFO - Running setup.py (path:/tmp/pip-T_1jLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:25 INFO - Running setup.py (path:/tmp/pip-tf_wZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:25 INFO - Running setup.py (path:/tmp/pip-91pv6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:25 INFO - Running setup.py (path:/tmp/pip-5SZbWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:25 INFO - Running setup.py (path:/tmp/pip-dHYGp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:25 INFO - Running setup.py (path:/tmp/pip-RAopEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:25 INFO - Running setup.py (path:/tmp/pip-LQMLOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:25 INFO - Running setup.py install for manifestparser 05:58:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:25 INFO - Running setup.py install for mozcrash 05:58:25 INFO - Running setup.py install for mozdebug 05:58:26 INFO - Running setup.py install for mozdevice 05:58:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Running setup.py install for mozfile 05:58:26 INFO - Running setup.py install for mozhttpd 05:58:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Running setup.py install for mozinfo 05:58:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Running setup.py install for mozInstall 05:58:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Running setup.py install for mozleak 05:58:26 INFO - Running setup.py install for mozlog 05:58:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Running setup.py install for moznetwork 05:58:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:26 INFO - Running setup.py install for mozprocess 05:58:27 INFO - Running setup.py install for mozprofile 05:58:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Running setup.py install for mozrunner 05:58:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Running setup.py install for mozscreenshot 05:58:27 INFO - Running setup.py install for moztest 05:58:27 INFO - Running setup.py install for mozversion 05:58:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:27 INFO - Cleaning up... 05:58:27 INFO - Return code: 0 05:58:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:27 INFO - Using env: {'DISPLAY': ':0', 05:58:27 INFO - 'HOME': '/home/cltbld', 05:58:27 INFO - 'LANG': 'en_US.UTF-8', 05:58:27 INFO - 'LANGUAGE': 'en_US:en', 05:58:27 INFO - 'LOGNAME': 'cltbld', 05:58:27 INFO - 'MAIL': '/var/mail/cltbld', 05:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:27 INFO - 'MOZ_NO_REMOTE': '1', 05:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:27 INFO - 'NO_EM_RESTART': '1', 05:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:27 INFO - 'PWD': '/builds/slave/test', 05:58:27 INFO - 'SHELL': '/bin/bash', 05:58:27 INFO - 'SHLVL': '1', 05:58:27 INFO - 'TERM': 'linux', 05:58:27 INFO - 'TMOUT': '86400', 05:58:27 INFO - 'USER': 'cltbld', 05:58:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:27 INFO - '_': '/tools/buildbot/bin/python'} 05:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:27 INFO - Running setup.py (path:/tmp/pip-WrwM9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:27 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)) 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:27 INFO - Running setup.py (path:/tmp/pip-pY6cIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:27 INFO - Running setup.py (path:/tmp/pip-0jgqwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:28 INFO - Running setup.py (path:/tmp/pip-Hl9Fw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:28 INFO - Running setup.py (path:/tmp/pip-Zvk17T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:28 INFO - Running setup.py (path:/tmp/pip-CNF9Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:28 INFO - Running setup.py (path:/tmp/pip-vvziwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:28 INFO - Running setup.py (path:/tmp/pip-HKNxAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:28 INFO - Running setup.py (path:/tmp/pip-WkUAjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:28 INFO - Running setup.py (path:/tmp/pip-lI9rY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:28 INFO - Running setup.py (path:/tmp/pip-VObhcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:28 INFO - Running setup.py (path:/tmp/pip-Yh9W6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:28 INFO - Running setup.py (path:/tmp/pip-recFiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:28 INFO - Running setup.py (path:/tmp/pip-WUiteg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:28 INFO - Running setup.py (path:/tmp/pip-e0jVX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:28 INFO - Running setup.py (path:/tmp/pip-EAPc0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:28 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)) 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:28 INFO - Running setup.py (path:/tmp/pip-owvybz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:29 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)) 05:58:29 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:29 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:29 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)) 05:58:29 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:29 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:30 INFO - Downloading blessings-1.6.tar.gz 05:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:31 INFO - Installing collected packages: blessings 05:58:31 INFO - Running setup.py install for blessings 05:58:31 INFO - Successfully installed blessings 05:58:31 INFO - Cleaning up... 05:58:31 INFO - Return code: 0 05:58:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:31 INFO - Reading from file tmpfile_stdout 05:58:31 INFO - Current package versions: 05:58:31 INFO - argparse == 1.2.1 05:58:31 INFO - blessings == 1.6 05:58:31 INFO - blobuploader == 1.2.4 05:58:31 INFO - docopt == 0.6.1 05:58:31 INFO - manifestparser == 1.1 05:58:31 INFO - mozInstall == 1.12 05:58:31 INFO - mozcrash == 0.17 05:58:31 INFO - mozdebug == 0.1 05:58:31 INFO - mozdevice == 0.48 05:58:31 INFO - mozfile == 1.2 05:58:31 INFO - mozhttpd == 0.7 05:58:31 INFO - mozinfo == 0.9 05:58:31 INFO - mozleak == 0.1 05:58:31 INFO - mozlog == 3.1 05:58:31 INFO - moznetwork == 0.27 05:58:31 INFO - mozprocess == 0.22 05:58:31 INFO - mozprofile == 0.28 05:58:31 INFO - mozrunner == 6.11 05:58:31 INFO - mozscreenshot == 0.1 05:58:31 INFO - mozsystemmonitor == 0.0 05:58:31 INFO - moztest == 0.7 05:58:31 INFO - mozversion == 1.4 05:58:31 INFO - psutil == 3.1.1 05:58:31 INFO - requests == 1.2.3 05:58:31 INFO - wsgiref == 0.1.2 05:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:31 INFO - Using env: {'DISPLAY': ':0', 05:58:31 INFO - 'HOME': '/home/cltbld', 05:58:31 INFO - 'LANG': 'en_US.UTF-8', 05:58:31 INFO - 'LANGUAGE': 'en_US:en', 05:58:31 INFO - 'LOGNAME': 'cltbld', 05:58:31 INFO - 'MAIL': '/var/mail/cltbld', 05:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:31 INFO - 'MOZ_NO_REMOTE': '1', 05:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:31 INFO - 'NO_EM_RESTART': '1', 05:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:31 INFO - 'PWD': '/builds/slave/test', 05:58:31 INFO - 'SHELL': '/bin/bash', 05:58:31 INFO - 'SHLVL': '1', 05:58:31 INFO - 'TERM': 'linux', 05:58:31 INFO - 'TMOUT': '86400', 05:58:31 INFO - 'USER': 'cltbld', 05:58:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:31 INFO - '_': '/tools/buildbot/bin/python'} 05:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 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)) 05:58:31 INFO - Cleaning up... 05:58:31 INFO - Return code: 0 05:58:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:31 INFO - Using env: {'DISPLAY': ':0', 05:58:31 INFO - 'HOME': '/home/cltbld', 05:58:31 INFO - 'LANG': 'en_US.UTF-8', 05:58:31 INFO - 'LANGUAGE': 'en_US:en', 05:58:31 INFO - 'LOGNAME': 'cltbld', 05:58:31 INFO - 'MAIL': '/var/mail/cltbld', 05:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:31 INFO - 'MOZ_NO_REMOTE': '1', 05:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:31 INFO - 'NO_EM_RESTART': '1', 05:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:31 INFO - 'PWD': '/builds/slave/test', 05:58:31 INFO - 'SHELL': '/bin/bash', 05:58:31 INFO - 'SHLVL': '1', 05:58:31 INFO - 'TERM': 'linux', 05:58:31 INFO - 'TMOUT': '86400', 05:58:31 INFO - 'USER': 'cltbld', 05:58:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:31 INFO - '_': '/tools/buildbot/bin/python'} 05:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:31 INFO - Downloading/unpacking jsonschema 05:58:31 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 05:58:31 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 05:58:31 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 05:58:31 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 05:58:31 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 05:58:31 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 05:58:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:33 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:33 INFO - warning: no files found matching '*.txt' 05:58:33 INFO - no previously-included directories found matching 'build' 05:58:33 INFO - no previously-included directories found matching 'dist' 05:58:33 INFO - no previously-included directories found matching '.git*' 05:58:34 INFO - Installing collected packages: jsonschema, functools32 05:58:34 INFO - Running setup.py install for functools32 05:58:34 INFO - warning: no files found matching '*.txt' 05:58:34 INFO - no previously-included directories found matching 'build' 05:58:34 INFO - no previously-included directories found matching 'dist' 05:58:34 INFO - no previously-included directories found matching '.git*' 05:58:34 INFO - Successfully installed jsonschema functools32 05:58:34 INFO - Cleaning up... 05:58:34 INFO - Return code: 0 05:58:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f228a681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, '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': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', '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 05:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:58:34 INFO - Using env: {'DISPLAY': ':0', 05:58:34 INFO - 'HOME': '/home/cltbld', 05:58:34 INFO - 'LANG': 'en_US.UTF-8', 05:58:34 INFO - 'LANGUAGE': 'en_US:en', 05:58:34 INFO - 'LOGNAME': 'cltbld', 05:58:34 INFO - 'MAIL': '/var/mail/cltbld', 05:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:34 INFO - 'MOZ_NO_REMOTE': '1', 05:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:34 INFO - 'NO_EM_RESTART': '1', 05:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:34 INFO - 'PWD': '/builds/slave/test', 05:58:34 INFO - 'SHELL': '/bin/bash', 05:58:34 INFO - 'SHLVL': '1', 05:58:34 INFO - 'TERM': 'linux', 05:58:34 INFO - 'TMOUT': '86400', 05:58:34 INFO - 'USER': 'cltbld', 05:58:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:34 INFO - '_': '/tools/buildbot/bin/python'} 05:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:34 INFO - Downloading/unpacking flake8 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:37 INFO - no previously-included directories found matching 'docs/_build' 05:58:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:37 INFO - Running setup.py install for pep8 05:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:37 INFO - no previously-included directories found matching 'docs/_build' 05:58:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:37 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Running post-action listener: _resource_record_post_action 05:58:38 INFO - Running post-action listener: _start_resource_monitoring 05:58:38 INFO - Starting resource monitoring. 05:58:38 INFO - ##### 05:58:38 INFO - ##### Running install step. 05:58:38 INFO - ##### 05:58:38 INFO - Running pre-action listener: _resource_record_pre_action 05:58:38 INFO - Running main action method: install 05:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:38 INFO - Reading from file tmpfile_stdout 05:58:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:38 INFO - Reading from file tmpfile_stdout 05:58:38 INFO - Output received: 05:58:38 INFO - Usage: mozinstall [options] installer 05:58:38 INFO - Options: 05:58:38 INFO - -h, --help show this help message and exit 05:58:38 INFO - -d DEST, --destination=DEST 05:58:38 INFO - Directory to install application into. [default: 05:58:38 INFO - "/builds/slave/test"] 05:58:38 INFO - --app=APP Application being installed. [default: firefox] 05:58:38 INFO - mkdir: /builds/slave/test/build/application 05:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:58:55 INFO - Reading from file tmpfile_stdout 05:58:55 INFO - Output received: 05:58:55 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:55 INFO - Running post-action listener: _resource_record_post_action 05:58:55 INFO - ##### 05:58:55 INFO - ##### Running run-tests step. 05:58:55 INFO - ##### 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: run_tests 05:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:55 INFO - Python 2.7.3 05:58:55 INFO - Return code: 0 05:58:55 INFO - grabbing minidump binary from tooltool 05:58:55 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')]} 05:58:55 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 0x23df810>, '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 0x23e0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:55 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 05:58:55 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 05:58:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:55 INFO - Return code: 0 05:58:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:58:56 INFO - Return code: 0 05:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 05:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 05:58:56 INFO - Using env: {'DISPLAY': ':0', 05:58:56 INFO - 'HOME': '/home/cltbld', 05:58:56 INFO - 'LANG': 'en_US.UTF-8', 05:58:56 INFO - 'LANGUAGE': 'en_US:en', 05:58:56 INFO - 'LOGNAME': 'cltbld', 05:58:56 INFO - 'MAIL': '/var/mail/cltbld', 05:58:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:56 INFO - 'MOZ_NO_REMOTE': '1', 05:58:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:56 INFO - 'NO_EM_RESTART': '1', 05:58:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:56 INFO - 'PWD': '/builds/slave/test', 05:58:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:56 INFO - 'SHELL': '/bin/bash', 05:58:56 INFO - 'SHLVL': '1', 05:58:56 INFO - 'TERM': 'linux', 05:58:56 INFO - 'TMOUT': '86400', 05:58:56 INFO - 'USER': 'cltbld', 05:58:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461934080.772365-746088716', 05:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:56 INFO - '_': '/tools/buildbot/bin/python'} 05:58:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 05:58:56 INFO - mozversion application_buildid: 20160429030215 05:58:56 INFO - mozversion application_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 05:58:56 INFO - mozversion application_display_name: Nightly 05:58:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:56 INFO - mozversion application_name: Firefox 05:58:56 INFO - mozversion application_remotingname: firefox 05:58:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:56 INFO - mozversion application_vendor: Mozilla 05:58:56 INFO - mozversion application_version: 49.0a1 05:58:56 INFO - mozversion platform_buildid: 20160429030215 05:58:56 INFO - mozversion platform_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 05:58:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:56 INFO - mozversion platform_version: 49.0a1 05:58:56 INFO - using testdate: 1461934736 05:58:56 INFO - actual date: 1461934736 05:58:56 INFO - starting webserver on 'localhost:60808' 05:58:56 INFO - SUITE-START | Running 2 tests 05:58:56 INFO - TEST-START | dromaeo_css 05:58:56 INFO - operating with platform_type : linux_ 05:58:56 INFO - Initialising browser for dromaeo_css test... 05:58:56 INFO - TEST-INFO | started process 18970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppiLLR6/profile http://localhost:60808/getInfo.html) 05:59:01 INFO - PROCESS | 18970 | __metrics Screen width/height:1600/1200 05:59:01 INFO - PROCESS | 18970 | colorDepth:24 05:59:01 INFO - PROCESS | 18970 | Browser inner width/height: 1024/697 05:59:01 INFO - PROCESS | 18970 | __metrics 05:59:02 ERROR - PROCESS | 18970 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:59:03 INFO - TEST-INFO | 18970: exit 0 05:59:03 INFO - Browser initialized. 05:59:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:03 INFO - TEST-INFO | started process 19052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppiLLR6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:15 INFO - PROCESS | 19052 | RSS: Main: 154316800 05:59:15 INFO - PROCESS | 19052 | 06:00:06 INFO - PROCESS | 19052 | 1461934806528 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] 06:02:13 INFO - PROCESS | 19052 | Cycle 1(1): loaded http://localhost:60808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60808/tests/dromaeo/cssquery-ext.html) 06:02:15 INFO - PROCESS | 19052 | RSS: Main: 232792064 06:02:15 INFO - PROCESS | 19052 | 06:05:17 INFO - PROCESS | 19052 | Cycle 1(1): loaded http://localhost:60808/tests/dromaeo/cssquery-ext.html (next: http://localhost:60808/tests/dromaeo/cssquery-jquery.html) 06:05:18 INFO - PROCESS | 19052 | RSS: Main: 236638208 06:05:18 INFO - PROCESS | 19052 | 06:08:19 INFO - PROCESS | 19052 | Cycle 1(1): loaded http://localhost:60808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60808/tests/dromaeo/cssquery-mootools.html) 06:08:20 INFO - PROCESS | 19052 | RSS: Main: 240156672 06:08:20 INFO - PROCESS | 19052 | 06:11:22 INFO - PROCESS | 19052 | Cycle 1(1): loaded http://localhost:60808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60808/tests/dromaeo/cssquery-prototype.html) 06:11:23 INFO - PROCESS | 19052 | RSS: Main: 238850048 06:11:23 INFO - PROCESS | 19052 | 06:14:25 INFO - PROCESS | 19052 | Cycle 1(1): loaded http://localhost:60808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60808/tests/dromaeo/cssquery-yui.html) 06:14:26 INFO - PROCESS | 19052 | RSS: Main: 212615168 06:14:26 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | Cycle 1(1): loaded http://localhost:60808/tests/dromaeo/cssquery-yui.html (next: http://localhost:60808/tests/dromaeo/cssquery-dojo.html) 06:17:28 INFO - PROCESS | 19052 | RSS: Main: 270475264 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | __start_tp_report 06:17:28 INFO - PROCESS | 19052 | _x_x_mozilla_page_load 06:17:28 INFO - PROCESS | 19052 | _x_x_mozilla_page_load_details 06:17:28 INFO - PROCESS | 19052 | |i|pagename|runs| 06:17:28 INFO - PROCESS | 19052 | |0;dojo.html;3083.414151311251;3134.4984802431613;3174.936501269976;3182.204448887778;3211.036688993302;5086.084504789136;5239.476052394768;5274.683518988863;5297.496737809912;5322;5244.68531888086;5288.497592728685;5301.946980530193;5317.042932272189;5318.30861987942;4758.738269395182;4776.928346074812;4778;4793.616510679155;4986.252062190664;4892.730899800509;4955.380577427822;4966.453690094087;4967.329410529568;4977.925331120036;4744.169770290203;4807.543283388072;4826.879328016793;4875.219964805632;4918.114739346916;4767.165745994437;4768.427788665348;4773.737444440554;4776.0925424169645;4807.687500312503;4701.976490117561;4734.810607575727;4742.241241401359;4747.216709242971;4775.474697783241;5081.974590127025;5108.565771909355;5172.612054095958;5202.167653175474;5204.115300398941;5577.721113944286;5585.190147428641;5614.045612245928;5618.91571626426;5624.128260119688;5453.372862120827;5657.462541058593;5658.858528536778;5659.773609055633;5663.093904975184;5261.921071183897;5272.710000949946;5290.153575427913;5295.364556253275;5335.839924802262;5727.942720572824;5734.541236701054;5735.311762588516;5736.913946290809;5737.08206686928;5384.138537833927;5515.972420137874;5521.503064724194;5526.723663816793;5529.834104976857;5592.636478628876;5596.356419011784;5599.44005599445;5631.943680563142;5652.208690783294;5565.7217139143695;5568.860778480489;5569.749361278752;5571.832845014656;5577.163425486209;5389.272448219519;5596.300462442195;5599.636023658449;5633.8309850704545;5717.914231286534;4237.173751118564;4241.597048280409;4270.978645106755;4281.293586558245;4282.850100246539;3790.2419516096893;3798.563165235978;3799.525059367579;3837.520309961255;3850.614938506127;5157.303763991888;5201.6358854880555;5244.816431424882;5269.973650131801;5283.049051170749;5651.208830763697;5665.150227465913;5665.348484924287;5667.943320566824;5702.800401985911;5326.067938110815;5338.039152952506;5342.439043900335;5348.598855085884;5387.568994480433;4726.598239149711;4800.975995120002;4848.00615873745;4854.490278520775;4864.294677271776;5718.085106382959;5727.427257274239;5727.828165155052;5733.054046082433;5755.740991655385;5540.612157148961;5542.0301447247375;5543.057680194457;5549.861253468534;5552.361478429952;5631.746571404378;5726.713664316851;5766.596338256281;5888.617239879394;5907.350191478848;5528.640638358494;5531.03206938776;5532.778688852401;5559.110542313372;5579.916301255404;5607.43925607436;5612.298462692163;5614.747336369955;5615.831525054255;5619.157126431068;5230.764615592384;5461.15352120422;5483.4516548344845;5510.201020851874;5565.1374037024325;5436.972815135899;5441.863953401196;5444.047291724011;5444.128939369682;5476.12382018891;5353.2505449237915;5354.2771725818075;5362.544183744425;5362.919556206738;5410.648307860134;5339.706316152494;5469.179623056573;5471.945280547144;5513.7794488221625;5550.417206193291;5308.575313974796;5318.228856815817;5323.600729945347;5325.09473389517;5373.140297552372 06:17:28 INFO - PROCESS | 19052 | |1;ext.html;603.4146877528798;645.9612423254605;648.6562122075298;650.8112647332274;652.4226059936955;30751;38273.80863095684;39553.802230988804;39938.600613993854;39996.80001599995;42230;42896.57103428965;42902.57097429025;43000.784996075054;43022.35466468005;8432.747017589481;8653.610587523544;8660.30717542595;8663.35024873137;8679.479231246145;8527.360447966395;8678.522681252529;8680.56597170142;8686.609102590399;8881.06748791374;8831.77920551988;8922.687705930293;8927.821443571125;8928.776780580505;8933.59798809055;8773.473591584494;8843.159899809507;8857.335699822539;8862;8865.06916773736;8669.523176225304;8785.868211976825;8789;8789.121087891159;8792.956035219848;42450.57549424497;43045.13909721819;43055.35416968748;43176.352354714705;43189.35215971763;3679.6688298053305;3799.715021373408;3949.743266687656;4041.717079804415;4321.222180007598;28760;29310.267243318875;32516.56619002555;32684.346313073842;33128.6687133128;4219.472565929259;4328.350747387885;4336.674749393808;4371.9781401093105;4387.73673579583;239193;240462;241209;241418;242494;56418;56568;56881.71559142178;56952.43047569471;57025.429745702015;51466.74266628718;56871;58738.41261587415;63918.360816392174;63950;16741.832581674273;17223;17223.22495487706;17240.482785516204;17243.137843107794;12844.100912936192;12953.481860725466;12959.546415875398;12967.546135885388;12976.675583110498;16590.419335323448;18586.628267434575;19009.61980760377;19103.904480477508;19582.31461898827;7197.020819274637;7320.560766354036;7464.962675186698;7465.776026719207;7526.887096693554;989.5448093876753;1023.2581378500528;1049.8267785815256;1055.8257887448485;1099.8515200447837;32417.189570260933;32514.674853251163;32652.346953060805;33343.833280833926;33477.330453390794;1116.0959622705634;1125.7861006408757;1151.988480115205;1155.942202889852;1229.2685851918095;17270.22283997198;17745.7338139928;17762.555936101442;17779.644407111784;17808.91095544514;481598;484253;488812;489457;489979;59158.704206478695;59877.700611496664;60195.09707354393;60334.39665603376;60458;1276.7510335484492;1346.7037251804784;1390.7774756038984;1414.4003511064366;1436.4110714606961;28973.420531589672;30685.386292273583;30706.232344191572;32635;33580.83209583937;41896.581034189265;47919.76040119777;49088.263676044175;49170.75414623047;49287.75356123196;440199;443722.8138592993;446834;447432;448819;33696.663033370336;39258.411123833735;39583.40624890687;40331.79834100811;43874.78062609667;42686.5731342695;42913.35629965491;43084.35373469338;43666.78166609147;43736.78131609321;36686.082847929014;37072.81463592665;37604.435933461566;37696.811515942245;37793.62206377901;36128.45807312945;37077;37174;37189.62810371862;37338.81330593438;40657.59342406538;40962.79518602388;40997.18005639811;41474.37788433115;41766.37350439806;34344.48483272703;35610;35974;36068;36157.457638134925;26075.60886586665;26778.866105669345;27208.183754487396;27621.723782762718;28030.159095227176 06:17:28 INFO - PROCESS | 19052 | |2;jquery.html;387.3801916932908;392.40158757894227;394.0896529017967;394.6224000397606;394.9723519353645;14441.78337324941;16970.915145424286;18307.63384732306;19692.507687307807;19946.90026549867;15172.317245723942;17506.56233594161;18296.268149274045;18316.08419579019;19011.61976760464;5640.605157638956;5819.33077696064;5827.708614569255;5827.941720582803;5828.446297601721;4193.811278492475;5748.82753517393;5790.102534107199;6127.938720612804;6471.9029214561815;6394.200724909387;6414.10202571638;6426.518011149159;6443.0657554654545;6443.645599492026;6146.508279337665;6497.707603157869;6509.414152726254;6521.478281737497;6522.608643481382;5465.234867118606;5727.828165155052;5732.971335143339;5738.799142030009;5763.5101016413655;21978.560428791494;22419.439514012116;22522.54954900909;22778;22999.885000575057;2415.7101147862195;2485.9254222373356;2533.873306334676;2588.3399733067945;2861.241770930705;8404.41169118162;9085.227755640779;9183.632654693803;9363.71908842729;14184.148951062969;1924.2687778644165;1954.171557047854;1965.626530959113;2014.8488863335308;2052.107333310015;78079;78248.60875695584;79029.99999999942;79089.60455197745;82186.17813821846;10010.899891001143;10323.432211228304;10444.738881528023;10510.947445262726;10667.679969600924;14169.645758855904;14283;14325.283735813377;14327.35526901292;14354.354054067591;7854.057513098464;7931.087924888711;7940.563269020259;8119.512829230265;8146.30756385702;6791.4906382021545;6933.93066069343;7118.110236220473;7323.670434830446;8017.518948863087;4263.978680106579;4476.194285028661;4496.213162696515;4639.468975238164;4654.557817007379;1784.8036715961493;1833.6149408624337;1844.7970723220435;1860.3302810988034;1876.521487020801;997.7854761226371;1026.7741096958657;1037.4812593703148;1039.4906495816995;1040.0379648824808;18427.81572184288;18443.262269509338;18772.906135469235;19013.144408501375;19055.142518586697;942.6700654770913;954.0507195340681;1031.185363562792;1034.7102811212872;1036.4817591204398;10298.794024119476;10535.84196237057;10553.472326383804;10622.893771062345;10686.572537098584;468771;469569.3014889591;474300;478777;493844;89093;91060;91356.54321728482;93363.53318233366;93866.53066734623;1028.1620479309338;1073.7476692977143;1093.059968427152;1093.2511229807449;1094.070040465598;17028.404005859735;17054.2325595351;17148.657026859644;17544;17552.56118597045;36642.45036324511;39604.80197598993;42814.57185428106;43424.13151737011;43468.347974781034;54220.45779542154;55589.44410556005;56303.43696563146;56369.43630563642;56572.151417727946;8117.87461827189;8268.669253229804;8385.496870187808;8443.36674749384;8589.65641374338;11339.943300283447;13490;13566.321683915961;13692.520761773689;13796.241206733324;11580.247283926517;11631.76736465283;11835.171537992257;11849;12193.024558035158;11589.710257243636;11699.707507312045;11789.469473873867;11895.048396128463;11969.16215864881;6482.513811464065;11759.647210583697;12075.51697932073;12179.208351457128;12278.570250041206;8183.3453323732765;8454.57727113654;8583.699570515002;8618.913810861812;8719.956400218212;11447.942760286478;12142.453589588313;12142.575009874612;12148.331841748788;12268.938655306667 06:17:28 INFO - PROCESS | 19052 | |3;mootools.html;1350.9662258443532;1449.557884845122;1494.2379386512878;1625.5529729324435;1748.1521462090875;7328.743493977705;7631.847363052742;7632.236776322365;7632.618369081538;7649.961750191242;7385.187629360766;7567.394608431312;7573.5834529100875;7576.242375762421;7586.810329741759;1778.5197996540926;2009.1059478532059;2030.6649402848511;2074.6991686205492;2144.024468866662;2090.592334494774;2101.2120454829437;2102.6951092091635;2103.368989303203;2105.463106907744;2038.7329379366663;2054.12699602669;2057.403353027628;2059.618970490464;2059.9588008239825;1713.143428285857;2087.551176497045;2133.615949129156;2141.9036143373587;2142.4001279641725;2024.2813801100692;2037.3989673046487;2038.8878611676353;2041.765197002349;2044.090379780998;7599.544027358376;7601.31588157063;7631.046119235096;7632.084149901992;7634.961825190839;4504.684672072956;4709.670323077386;4745.074710431467;4745.383100196952;4795.448523419816;3115.7195852373397;3140.5917230759856;3212.084555901557;3221.8389080546112;3240.4491236489853;1029.23836361093;1031.3502493429166;1046.0585473074218;1092.071739021833;1116.4306203836102;10500.054995050406;10501.527431265611;10507.211959103022;10522.894771052268;10524.368537887674;4085.571015043437;4115.444415003996;4181.51912530063;4203.033302340479;4215.620594146541;8936.553172341357;8937.910620893837;8944.37389382737;8947.776305592412;8962.283017358595;4219.78901054946;4814.879628009257;4835.105505481497;4839.733814640158;4843.8304659337455;4280.293751531025;4381.38660587518;4381.978090109529;4394.780260987001;4403.295472724349;3457.377672019061;3508.3509550733197;3557.1285035166034;3577.5706915170344;3609.8375573099274;1027.7276521721749;1143.9027682646902;1151.407025381929;1151.4357964597286;1168.182272409317;851.7359618518279;955.9713208603753;957.9632564769697;959.788846453779;962.2686758063921;5226.451222621646;5269.367675878919;5333.57331413486;5407.107827208467;5480.451954804487;389.555906266856;390.7186825485646;392.0825268870799;393.87789785166115;393.9960600394017;3725.4225595032813;3770.1140232045445;3784.413415920537;3791.260704162717;3856.8071596420627;9009.549522523848;9321;9333.533323333806;9366.484843333546;9396.248300135972;9057.637694492278;9196.402233854778;9301.53492325381;9326.160645541933;9342.112499312554;7209.999999999895;7261.636918154071;7325.450591205681;7335.926640733631;7410.5183163094225;5101.51535604117;5158.845234642967;5255.290535777621;5283.5773138149625;5319.760610772602;8570.700025499078;8595.785105372415;8648.697295594624;8676.305895528469;8705.085965973482;8562.987697891116;8764.649414023623;8795.120487951153;8872.822543549222;8996.865047024168;6134.447899689049;6609.339066093352;6762.7294908205085;6793;6817.761378351734;7366.852662946818;7389.076365454318;7437.70249190048;7452.552846829208;7457.291557302047;6270.184875966095;6437.0666253392055;6458;6492.5455218134275;6519.576227545194;6369.363063693593;6389.073584330339;6514.869702606016;6571.638559879252;6724.495662825406;6090.786822461369;6140.846478838065;6149.569530132848;6159.630422174684;6168;4531.614812740822;4681.087187998308;4687.250039993584;4694.483606803181;4723.267893476516;4756.9524304756505;4809;4812.51874812516;4814.061258054786;4907.263910413467 06:17:28 INFO - PROCESS | 19052 | |4;prototype.html;323.80895271789655;329.5172572181753;331.3059141099397;332.7221769822198;334.1579220364681;5148.562372198363;5221.216817477381;5314.787408503665;5323.8819847832;5327.147656374981;5211.687298762077;5212.8696782580455;5223.947760522394;5236.795537026486;5267.710275934822;3890.0160917931917;3917.784521851297;4097.610726980932;4100.200460910124;4122.196171746511;4085.8978525536804;4087.509498860141;4105.548389677133;4113.465249517573;4121.319982202948;3828.2152158807517;4065;4068.4914385701786;4080.1635664688815;4081.3061779497557;3863.961360386388;3960.4158336665278;3984.322665146932;4054.837806487737;4108.876733697994;3538.929221415583;3589.228315912065;3607.701227558077;3615.4576813477925;3624.1221892574954;5063.215201643751;5068;5068.594512439033;5074.5432911037815;5104.4640312767;4559.908801823978;4621.607163391116;4638.466576343696;4664.55686709762;4681.57865792077;5413.186582494869;5422.728863556846;5439.5376393006645;5453.972730136364;5454.181872719084;3929.5481019682816;3936.76379417233;3949.8617548385955;3960.3465428204313;3964.0684439156776;5512.531434828044;5689.800856969986;5693.487586117228;5707.571932105067;5713.714514194314;4011.538673052578;4016.6142680775088;4019.598040195957;4024.1348110155873;4029.4761680981283;4049.1699201663587;4065.654419374327;4089.223047621002;4112;4129.855455059059;4492.573205545468;4622.168009758208;4646.884747660605;4650.627949764011;4659.8136074557315;5444.237806707064;5485.561155107582;5514;5525.4474552545225;5562.805301814417;1479.7484427647325;1482.4663121276333;1497.1840347010905;1497.5657059452853;1500.7223663622265;931.6320053578798;976.7460460280237;1012.1953047327393;1015.5836107196014;1022.9795404091876;5216.008958297912;5345.930813837248;5365.839024829262;5367.2485851980755;5367.5169234769055;5635.915461268084;5672.4894759471845;5683.602147849693;5685.403032681592;5689.032864412977;5022.949770502321;5335;5350.869741201441;5363.410024897258;5385.272988146628;3198.104530731399;3227.2415982244156;3227.580414546094;3229.6608856070243;3249.788763730397;6143.723532441051;6291.905621415683;6314.8001879642725;6324.778632747832;6335.809925702144;6153.815385538441;6196.721147548281;6221.408966148299;6235.220597425322;6245.156903817927;6247.406496382836;6250.343713909974;6251;6251.624902505864;6286.779962701375;5945.34601193877;6051.487128217946;6063.423974722395;6086.322018311928;6124.142620033288;5990.850228744316;5996.70016499182;5998.280206375263;6025.246844144482;6027.668478233739;6047.969760151171;6242.563020588515;6297.779577714758;6311.715972781144;6344.619322840645;4114.177164567039;4131.772752498521;4156.25187466259;4168.249715051199;4177;6072.787452439144;6095.146679464967;6169.105479705508;6181.381861813783;6193.535484838565;5325.360956685223;5545.223668686306;5559.388467268678;5996.700164991646;6001.159837622649;5503.11950087984;5529.612927095065;5543.750531226024;5553.250311207935;5571.9721401392735;5207.609429292743;5409.810656626999;5476.2607048049595;5485.780568777363;5501.917471237854;5149.382074151126;5517.69652669107;5542.7782888685615;5575.8884822304135;5596.328440586993;5453.800573558258;5456.263404440509;5461;5490.6980116094;5491.270249871438 06:17:28 INFO - PROCESS | 19052 | |5;yui.html;726.1358982810458;789.9921000789992;861.9612117454714;867.9652813887445;869.1221865915423;15444.073355598672;15608.141552214624;15681.686366272696;15718.449854255088;15792.526224213278;14117.082389644691;14170.929145354285;14183.787243191335;14199.858001419983;14211.78682319766;688.1432616392585;805.5408417202198;839.7312859884839;842.6208206307156;844.3287586368851;817.7587611654546;819.5697258939075;827.0612854410227;827.8137419080689;828.3662997806682;725.2928394815066;879.428371558489;879.4898958604026;880.2957633892892;883.730462209026;849.587949844325;870.5212133326645;870.5299138465222;871.895372555291;873.7466134820894;639.833643252753;640.8910485217477;641.2593454559944;645.8482256669679;645.9483241340681;13074.673133171747;13126.081174317802;13168.209907405586;13170.60488185356;13203.207807531482;13786.724265514735;14477;14717.411303547846;14725.705485890223;14789.40842366304;11072.169587280987;11081.390523521202;11127.499262533205;11183.32900026001;11423.371714555697;3845.2309538092495;3933.960660393388;3964.266610677034;4005.218982298453;4084.9387259191135;56427.71786141043;57103.71448142774;58202.41797582012;58227;58252.70873645604;10640.255182137176;10898.455077246106;10943.4528273586;11072.39101849406;11367.431628418546;18857.90571047136;19089.522761931064;19116.8088319115;19120.52198695016;19121.13954872034;8055.959720201361;8406.327493800482;8742.38803283764;8813.471191728517;8927.33045021626;4728.101660684459;4877.804887804519;4943.456219815817;4949.529794669501;5137.922931156036;3221.275213077039;3287.6383597804224;3298.356820419995;3327.434336162858;3328.417526932777;662.2251965200727;670.1723371636026;691.9584824910521;699.9405050570657;706.5584009993754;671.318611609217;695.5652717051843;696.7770313499632;697.2225968045593;709.0817391478048;8521.616527256288;9151.77120571991;9200.40197387181;9270.397424167408;9430.245580353556;691.5263044814318;758.1054355860027;762.3748526208567;770.9190534993745;802.1417083720363;4175.394567787715;4296.677749168763;4429.667774916894;4581.129585378767;4685.508021657745;55962;57802.421975779704;74585.25414745892;75674.24325756672;75764;56648;56787.43212567904;56825.43174568201;57511;58220.708896455246;53478.19782703263;53522;53772.19341709877;53788.73105634525;55704.44295557074;9677.467739274125;9710.028997100233;9720.708378748648;9849.556769945226;9858.753531161778;33333.66666333403;34833.08418037032;35422.291554169286;35785.284294314486;36539.817300913324;45072.323915141955;48829.51170488392;49130;49475.50524494709;49673.25490117579;11718.472668729757;11993.520259189883;12345.814812777637;12657.620271391874;13143;13626.659333516742;13999.930000350341;14012.929935350257;14171.291435427982;14177.787333190217;13375.933120334335;13379.665508362368;13410.530631427853;13539.932300338436;13691.726165476435;12468;13177.934110329386;13259.204447733167;13329.533466328632;13383.598492045254;11939.164258501822;12037.518499260283;12109.333986630467;12448.502059917502;12888.613341599766;10363.32638378503;10380.221483388625;10931;11074.335539867634;11145.36047733262;11147.944260278648;11241.156913231704;11373.545058197911;11388.94305528467;11407.657770266906 06:17:28 INFO - PROCESS | 19052 | __end_tp_report 06:17:28 INFO - PROCESS | 19052 | __start_cc_report 06:17:28 INFO - PROCESS | 19052 | _x_x_mozilla_cycle_collect,946 06:17:28 INFO - PROCESS | 19052 | __end_cc_report 06:17:28 INFO - PROCESS | 19052 | __startTimestamp1461935848985__endTimestamp 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | ------- Summary: start ------- 06:17:28 INFO - PROCESS | 19052 | Number of tests: 6 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | [#0] dojo.html Cycles:165 Average:5209.86 Median:5362.54 stddev:569.52 (10.6%) stddev-sans-first:546.29 06:17:28 INFO - PROCESS | 19052 | Values: 3083.4 3134.5 3174.9 3182.2 3211.0 5086.1 5239.5 5274.7 5297.5 5322.0 5244.7 5288.5 5301.9 5317.0 5318.3 4758.7 4776.9 4778.0 4793.6 4986.3 4892.7 4955.4 4966.5 4967.3 4977.9 4744.2 4807.5 4826.9 4875.2 4918.1 4767.2 4768.4 4773.7 4776.1 4807.7 4702.0 4734.8 4742.2 4747.2 4775.5 5082.0 5108.6 5172.6 5202.2 5204.1 5577.7 5585.2 5614.0 5618.9 5624.1 5453.4 5657.5 5658.9 5659.8 5663.1 5261.9 5272.7 5290.2 5295.4 5335.8 5727.9 5734.5 5735.3 5736.9 5737.1 5384.1 5516.0 5521.5 5526.7 5529.8 5592.6 5596.4 5599.4 5631.9 5652.2 5565.7 5568.9 5569.7 5571.8 5577.2 5389.3 5596.3 5599.6 5633.8 5717.9 4237.2 4241.6 4271.0 4281.3 4282.9 3790.2 3798.6 3799.5 3837.5 3850.6 5157.3 5201.6 5244.8 5270.0 5283.0 5651.2 5665.2 5665.3 5667.9 5702.8 5326.1 5338.0 5342.4 5348.6 5387.6 4726.6 4801.0 4848.0 4854.5 4864.3 5718.1 5727.4 5727.8 5733.1 5755.7 5540.6 5542.0 5543.1 5549.9 5552.4 5631.7 5726.7 5766.6 5888.6 5907.4 5528.6 5531.0 5532.8 5559.1 5579.9 5607.4 5612.3 5614.7 5615.8 5619.2 5230.8 5461.2 5483.5 5510.2 5565.1 5437.0 5441.9 5444.0 5444.1 5476.1 5353.3 5354.3 5362.5 5362.9 5410.6 5339.7 5469.2 5471.9 5513.8 5550.4 5308.6 5318.2 5323.6 5325.1 5373.1 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | [#1] ext.html Cycles:180 Average:55730.30 Median:41620.38 stddev:107522.30 (258.3%) stddev-sans-first:107744.26 06:17:28 INFO - PROCESS | 19052 | Values: 603.4 646.0 648.7 650.8 652.4 30751.0 38273.8 39553.8 39938.6 39996.8 42230.0 42896.6 42902.6 43000.8 43022.4 8432.7 8653.6 8660.3 8663.4 8679.5 8527.4 8678.5 8680.6 8686.6 8881.1 8831.8 8922.7 8927.8 8928.8 8933.6 8773.5 8843.2 8857.3 8862.0 8865.1 8669.5 8785.9 8789.0 8789.1 8793.0 42450.6 43045.1 43055.4 43176.4 43189.4 3679.7 3799.7 3949.7 4041.7 4321.2 28760.0 29310.3 32516.6 32684.3 33128.7 4219.5 4328.4 4336.7 4372.0 4387.7 239193.0 240462.0 241209.0 241418.0 242494.0 56418.0 56568.0 56881.7 56952.4 57025.4 51466.7 56871.0 58738.4 63918.4 63950.0 16741.8 17223.0 17223.2 17240.5 17243.1 12844.1 12953.5 12959.5 12967.5 12976.7 16590.4 18586.6 19009.6 19103.9 19582.3 7197.0 7320.6 7465.0 7465.8 7526.9 989.5 1023.3 1049.8 1055.8 1099.9 32417.2 32514.7 32652.3 33343.8 33477.3 1116.1 1125.8 1152.0 1155.9 1229.3 17270.2 17745.7 17762.6 17779.6 17808.9 481598.0 484253.0 488812.0 489457.0 489979.0 59158.7 59877.7 60195.1 60334.4 60458.0 1276.8 1346.7 1390.8 1414.4 1436.4 28973.4 30685.4 30706.2 32635.0 33580.8 41896.6 47919.8 49088.3 49170.8 49287.8 440199.0 443722.8 446834.0 447432.0 448819.0 33696.7 39258.4 39583.4 40331.8 43874.8 42686.6 42913.4 43084.4 43666.8 43736.8 36686.1 37072.8 37604.4 37696.8 37793.6 36128.5 37077.0 37174.0 37189.6 37338.8 40657.6 40962.8 40997.2 41474.4 41766.4 34344.5 35610.0 35974.0 36068.0 36157.5 26075.6 26778.9 27208.2 27621.7 28030.2 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | [#2] jquery.html Cycles:180 Average:28354.46 Median:2724.79 stddev:78707.92 (2888.6%) stddev-sans-first:78900.70 06:17:28 INFO - PROCESS | 19052 | Values: 387.4 392.4 394.1 394.6 395.0 14441.8 16970.9 18307.6 19692.5 19946.9 15172.3 17506.6 18296.3 18316.1 19011.6 5640.6 5819.3 5827.7 5827.9 5828.4 4193.8 5748.8 5790.1 6127.9 6471.9 6394.2 6414.1 6426.5 6443.1 6443.6 6146.5 6497.7 6509.4 6521.5 6522.6 5465.2 5727.8 5733.0 5738.8 5763.5 21978.6 22419.4 22522.5 22778.0 22999.9 2415.7 2485.9 2533.9 2588.3 2861.2 8404.4 9085.2 9183.6 9363.7 14184.1 1924.3 1954.2 1965.6 2014.8 2052.1 78079.0 78248.6 79030.0 79089.6 82186.2 10010.9 10323.4 10444.7 10510.9 10667.7 14169.6 14283.0 14325.3 14327.4 14354.4 7854.1 7931.1 7940.6 8119.5 8146.3 6791.5 6933.9 7118.1 7323.7 8017.5 4264.0 4476.2 4496.2 4639.5 4654.6 1784.8 1833.6 1844.8 1860.3 1876.5 997.8 1026.8 1037.5 1039.5 1040.0 18427.8 18443.3 18772.9 19013.1 19055.1 942.7 954.1 1031.2 1034.7 1036.5 10298.8 10535.8 10553.5 10622.9 10686.6 468771.0 469569.3 474300.0 478777.0 493844.0 89093.0 91060.0 91356.5 93363.5 93866.5 1028.2 1073.7 1093.1 1093.3 1094.1 17028.4 17054.2 17148.7 17544.0 17552.6 36642.5 39604.8 42814.6 43424.1 43468.3 54220.5 55589.4 56303.4 56369.4 56572.2 8117.9 8268.7 8385.5 8443.4 8589.7 11339.9 13490.0 13566.3 13692.5 13796.2 11580.2 11631.8 11835.2 11849.0 12193.0 11589.7 11699.7 11789.5 11895.0 11969.2 6482.5 11759.6 12075.5 12179.2 12278.6 8183.3 8454.6 8583.7 8618.9 8720.0 11447.9 12142.5 12142.6 12148.3 12268.9 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | [#3] mootools.html Cycles:180 Average:5066.76 Median:4824.99 stddev:2806.01 (58.2%) stddev-sans-first:2799.99 06:17:28 INFO - PROCESS | 19052 | Values: 1351.0 1449.6 1494.2 1625.6 1748.2 7328.7 7631.8 7632.2 7632.6 7650.0 7385.2 7567.4 7573.6 7576.2 7586.8 1778.5 2009.1 2030.7 2074.7 2144.0 2090.6 2101.2 2102.7 2103.4 2105.5 2038.7 2054.1 2057.4 2059.6 2060.0 1713.1 2087.6 2133.6 2141.9 2142.4 2024.3 2037.4 2038.9 2041.8 2044.1 7599.5 7601.3 7631.0 7632.1 7635.0 4504.7 4709.7 4745.1 4745.4 4795.4 3115.7 3140.6 3212.1 3221.8 3240.4 1029.2 1031.4 1046.1 1092.1 1116.4 10500.1 10501.5 10507.2 10522.9 10524.4 4085.6 4115.4 4181.5 4203.0 4215.6 8936.6 8937.9 8944.4 8947.8 8962.3 4219.8 4814.9 4835.1 4839.7 4843.8 4280.3 4381.4 4382.0 4394.8 4403.3 3457.4 3508.4 3557.1 3577.6 3609.8 1027.7 1143.9 1151.4 1151.4 1168.2 851.7 956.0 958.0 959.8 962.3 5226.5 5269.4 5333.6 5407.1 5480.5 389.6 390.7 392.1 393.9 394.0 3725.4 3770.1 3784.4 3791.3 3856.8 9009.5 9321.0 9333.5 9366.5 9396.2 9057.6 9196.4 9301.5 9326.2 9342.1 7210.0 7261.6 7325.5 7335.9 7410.5 5101.5 5158.8 5255.3 5283.6 5319.8 8570.7 8595.8 8648.7 8676.3 8705.1 8563.0 8764.6 8795.1 8872.8 8996.9 6134.4 6609.3 6762.7 6793.0 6817.8 7366.9 7389.1 7437.7 7452.6 7457.3 6270.2 6437.1 6458.0 6492.5 6519.6 6369.4 6389.1 6514.9 6571.6 6724.5 6090.8 6140.8 6149.6 6159.6 6168.0 4531.6 4681.1 4687.3 4694.5 4723.3 4757.0 4809.0 4812.5 4814.1 4907.3 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | [#4] prototype.html Cycles:180 Average:4736.31 Median:5324.62 stddev:1431.46 (26.9%) stddev-sans-first:1396.63 06:17:28 INFO - PROCESS | 19052 | Values: 323.8 329.5 331.3 332.7 334.2 5148.6 5221.2 5314.8 5323.9 5327.1 5211.7 5212.9 5223.9 5236.8 5267.7 3890.0 3917.8 4097.6 4100.2 4122.2 4085.9 4087.5 4105.5 4113.5 4121.3 3828.2 4065.0 4068.5 4080.2 4081.3 3864.0 3960.4 3984.3 4054.8 4108.9 3538.9 3589.2 3607.7 3615.5 3624.1 5063.2 5068.0 5068.6 5074.5 5104.5 4559.9 4621.6 4638.5 4664.6 4681.6 5413.2 5422.7 5439.5 5454.0 5454.2 3929.5 3936.8 3949.9 3960.3 3964.1 5512.5 5689.8 5693.5 5707.6 5713.7 4011.5 4016.6 4019.6 4024.1 4029.5 4049.2 4065.7 4089.2 4112.0 4129.9 4492.6 4622.2 4646.9 4650.6 4659.8 5444.2 5485.6 5514.0 5525.4 5562.8 1479.7 1482.5 1497.2 1497.6 1500.7 931.6 976.7 1012.2 1015.6 1023.0 5216.0 5345.9 5365.8 5367.2 5367.5 5635.9 5672.5 5683.6 5685.4 5689.0 5022.9 5335.0 5350.9 5363.4 5385.3 3198.1 3227.2 3227.6 3229.7 3249.8 6143.7 6291.9 6314.8 6324.8 6335.8 6153.8 6196.7 6221.4 6235.2 6245.2 6247.4 6250.3 6251.0 6251.6 6286.8 5945.3 6051.5 6063.4 6086.3 6124.1 5990.9 5996.7 5998.3 6025.2 6027.7 6048.0 6242.6 6297.8 6311.7 6344.6 4114.2 4131.8 4156.3 4168.2 4177.0 6072.8 6095.1 6169.1 6181.4 6193.5 5325.4 5545.2 5559.4 5996.7 6001.2 5503.1 5529.6 5543.8 5553.3 5572.0 5207.6 5409.8 5476.3 5485.8 5501.9 5149.4 5517.7 5542.8 5575.9 5596.3 5453.8 5456.3 5461.0 5490.7 5491.3 06:17:28 INFO - PROCESS | 19052 | 06:17:28 INFO - PROCESS | 19052 | [#5] yui.html Cycles:180 Average:15487.53 Median:4706.80 stddev:18335.98 (389.6%) stddev-sans-first:18353.91 06:17:28 INFO - PROCESS | 19052 | Values: 726.1 790.0 862.0 868.0 869.1 15444.1 15608.1 15681.7 15718.4 15792.5 14117.1 14170.9 14183.8 14199.9 14211.8 688.1 805.5 839.7 842.6 844.3 817.8 819.6 827.1 827.8 828.4 725.3 879.4 879.5 880.3 883.7 849.6 870.5 870.5 871.9 873.7 639.8 640.9 641.3 645.8 645.9 13074.7 13126.1 13168.2 13170.6 13203.2 13786.7 14477.0 14717.4 14725.7 14789.4 11072.2 11081.4 11127.5 11183.3 11423.4 3845.2 3934.0 3964.3 4005.2 4084.9 56427.7 57103.7 58202.4 58227.0 58252.7 10640.3 10898.5 10943.5 11072.4 11367.4 18857.9 19089.5 19116.8 19120.5 19121.1 8056.0 8406.3 8742.4 8813.5 8927.3 4728.1 4877.8 4943.5 4949.5 5137.9 3221.3 3287.6 3298.4 3327.4 3328.4 662.2 670.2 692.0 699.9 706.6 671.3 695.6 696.8 697.2 709.1 8521.6 9151.8 9200.4 9270.4 9430.2 691.5 758.1 762.4 770.9 802.1 4175.4 4296.7 4429.7 4581.1 4685.5 55962.0 57802.4 74585.3 75674.2 75764.0 56648.0 56787.4 56825.4 57511.0 58220.7 53478.2 53522.0 53772.2 53788.7 55704.4 9677.5 9710.0 9720.7 9849.6 9858.8 33333.7 34833.1 35422.3 35785.3 36539.8 45072.3 48829.5 49130.0 49475.5 49673.3 11718.5 11993.5 12345.8 12657.6 13143.0 13626.7 13999.9 14012.9 14171.3 14177.8 13375.9 13379.7 13410.5 13539.9 13691.7 12468.0 13177.9 13259.2 13329.5 13383.6 11939.2 12037.5 12109.3 12448.5 12888.6 10363.3 10380.2 10931.0 11074.3 11145.4 11147.9 11241.2 11373.5 11388.9 11407.7 06:17:29 INFO - PROCESS | 19052 | -------- Summary: end -------- 06:17:29 INFO - PROCESS | 19052 | 06:17:29 INFO - TEST-INFO | 19052: exit 0 06:17:29 INFO - TEST-OK | dromaeo_css | took 1113232ms 06:17:29 INFO - TEST-START | kraken 06:17:29 INFO - operating with platform_type : linux_ 06:17:29 INFO - Initialising browser for kraken test... 06:17:29 INFO - TEST-INFO | started process 19239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5HUf82/profile http://localhost:60808/getInfo.html) 06:17:34 INFO - PROCESS | 19239 | __metrics Screen width/height:1600/1200 06:17:34 INFO - PROCESS | 19239 | colorDepth:24 06:17:34 INFO - PROCESS | 19239 | Browser inner width/height: 1024/697 06:17:34 INFO - PROCESS | 19239 | __metrics 06:17:35 ERROR - PROCESS | 19239 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:36 INFO - TEST-INFO | 19239: exit 0 06:17:36 INFO - Browser initialized. 06:17:36 INFO - Running cycle 1/1 for kraken test... 06:17:36 INFO - TEST-INFO | started process 19320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5HUf82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:48 INFO - PROCESS | 19320 | RSS: Main: 154472448 06:17:48 INFO - PROCESS | 19320 | 06:17:50 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60808/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:51 INFO - PROCESS | 19320 | RSS: Main: 209088512 06:17:51 INFO - PROCESS | 19320 | 06:17:54 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60808/tests/kraken/driver.html?testName=audio-dft) 06:17:54 INFO - PROCESS | 19320 | RSS: Main: 195092480 06:17:54 INFO - PROCESS | 19320 | 06:17:57 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60808/tests/kraken/driver.html?testName=audio-fft) 06:17:58 INFO - PROCESS | 19320 | RSS: Main: 264896512 06:17:58 INFO - PROCESS | 19320 | 06:18:00 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60808/tests/kraken/driver.html?testName=audio-oscillator) 06:18:01 INFO - PROCESS | 19320 | RSS: Main: 174022656 06:18:01 INFO - PROCESS | 19320 | 06:18:03 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:03 INFO - PROCESS | 19320 | RSS: Main: 179154944 06:18:03 INFO - PROCESS | 19320 | 06:18:06 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60808/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:07 INFO - PROCESS | 19320 | RSS: Main: 214487040 06:18:07 INFO - PROCESS | 19320 | 06:18:10 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60808/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:11 INFO - PROCESS | 19320 | RSS: Main: 215244800 06:18:11 INFO - PROCESS | 19320 | 06:18:14 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60808/tests/kraken/driver.html?testName=json-parse-financial) 06:18:14 INFO - PROCESS | 19320 | RSS: Main: 215281664 06:18:14 INFO - PROCESS | 19320 | 06:18:16 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:16 INFO - PROCESS | 19320 | RSS: Main: 201863168 06:18:16 INFO - PROCESS | 19320 | 06:18:18 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:19 INFO - PROCESS | 19320 | RSS: Main: 201494528 06:18:19 INFO - PROCESS | 19320 | 06:18:21 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:22 INFO - PROCESS | 19320 | RSS: Main: 215130112 06:18:22 INFO - PROCESS | 19320 | 06:18:24 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:25 INFO - PROCESS | 19320 | RSS: Main: 221614080 06:18:25 INFO - PROCESS | 19320 | 06:18:27 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:28 INFO - PROCESS | 19320 | RSS: Main: 217702400 06:18:28 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | Cycle 1(1): loaded http://localhost:60808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60808/tests/kraken/driver.html?testName=ai-astar) 06:18:30 INFO - PROCESS | 19320 | RSS: Main: 281391104 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | __start_tp_report 06:18:30 INFO - PROCESS | 19320 | _x_x_mozilla_page_load 06:18:30 INFO - PROCESS | 19320 | _x_x_mozilla_page_load_details 06:18:30 INFO - PROCESS | 19320 | |i|pagename|runs| 06:18:30 INFO - PROCESS | 19320 | |0;ai-astar;110;110;107;110;111;111;101;109;109;110 06:18:30 INFO - PROCESS | 19320 | |1;audio-beat-detection;161;123;152;180;129;159;160;129;189;131 06:18:30 INFO - PROCESS | 19320 | |2;audio-dft;160;159;161;160;161;160;160;160;162;160 06:18:30 INFO - PROCESS | 19320 | |3;audio-fft;75;73;99;113;74;73;72;130;120;73 06:18:30 INFO - PROCESS | 19320 | |4;audio-oscillator;93;93;154;93;93;94;144;94;92;149 06:18:30 INFO - PROCESS | 19320 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;117;116 06:18:30 INFO - PROCESS | 19320 | |6;imaging-darkroom;145;145;146;145;145;146;146;145;146;145 06:18:30 INFO - PROCESS | 19320 | |7;imaging-desaturate;95;94;94;94;95;95;95;94;95;95 06:18:30 INFO - PROCESS | 19320 | |8;json-parse-financial;56;58;58;57;59;59;61;73;56;54 06:18:30 INFO - PROCESS | 19320 | |9;json-stringify-tinderbox;61;61;61;61;62;61;61;63;63;61 06:18:30 INFO - PROCESS | 19320 | |10;stanford-crypto-aes;77;77;77;76;78;77;80;79;79;78 06:18:30 INFO - PROCESS | 19320 | |11;stanford-crypto-ccm;127;124;123;123;137;122;123;125;157;137 06:18:30 INFO - PROCESS | 19320 | |12;stanford-crypto-pbkdf2;170;164;163;163;169;165;162;167;163;167 06:18:30 INFO - PROCESS | 19320 | |13;stanford-crypto-sha256-iterative;71;69;68;67;68;67;68;68;67;68 06:18:30 INFO - PROCESS | 19320 | __end_tp_report 06:18:30 INFO - PROCESS | 19320 | __start_cc_report 06:18:30 INFO - PROCESS | 19320 | _x_x_mozilla_cycle_collect,1600 06:18:30 INFO - PROCESS | 19320 | __end_cc_report 06:18:30 INFO - PROCESS | 19320 | __startTimestamp1461935910450__endTimestamp 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | ------- Summary: start ------- 06:18:30 INFO - PROCESS | 19320 | Number of tests: 14 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.97 (2.7%) stddev-sans-first:3.12 06:18:30 INFO - PROCESS | 19320 | Values: 110.0 110.0 107.0 110.0 111.0 111.0 101.0 109.0 109.0 110.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:159.50 stddev:22.81 (14.3%) stddev-sans-first:23.92 06:18:30 INFO - PROCESS | 19320 | Values: 161.0 123.0 152.0 180.0 129.0 159.0 160.0 129.0 189.0 131.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:18:30 INFO - PROCESS | 19320 | Values: 160.0 159.0 161.0 160.0 161.0 160.0 160.0 160.0 162.0 160.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#3] audio-fft Cycles:10 Average:90.20 Median:73.00 stddev:23.05 (31.6%) stddev-sans-first:23.78 06:18:30 INFO - PROCESS | 19320 | Values: 75.0 73.0 99.0 113.0 74.0 73.0 72.0 130.0 120.0 73.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.09 (29.1%) stddev-sans-first:28.03 06:18:30 INFO - PROCESS | 19320 | Values: 93.0 93.0 154.0 93.0 93.0 94.0 144.0 94.0 92.0 149.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:18:30 INFO - PROCESS | 19320 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:18:30 INFO - PROCESS | 19320 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:18:30 INFO - PROCESS | 19320 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.50 stddev:5.26 (9.0%) stddev-sans-first:5.46 06:18:30 INFO - PROCESS | 19320 | Values: 56.0 58.0 58.0 57.0 59.0 59.0 61.0 73.0 56.0 54.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 06:18:30 INFO - PROCESS | 19320 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 61.0 63.0 63.0 61.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:1.23 (1.6%) stddev-sans-first:1.27 06:18:30 INFO - PROCESS | 19320 | Values: 77.0 77.0 77.0 76.0 78.0 77.0 80.0 79.0 79.0 78.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:126.00 stddev:11.09 (8.8%) stddev-sans-first:11.72 06:18:30 INFO - PROCESS | 19320 | Values: 127.0 124.0 123.0 123.0 137.0 122.0 123.0 125.0 157.0 137.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:2.79 (1.7%) stddev-sans-first:2.39 06:18:30 INFO - PROCESS | 19320 | Values: 170.0 164.0 163.0 163.0 169.0 165.0 162.0 167.0 163.0 167.0 06:18:30 INFO - PROCESS | 19320 | 06:18:30 INFO - PROCESS | 19320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:0.67 06:18:30 INFO - PROCESS | 19320 | Values: 71.0 69.0 68.0 67.0 68.0 67.0 68.0 68.0 67.0 68.0 06:18:30 INFO - PROCESS | 19320 | -------- Summary: end -------- 06:18:30 INFO - PROCESS | 19320 | 06:18:31 INFO - TEST-INFO | 19320: exit 0 06:18:31 INFO - TEST-OK | kraken | took 61777ms 06:18:31 INFO - SUITE-END | took 1175s 06:18:31 INFO - Completed test suite (00:19:35) 06:18:31 INFO - javascript benchmark 06:18:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.414151311251, 3134.4984802431613, 3174.936501269976, 3182.204448887778, 3211.036688993302, 5086.084504789136, 5239.476052394768, 5274.683518988863, 5297.496737809912, 5322.0, 5244.68531888086, 5288.497592728685, 5301.946980530193, 5317.042932272189, 5318.30861987942, 4758.738269395182, 4776.928346074812, 4778.0, 4793.616510679155, 4986.252062190664, 4892.730899800509, 4955.380577427822, 4966.453690094087, 4967.329410529568, 4977.925331120036, 4744.169770290203, 4807.543283388072, 4826.879328016793, 4875.219964805632, 4918.114739346916, 4767.165745994437, 4768.427788665348, 4773.737444440554, 4776.0925424169645, 4807.687500312503, 4701.976490117561, 4734.810607575727, 4742.241241401359, 4747.216709242971, 4775.474697783241, 5081.974590127025, 5108.565771909355, 5172.612054095958, 5202.167653175474, 5204.115300398941, 5577.721113944286, 5585.190147428641, 5614.045612245928, 5618.91571626426, 5624.128260119688, 5453.372862120827, 5657.462541058593, 5658.858528536778, 5659.773609055633, 5663.093904975184, 5261.921071183897, 5272.710000949946, 5290.153575427913, 5295.364556253275, 5335.839924802262, 5727.942720572824, 5734.541236701054, 5735.311762588516, 5736.913946290809, 5737.08206686928, 5384.138537833927, 5515.972420137874, 5521.503064724194, 5526.723663816793, 5529.834104976857, 5592.636478628876, 5596.356419011784, 5599.44005599445, 5631.943680563142, 5652.208690783294, 5565.7217139143695, 5568.860778480489, 5569.749361278752, 5571.832845014656, 5577.163425486209, 5389.272448219519, 5596.300462442195, 5599.636023658449, 5633.8309850704545, 5717.914231286534, 4237.173751118564, 4241.597048280409, 4270.978645106755, 4281.293586558245, 4282.850100246539, 3790.2419516096893, 3798.563165235978, 3799.525059367579, 3837.520309961255, 3850.614938506127, 5157.303763991888, 5201.6358854880555, 5244.816431424882, 5269.973650131801, 5283.049051170749, 5651.208830763697, 5665.150227465913, 5665.348484924287, 5667.943320566824, 5702.800401985911, 5326.067938110815, 5338.039152952506, 5342.439043900335, 5348.598855085884, 5387.568994480433, 4726.598239149711, 4800.975995120002, 4848.00615873745, 4854.490278520775, 4864.294677271776, 5718.085106382959, 5727.427257274239, 5727.828165155052, 5733.054046082433, 5755.740991655385, 5540.612157148961, 5542.0301447247375, 5543.057680194457, 5549.861253468534, 5552.361478429952, 5631.746571404378, 5726.713664316851, 5766.596338256281, 5888.617239879394, 5907.350191478848, 5528.640638358494, 5531.03206938776, 5532.778688852401, 5559.110542313372, 5579.916301255404, 5607.43925607436, 5612.298462692163, 5614.747336369955, 5615.831525054255, 5619.157126431068, 5230.764615592384, 5461.15352120422, 5483.4516548344845, 5510.201020851874, 5565.1374037024325, 5436.972815135899, 5441.863953401196, 5444.047291724011, 5444.128939369682, 5476.12382018891, 5353.2505449237915, 5354.2771725818075, 5362.544183744425, 5362.919556206738, 5410.648307860134, 5339.706316152494, 5469.179623056573, 5471.945280547144, 5513.7794488221625, 5550.417206193291, 5308.575313974796, 5318.228856815817, 5323.600729945347, 5325.09473389517, 5373.140297552372], "value": 5173.285610657801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4146877528798, 645.9612423254605, 648.6562122075298, 650.8112647332274, 652.4226059936955, 30751.0, 38273.80863095684, 39553.802230988804, 39938.600613993854, 39996.80001599995, 42230.0, 42896.57103428965, 42902.57097429025, 43000.784996075054, 43022.35466468005, 8432.747017589481, 8653.610587523544, 8660.30717542595, 8663.35024873137, 8679.479231246145, 8527.360447966395, 8678.522681252529, 8680.56597170142, 8686.609102590399, 8881.06748791374, 8831.77920551988, 8922.687705930293, 8927.821443571125, 8928.776780580505, 8933.59798809055, 8773.473591584494, 8843.159899809507, 8857.335699822539, 8862.0, 8865.06916773736, 8669.523176225304, 8785.868211976825, 8789.0, 8789.121087891159, 8792.956035219848, 42450.57549424497, 43045.13909721819, 43055.35416968748, 43176.352354714705, 43189.35215971763, 3679.6688298053305, 3799.715021373408, 3949.743266687656, 4041.717079804415, 4321.222180007598, 28760.0, 29310.267243318875, 32516.56619002555, 32684.346313073842, 33128.6687133128, 4219.472565929259, 4328.350747387885, 4336.674749393808, 4371.9781401093105, 4387.73673579583, 239193.0, 240462.0, 241209.0, 241418.0, 242494.0, 56418.0, 56568.0, 56881.71559142178, 56952.43047569471, 57025.429745702015, 51466.74266628718, 56871.0, 58738.41261587415, 63918.360816392174, 63950.0, 16741.832581674273, 17223.0, 17223.22495487706, 17240.482785516204, 17243.137843107794, 12844.100912936192, 12953.481860725466, 12959.546415875398, 12967.546135885388, 12976.675583110498, 16590.419335323448, 18586.628267434575, 19009.61980760377, 19103.904480477508, 19582.31461898827, 7197.020819274637, 7320.560766354036, 7464.962675186698, 7465.776026719207, 7526.887096693554, 989.5448093876753, 1023.2581378500528, 1049.8267785815256, 1055.8257887448485, 1099.8515200447837, 32417.189570260933, 32514.674853251163, 32652.346953060805, 33343.833280833926, 33477.330453390794, 1116.0959622705634, 1125.7861006408757, 1151.988480115205, 1155.942202889852, 1229.2685851918095, 17270.22283997198, 17745.7338139928, 17762.555936101442, 17779.644407111784, 17808.91095544514, 481598.0, 484253.0, 488812.0, 489457.0, 489979.0, 59158.704206478695, 59877.700611496664, 60195.09707354393, 60334.39665603376, 60458.0, 1276.7510335484492, 1346.7037251804784, 1390.7774756038984, 1414.4003511064366, 1436.4110714606961, 28973.420531589672, 30685.386292273583, 30706.232344191572, 32635.0, 33580.83209583937, 41896.581034189265, 47919.76040119777, 49088.263676044175, 49170.75414623047, 49287.75356123196, 440199.0, 443722.8138592993, 446834.0, 447432.0, 448819.0, 33696.663033370336, 39258.411123833735, 39583.40624890687, 40331.79834100811, 43874.78062609667, 42686.5731342695, 42913.35629965491, 43084.35373469338, 43666.78166609147, 43736.78131609321, 36686.082847929014, 37072.81463592665, 37604.435933461566, 37696.811515942245, 37793.62206377901, 36128.45807312945, 37077.0, 37174.0, 37189.62810371862, 37338.81330593438, 40657.59342406538, 40962.79518602388, 40997.18005639811, 41474.37788433115, 41766.37350439806, 34344.48483272703, 35610.0, 35974.0, 36068.0, 36157.457638134925, 26075.60886586665, 26778.866105669345, 27208.183754487396, 27621.723782762718, 28030.159095227176], "value": 19855.424837389233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.3801916932908, 392.40158757894227, 394.0896529017967, 394.6224000397606, 394.9723519353645, 14441.78337324941, 16970.915145424286, 18307.63384732306, 19692.507687307807, 19946.90026549867, 15172.317245723942, 17506.56233594161, 18296.268149274045, 18316.08419579019, 19011.61976760464, 5640.605157638956, 5819.33077696064, 5827.708614569255, 5827.941720582803, 5828.446297601721, 4193.811278492475, 5748.82753517393, 5790.102534107199, 6127.938720612804, 6471.9029214561815, 6394.200724909387, 6414.10202571638, 6426.518011149159, 6443.0657554654545, 6443.645599492026, 6146.508279337665, 6497.707603157869, 6509.414152726254, 6521.478281737497, 6522.608643481382, 5465.234867118606, 5727.828165155052, 5732.971335143339, 5738.799142030009, 5763.5101016413655, 21978.560428791494, 22419.439514012116, 22522.54954900909, 22778.0, 22999.885000575057, 2415.7101147862195, 2485.9254222373356, 2533.873306334676, 2588.3399733067945, 2861.241770930705, 8404.41169118162, 9085.227755640779, 9183.632654693803, 9363.71908842729, 14184.148951062969, 1924.2687778644165, 1954.171557047854, 1965.626530959113, 2014.8488863335308, 2052.107333310015, 78079.0, 78248.60875695584, 79029.99999999942, 79089.60455197745, 82186.17813821846, 10010.899891001143, 10323.432211228304, 10444.738881528023, 10510.947445262726, 10667.679969600924, 14169.645758855904, 14283.0, 14325.283735813377, 14327.35526901292, 14354.354054067591, 7854.057513098464, 7931.087924888711, 7940.563269020259, 8119.512829230265, 8146.30756385702, 6791.4906382021545, 6933.93066069343, 7118.110236220473, 7323.670434830446, 8017.518948863087, 4263.978680106579, 4476.194285028661, 4496.213162696515, 4639.468975238164, 4654.557817007379, 1784.8036715961493, 1833.6149408624337, 1844.7970723220435, 1860.3302810988034, 1876.521487020801, 997.7854761226371, 1026.7741096958657, 1037.4812593703148, 1039.4906495816995, 1040.0379648824808, 18427.81572184288, 18443.262269509338, 18772.906135469235, 19013.144408501375, 19055.142518586697, 942.6700654770913, 954.0507195340681, 1031.185363562792, 1034.7102811212872, 1036.4817591204398, 10298.794024119476, 10535.84196237057, 10553.472326383804, 10622.893771062345, 10686.572537098584, 468771.0, 469569.3014889591, 474300.0, 478777.0, 493844.0, 89093.0, 91060.0, 91356.54321728482, 93363.53318233366, 93866.53066734623, 1028.1620479309338, 1073.7476692977143, 1093.059968427152, 1093.2511229807449, 1094.070040465598, 17028.404005859735, 17054.2325595351, 17148.657026859644, 17544.0, 17552.56118597045, 36642.45036324511, 39604.80197598993, 42814.57185428106, 43424.13151737011, 43468.347974781034, 54220.45779542154, 55589.44410556005, 56303.43696563146, 56369.43630563642, 56572.151417727946, 8117.87461827189, 8268.669253229804, 8385.496870187808, 8443.36674749384, 8589.65641374338, 11339.943300283447, 13490.0, 13566.321683915961, 13692.520761773689, 13796.241206733324, 11580.247283926517, 11631.76736465283, 11835.171537992257, 11849.0, 12193.024558035158, 11589.710257243636, 11699.707507312045, 11789.469473873867, 11895.048396128463, 11969.16215864881, 6482.513811464065, 11759.647210583697, 12075.51697932073, 12179.208351457128, 12278.570250041206, 8183.3453323732765, 8454.57727113654, 8583.699570515002, 8618.913810861812, 8719.956400218212, 11447.942760286478, 12142.453589588313, 12142.575009874612, 12148.331841748788, 12268.938655306667], "value": 9151.71219899855, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.9662258443532, 1449.557884845122, 1494.2379386512878, 1625.5529729324435, 1748.1521462090875, 7328.743493977705, 7631.847363052742, 7632.236776322365, 7632.618369081538, 7649.961750191242, 7385.187629360766, 7567.394608431312, 7573.5834529100875, 7576.242375762421, 7586.810329741759, 1778.5197996540926, 2009.1059478532059, 2030.6649402848511, 2074.6991686205492, 2144.024468866662, 2090.592334494774, 2101.2120454829437, 2102.6951092091635, 2103.368989303203, 2105.463106907744, 2038.7329379366663, 2054.12699602669, 2057.403353027628, 2059.618970490464, 2059.9588008239825, 1713.143428285857, 2087.551176497045, 2133.615949129156, 2141.9036143373587, 2142.4001279641725, 2024.2813801100692, 2037.3989673046487, 2038.8878611676353, 2041.765197002349, 2044.090379780998, 7599.544027358376, 7601.31588157063, 7631.046119235096, 7632.084149901992, 7634.961825190839, 4504.684672072956, 4709.670323077386, 4745.074710431467, 4745.383100196952, 4795.448523419816, 3115.7195852373397, 3140.5917230759856, 3212.084555901557, 3221.8389080546112, 3240.4491236489853, 1029.23836361093, 1031.3502493429166, 1046.0585473074218, 1092.071739021833, 1116.4306203836102, 10500.054995050406, 10501.527431265611, 10507.211959103022, 10522.894771052268, 10524.368537887674, 4085.571015043437, 4115.444415003996, 4181.51912530063, 4203.033302340479, 4215.620594146541, 8936.553172341357, 8937.910620893837, 8944.37389382737, 8947.776305592412, 8962.283017358595, 4219.78901054946, 4814.879628009257, 4835.105505481497, 4839.733814640158, 4843.8304659337455, 4280.293751531025, 4381.38660587518, 4381.978090109529, 4394.780260987001, 4403.295472724349, 3457.377672019061, 3508.3509550733197, 3557.1285035166034, 3577.5706915170344, 3609.8375573099274, 1027.7276521721749, 1143.9027682646902, 1151.407025381929, 1151.4357964597286, 1168.182272409317, 851.7359618518279, 955.9713208603753, 957.9632564769697, 959.788846453779, 962.2686758063921, 5226.451222621646, 5269.367675878919, 5333.57331413486, 5407.107827208467, 5480.451954804487, 389.555906266856, 390.7186825485646, 392.0825268870799, 393.87789785166115, 393.9960600394017, 3725.4225595032813, 3770.1140232045445, 3784.413415920537, 3791.260704162717, 3856.8071596420627, 9009.549522523848, 9321.0, 9333.533323333806, 9366.484843333546, 9396.248300135972, 9057.637694492278, 9196.402233854778, 9301.53492325381, 9326.160645541933, 9342.112499312554, 7209.999999999895, 7261.636918154071, 7325.450591205681, 7335.926640733631, 7410.5183163094225, 5101.51535604117, 5158.845234642967, 5255.290535777621, 5283.5773138149625, 5319.760610772602, 8570.700025499078, 8595.785105372415, 8648.697295594624, 8676.305895528469, 8705.085965973482, 8562.987697891116, 8764.649414023623, 8795.120487951153, 8872.822543549222, 8996.865047024168, 6134.447899689049, 6609.339066093352, 6762.7294908205085, 6793.0, 6817.761378351734, 7366.852662946818, 7389.076365454318, 7437.70249190048, 7452.552846829208, 7457.291557302047, 6270.184875966095, 6437.0666253392055, 6458.0, 6492.5455218134275, 6519.576227545194, 6369.363063693593, 6389.073584330339, 6514.869702606016, 6571.638559879252, 6724.495662825406, 6090.786822461369, 6140.846478838065, 6149.569530132848, 6159.630422174684, 6168.0, 4531.614812740822, 4681.087187998308, 4687.250039993584, 4694.483606803181, 4723.267893476516, 4756.9524304756505, 4809.0, 4812.51874812516, 4814.061258054786, 4907.263910413467], "value": 4036.0211597469547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.80895271789655, 329.5172572181753, 331.3059141099397, 332.7221769822198, 334.1579220364681, 5148.562372198363, 5221.216817477381, 5314.787408503665, 5323.8819847832, 5327.147656374981, 5211.687298762077, 5212.8696782580455, 5223.947760522394, 5236.795537026486, 5267.710275934822, 3890.0160917931917, 3917.784521851297, 4097.610726980932, 4100.200460910124, 4122.196171746511, 4085.8978525536804, 4087.509498860141, 4105.548389677133, 4113.465249517573, 4121.319982202948, 3828.2152158807517, 4065.0, 4068.4914385701786, 4080.1635664688815, 4081.3061779497557, 3863.961360386388, 3960.4158336665278, 3984.322665146932, 4054.837806487737, 4108.876733697994, 3538.929221415583, 3589.228315912065, 3607.701227558077, 3615.4576813477925, 3624.1221892574954, 5063.215201643751, 5068.0, 5068.594512439033, 5074.5432911037815, 5104.4640312767, 4559.908801823978, 4621.607163391116, 4638.466576343696, 4664.55686709762, 4681.57865792077, 5413.186582494869, 5422.728863556846, 5439.5376393006645, 5453.972730136364, 5454.181872719084, 3929.5481019682816, 3936.76379417233, 3949.8617548385955, 3960.3465428204313, 3964.0684439156776, 5512.531434828044, 5689.800856969986, 5693.487586117228, 5707.571932105067, 5713.714514194314, 4011.538673052578, 4016.6142680775088, 4019.598040195957, 4024.1348110155873, 4029.4761680981283, 4049.1699201663587, 4065.654419374327, 4089.223047621002, 4112.0, 4129.855455059059, 4492.573205545468, 4622.168009758208, 4646.884747660605, 4650.627949764011, 4659.8136074557315, 5444.237806707064, 5485.561155107582, 5514.0, 5525.4474552545225, 5562.805301814417, 1479.7484427647325, 1482.4663121276333, 1497.1840347010905, 1497.5657059452853, 1500.7223663622265, 931.6320053578798, 976.7460460280237, 1012.1953047327393, 1015.5836107196014, 1022.9795404091876, 5216.008958297912, 5345.930813837248, 5365.839024829262, 5367.2485851980755, 5367.5169234769055, 5635.915461268084, 5672.4894759471845, 5683.602147849693, 5685.403032681592, 5689.032864412977, 5022.949770502321, 5335.0, 5350.869741201441, 5363.410024897258, 5385.272988146628, 3198.104530731399, 3227.2415982244156, 3227.580414546094, 3229.6608856070243, 3249.788763730397, 6143.723532441051, 6291.905621415683, 6314.8001879642725, 6324.778632747832, 6335.809925702144, 6153.815385538441, 6196.721147548281, 6221.408966148299, 6235.220597425322, 6245.156903817927, 6247.406496382836, 6250.343713909974, 6251.0, 6251.624902505864, 6286.779962701375, 5945.34601193877, 6051.487128217946, 6063.423974722395, 6086.322018311928, 6124.142620033288, 5990.850228744316, 5996.70016499182, 5998.280206375263, 6025.246844144482, 6027.668478233739, 6047.969760151171, 6242.563020588515, 6297.779577714758, 6311.715972781144, 6344.619322840645, 4114.177164567039, 4131.772752498521, 4156.25187466259, 4168.249715051199, 4177.0, 6072.787452439144, 6095.146679464967, 6169.105479705508, 6181.381861813783, 6193.535484838565, 5325.360956685223, 5545.223668686306, 5559.388467268678, 5996.700164991646, 6001.159837622649, 5503.11950087984, 5529.612927095065, 5543.750531226024, 5553.250311207935, 5571.9721401392735, 5207.609429292743, 5409.810656626999, 5476.2607048049595, 5485.780568777363, 5501.917471237854, 5149.382074151126, 5517.69652669107, 5542.7782888685615, 5575.8884822304135, 5596.328440586993, 5453.800573558258, 5456.263404440509, 5461.0, 5490.6980116094, 5491.270249871438], "value": 4287.523346162255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.1358982810458, 789.9921000789992, 861.9612117454714, 867.9652813887445, 869.1221865915423, 15444.073355598672, 15608.141552214624, 15681.686366272696, 15718.449854255088, 15792.526224213278, 14117.082389644691, 14170.929145354285, 14183.787243191335, 14199.858001419983, 14211.78682319766, 688.1432616392585, 805.5408417202198, 839.7312859884839, 842.6208206307156, 844.3287586368851, 817.7587611654546, 819.5697258939075, 827.0612854410227, 827.8137419080689, 828.3662997806682, 725.2928394815066, 879.428371558489, 879.4898958604026, 880.2957633892892, 883.730462209026, 849.587949844325, 870.5212133326645, 870.5299138465222, 871.895372555291, 873.7466134820894, 639.833643252753, 640.8910485217477, 641.2593454559944, 645.8482256669679, 645.9483241340681, 13074.673133171747, 13126.081174317802, 13168.209907405586, 13170.60488185356, 13203.207807531482, 13786.724265514735, 14477.0, 14717.411303547846, 14725.705485890223, 14789.40842366304, 11072.169587280987, 11081.390523521202, 11127.499262533205, 11183.32900026001, 11423.371714555697, 3845.2309538092495, 3933.960660393388, 3964.266610677034, 4005.218982298453, 4084.9387259191135, 56427.71786141043, 57103.71448142774, 58202.41797582012, 58227.0, 58252.70873645604, 10640.255182137176, 10898.455077246106, 10943.4528273586, 11072.39101849406, 11367.431628418546, 18857.90571047136, 19089.522761931064, 19116.8088319115, 19120.52198695016, 19121.13954872034, 8055.959720201361, 8406.327493800482, 8742.38803283764, 8813.471191728517, 8927.33045021626, 4728.101660684459, 4877.804887804519, 4943.456219815817, 4949.529794669501, 5137.922931156036, 3221.275213077039, 3287.6383597804224, 3298.356820419995, 3327.434336162858, 3328.417526932777, 662.2251965200727, 670.1723371636026, 691.9584824910521, 699.9405050570657, 706.5584009993754, 671.318611609217, 695.5652717051843, 696.7770313499632, 697.2225968045593, 709.0817391478048, 8521.616527256288, 9151.77120571991, 9200.40197387181, 9270.397424167408, 9430.245580353556, 691.5263044814318, 758.1054355860027, 762.3748526208567, 770.9190534993745, 802.1417083720363, 4175.394567787715, 4296.677749168763, 4429.667774916894, 4581.129585378767, 4685.508021657745, 55962.0, 57802.421975779704, 74585.25414745892, 75674.24325756672, 75764.0, 56648.0, 56787.43212567904, 56825.43174568201, 57511.0, 58220.708896455246, 53478.19782703263, 53522.0, 53772.19341709877, 53788.73105634525, 55704.44295557074, 9677.467739274125, 9710.028997100233, 9720.708378748648, 9849.556769945226, 9858.753531161778, 33333.66666333403, 34833.08418037032, 35422.291554169286, 35785.284294314486, 36539.817300913324, 45072.323915141955, 48829.51170488392, 49130.0, 49475.50524494709, 49673.25490117579, 11718.472668729757, 11993.520259189883, 12345.814812777637, 12657.620271391874, 13143.0, 13626.659333516742, 13999.930000350341, 14012.929935350257, 14171.291435427982, 14177.787333190217, 13375.933120334335, 13379.665508362368, 13410.530631427853, 13539.932300338436, 13691.726165476435, 12468.0, 13177.934110329386, 13259.204447733167, 13329.533466328632, 13383.598492045254, 11939.164258501822, 12037.518499260283, 12109.333986630467, 12448.502059917502, 12888.613341599766, 10363.32638378503, 10380.221483388625, 10931.0, 11074.335539867634, 11145.36047733262, 11147.944260278648, 11241.156913231704, 11373.545058197911, 11388.94305528467, 11407.657770266906], "value": 6937.6070382638045, "unit": "score"}], "name": "dromaeo_css", "value": 6951.757135313457, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 107.0, 110.0, 111.0, 111.0, 101.0, 109.0, 109.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 152.0, 180.0, 129.0, 159.0, 160.0, 129.0, 189.0, 131.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 99.0, 113.0, 74.0, 73.0, 72.0, 130.0, 120.0, 73.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 93.0, 93.0, 94.0, 144.0, 94.0, 92.0, 149.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 57.0, 59.0, 59.0, 61.0, 73.0, 56.0, 54.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 63.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 76.0, 78.0, 77.0, 80.0, 79.0, 79.0, 78.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 123.0, 123.0, 137.0, 122.0, 123.0, 125.0, 157.0, 137.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 164.0, 163.0, 163.0, 169.0, 165.0, 162.0, 167.0, 163.0, 167.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1538.6999999999998, "alertThreshold": 2.0}]} 06:18:31 INFO - Return code: 0 06:18:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:18:31 ERROR - # TBPL SUCCESS # 06:18:31 INFO - Running post-action listener: _resource_record_post_action 06:18:31 INFO - Running post-run listener: _resource_record_post_run 06:18:32 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 448077824; Read time: 16; Write time: 805964 06:18:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112607232; Read time: 0; Write time: 301064 06:18:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286138368; Read time: 16; Write time: 352044 06:18:32 INFO - Running post-run listener: _upload_blobber_files 06:18:32 INFO - Blob upload gear active. 06:18:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:32 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 06:18:32 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:32 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:33 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:34 INFO - (blobuploader) - INFO - Done attempting. 06:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:35 INFO - (blobuploader) - INFO - Done attempting. 06:18:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:35 INFO - Return code: 0 06:18:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43758b87dab19da763af192487a7309b44fb43459b6386f45d2e1832b6d5b85f39a8c9fb6086dac55ff9da719f49d4a2e3f625ee165401bce266ba5e88273a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf940eab208d0fa4f039be8c9403ed6ed92f138582905a0eccdf64466ac73391516bfa1b9a9f824c33a81ccb112ff634cb3a298bdb1c790893123f908b38507"} 06:18:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:35 INFO - Contents: 06:18:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43758b87dab19da763af192487a7309b44fb43459b6386f45d2e1832b6d5b85f39a8c9fb6086dac55ff9da719f49d4a2e3f625ee165401bce266ba5e88273a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf940eab208d0fa4f039be8c9403ed6ed92f138582905a0eccdf64466ac73391516bfa1b9a9f824c33a81ccb112ff634cb3a298bdb1c790893123f908b38507"} 06:18:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:35 INFO - Copying logs to upload dir... 06:18:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.255059 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-29 06:18:35.065378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:35.069120) ========= 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=745a4373a2a16df560f216e000000264-1461934080.772365-746088716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43758b87dab19da763af192487a7309b44fb43459b6386f45d2e1832b6d5b85f39a8c9fb6086dac55ff9da719f49d4a2e3f625ee165401bce266ba5e88273a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf940eab208d0fa4f039be8c9403ed6ed92f138582905a0eccdf64466ac73391516bfa1b9a9f824c33a81ccb112ff634cb3a298bdb1c790893123f908b38507"} build_url:https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43758b87dab19da763af192487a7309b44fb43459b6386f45d2e1832b6d5b85f39a8c9fb6086dac55ff9da719f49d4a2e3f625ee165401bce266ba5e88273a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf940eab208d0fa4f039be8c9403ed6ed92f138582905a0eccdf64466ac73391516bfa1b9a9f824c33a81ccb112ff634cb3a298bdb1c790893123f908b38507"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:35.093700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:35.094008) ========= 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=745a4373a2a16df560f216e000000264-1461934080.772365-746088716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:35.178197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 06:18:35.178494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 06:18:35.178785) ========= ========= Total master_lag: 0.17 =========