builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1466523621.31 results: success (0) buildid: 20160621055904 builduid: aaa87a9ab85f4e26a03835bfe826c945 revision: 5f7dcce004111d3e2f78cdae83bafb8551937018 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.307118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.307883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.308249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.323192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.323536) ========= 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=df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 08:40:21-- 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% 23.4M=0s 2016-06-21 08:40:21 (23.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.528064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.528433) ========= 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=df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015420 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.578790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:21.579206) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5f7dcce004111d3e2f78cdae83bafb8551937018 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5f7dcce004111d3e2f78cdae83bafb8551937018 --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=df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 08:40:22,020 truncating revision to first 12 chars 2016-06-21 08:40:22,021 Setting DEBUG logging. 2016-06-21 08:40:22,021 attempt 1/10 2016-06-21 08:40:22,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5f7dcce00411?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 08:40:22,313 unpacking tar archive at: mozilla-beta-5f7dcce00411/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:22.211223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:22.211616) ========= script_repo_revision: 5f7dcce004111d3e2f78cdae83bafb8551937018 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:22.212053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:22.212337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:22.222729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-21 08:40:22.223077) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:22 INFO - MultiFileLogger online at 20160621 08:40:22 in /builds/slave/test 08:40:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:40:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:22 INFO - {'append_to_log': False, 08:40:22 INFO - 'base_work_dir': '/builds/slave/test', 08:40:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:40:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:22 INFO - 'branch': 'Mozilla-Beta', 08:40:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:22 INFO - 'config_files': ('talos/linux_config.py',), 08:40:22 INFO - 'default_actions': ('clobber', 08:40:22 INFO - 'read-buildbot-config', 08:40:22 INFO - 'download-and-extract', 08:40:22 INFO - 'populate-webroot', 08:40:22 INFO - 'create-virtualenv', 08:40:22 INFO - 'install', 08:40:22 INFO - 'run-tests'), 08:40:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:22 INFO - 'download_minidump_stackwalk': True, 08:40:22 INFO - 'download_symbols': 'ondemand', 08:40:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:22 INFO - 'installer_path': 'installer.exe', 08:40:22 INFO - 'log_level': 'info', 08:40:22 INFO - 'log_name': 'talos', 08:40:22 INFO - 'log_to_console': True, 08:40:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:22 INFO - 'opt_config_files': (), 08:40:22 INFO - 'pip_index': False, 08:40:22 INFO - 'sps_profile': False, 08:40:22 INFO - 'sps_profile_interval': 0, 08:40:22 INFO - 'suite': 'dromaeojs', 08:40:22 INFO - 'system_bits': '32', 08:40:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:22 INFO - 'title': 'talos-linux64-ix-021', 08:40:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:22 INFO - 'use_talos_json': True, 08:40:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:22 INFO - 'work_dir': 'build'} 08:40:22 INFO - ##### 08:40:22 INFO - ##### Running clobber step. 08:40:22 INFO - ##### 08:40:22 INFO - Running pre-action listener: _resource_record_pre_action 08:40:22 INFO - Running main action method: clobber 08:40:22 INFO - rmtree: /builds/slave/test/build 08:40:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:23 INFO - Running post-action listener: _resource_record_post_action 08:40:23 INFO - ##### 08:40:23 INFO - ##### Running read-buildbot-config step. 08:40:23 INFO - ##### 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: read_buildbot_config 08:40:23 INFO - Using buildbot properties: 08:40:23 INFO - { 08:40:23 INFO - "project": "", 08:40:23 INFO - "product": "firefox", 08:40:23 INFO - "script_repo_revision": "production", 08:40:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:40:23 INFO - "repository": "", 08:40:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:40:23 INFO - "buildid": "20160621055904", 08:40:23 INFO - "pgo_build": "True", 08:40:23 INFO - "basedir": "/builds/slave/test", 08:40:23 INFO - "buildnumber": 53, 08:40:23 INFO - "slavename": "talos-linux64-ix-021", 08:40:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:40:23 INFO - "platform": "ubuntu64_hw", 08:40:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:40:23 INFO - "branch": "mozilla-beta", 08:40:23 INFO - "repo_path": "releases/mozilla-beta", 08:40:23 INFO - "revision": "5f7dcce004111d3e2f78cdae83bafb8551937018", 08:40:23 INFO - "stage_platform": "linux64-pgo", 08:40:23 INFO - "builduid": "aaa87a9ab85f4e26a03835bfe826c945", 08:40:23 INFO - "slavebuilddir": "test" 08:40:23 INFO - } 08:40:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:40:23 INFO - Running post-action listener: _resource_record_post_action 08:40:23 INFO - ##### 08:40:23 INFO - ##### Running download-and-extract step. 08:40:23 INFO - ##### 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: download_and_extract 08:40:23 INFO - mkdir: /builds/slave/test/build/tests 08:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:23 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:40:25 INFO - Downloaded 1327 bytes. 08:40:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:25 INFO - Using the following test package requirements: 08:40:25 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:40:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:25 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:40:25 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'jsshell-linux-x86_64.zip'], 08:40:25 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:25 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:40:25 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:40:25 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:40:25 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:25 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:25 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:25 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:26 INFO - Downloaded 24186693 bytes. 08:40:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:28 INFO - Return code: 0 08:40:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:28 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:29 INFO - Downloaded 24186693 bytes. 08:40:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:31 INFO - Return code: 0 08:40: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')]} 08:40:31 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:40:33 INFO - Downloaded 10840145 bytes. 08:40:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:40:33 INFO - Return code: 0 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:40:36 INFO - Downloaded 56008338 bytes. 08:40:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:36 INFO - mkdir: /builds/slave/test/properties 08:40:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:36 INFO - Contents: 08:40:36 INFO - build_url:https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:37 INFO - Running post-action listener: _resource_record_post_action 08:40:37 INFO - Running post-action listener: set_extra_try_arguments 08:40:37 INFO - ##### 08:40:37 INFO - ##### Running populate-webroot step. 08:40:37 INFO - ##### 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: populate_webroot 08:40:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:37 INFO - '--tppagecycles', 08:40:37 INFO - '7'], 08:40:37 INFO - 'tests': ['tsvgm']}}, 08:40:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['damp', 'tps']}, 08:40:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'tests': ['damp', 'tps']}, 08:40:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['dromaeo_dom']}, 08:40:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['tsvgx', 08:40:37 INFO - 'tsvgr_opacity', 08:40:37 INFO - 'tart', 08:40:37 INFO - 'tscrollx', 08:40:37 INFO - 'cart']}, 08:40:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:37 INFO - 'tsvgr_opacity', 08:40:37 INFO - 'tart', 08:40:37 INFO - 'tscrollx', 08:40:37 INFO - 'cart']}, 08:40:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-e10s'], 08:40:37 INFO - 'tests': ['tp5o']}, 08:40:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'tests': ['tp5o']}, 08:40:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-e10s', 08:40:37 INFO - '--xperf_path', 08:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:37 INFO - 'tests': ['tp5n']}, 08:40:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:37 INFO - 'talos_options': ['--xperf_path', 08:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:37 INFO - 'tests': ['tp5n']}}, 08:40:37 INFO - 'talos.zip': {'path': '', 08:40:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:37 INFO - Running post-action listener: _resource_record_post_action 08:40:37 INFO - ##### 08:40:37 INFO - ##### Running create-virtualenv step. 08:40:37 INFO - ##### 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: create_virtualenv 08:40:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:37 INFO - Using real prefix '/usr' 08:40:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:40 INFO - Installing pip.................done. 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:40 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 08:40:40 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 08:40:40 INFO - Using env: {'DISPLAY': ':0', 08:40:40 INFO - 'HOME': '/home/cltbld', 08:40:40 INFO - 'LANG': 'en_US.UTF-8', 08:40:40 INFO - 'LANGUAGE': 'en_US:en', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MAIL': '/var/mail/cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SHLVL': '1', 08:40:40 INFO - 'TERM': 'linux', 08:40:40 INFO - 'TMOUT': '86400', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - '_': '/tools/buildbot/bin/python'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:40 INFO - Cleaning up... 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:40 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 08:40:40 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 08:40:40 INFO - Using env: {'DISPLAY': ':0', 08:40:40 INFO - 'HOME': '/home/cltbld', 08:40:40 INFO - 'LANG': 'en_US.UTF-8', 08:40:40 INFO - 'LANGUAGE': 'en_US:en', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MAIL': '/var/mail/cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SHLVL': '1', 08:40:40 INFO - 'TERM': 'linux', 08:40:40 INFO - 'TMOUT': '86400', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - '_': '/tools/buildbot/bin/python'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Downloading/unpacking psutil>=0.7.1 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:42 INFO - Installing collected packages: psutil 08:40:42 INFO - Running setup.py install for psutil 08:40:42 INFO - building 'psutil._psutil_linux' extension 08:40:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:40:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:40:43 INFO - building 'psutil._psutil_posix' extension 08:40:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:40:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:40:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:43 INFO - Successfully installed psutil 08:40:43 INFO - Cleaning up... 08:40:43 INFO - Return code: 0 08:40:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:43 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 08:40:43 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 08:40:43 INFO - Using env: {'DISPLAY': ':0', 08:40:43 INFO - 'HOME': '/home/cltbld', 08:40:43 INFO - 'LANG': 'en_US.UTF-8', 08:40:43 INFO - 'LANGUAGE': 'en_US:en', 08:40:43 INFO - 'LOGNAME': 'cltbld', 08:40:43 INFO - 'MAIL': '/var/mail/cltbld', 08:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:43 INFO - 'MOZ_NO_REMOTE': '1', 08:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:43 INFO - 'NO_EM_RESTART': '1', 08:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:43 INFO - 'PWD': '/builds/slave/test', 08:40:43 INFO - 'SHELL': '/bin/bash', 08:40:43 INFO - 'SHLVL': '1', 08:40:43 INFO - 'TERM': 'linux', 08:40:43 INFO - 'TMOUT': '86400', 08:40:43 INFO - 'USER': 'cltbld', 08:40:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:43 INFO - '_': '/tools/buildbot/bin/python'} 08:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:40:45 INFO - Installing collected packages: mozsystemmonitor 08:40:45 INFO - Running setup.py install for mozsystemmonitor 08:40:45 INFO - Successfully installed mozsystemmonitor 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:45 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 08:40:45 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 08:40:45 INFO - Using env: {'DISPLAY': ':0', 08:40:45 INFO - 'HOME': '/home/cltbld', 08:40:45 INFO - 'LANG': 'en_US.UTF-8', 08:40:45 INFO - 'LANGUAGE': 'en_US:en', 08:40:45 INFO - 'LOGNAME': 'cltbld', 08:40:45 INFO - 'MAIL': '/var/mail/cltbld', 08:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:45 INFO - 'MOZ_NO_REMOTE': '1', 08:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:45 INFO - 'NO_EM_RESTART': '1', 08:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:45 INFO - 'PWD': '/builds/slave/test', 08:40:45 INFO - 'SHELL': '/bin/bash', 08:40:45 INFO - 'SHLVL': '1', 08:40:45 INFO - 'TERM': 'linux', 08:40:45 INFO - 'TMOUT': '86400', 08:40:45 INFO - 'USER': 'cltbld', 08:40:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:45 INFO - '_': '/tools/buildbot/bin/python'} 08:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:47 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:48 INFO - Downloading docopt-0.6.1.tar.gz 08:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:48 INFO - Running setup.py install for blobuploader 08:40:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:48 INFO - Running setup.py install for requests 08:40:48 INFO - Running setup.py install for docopt 08:40:48 INFO - Successfully installed blobuploader requests docopt 08:40:48 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:49 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 08:40:49 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 08:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:49 INFO - Running setup.py (path:/tmp/pip-mcvR3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:49 INFO - Running setup.py (path:/tmp/pip-K769U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:49 INFO - Running setup.py (path:/tmp/pip-CEH1sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:49 INFO - Running setup.py (path:/tmp/pip-tIM_ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:49 INFO - Running setup.py (path:/tmp/pip-kGILHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:49 INFO - Running setup.py (path:/tmp/pip-DZWZbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:49 INFO - Running setup.py (path:/tmp/pip-eQZgMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:49 INFO - Running setup.py (path:/tmp/pip-tR4i2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:49 INFO - Running setup.py (path:/tmp/pip-5Yx43Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:49 INFO - Running setup.py (path:/tmp/pip-U3CMez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:49 INFO - Running setup.py (path:/tmp/pip-LcN6Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:50 INFO - Running setup.py (path:/tmp/pip-GKuW0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:50 INFO - Running setup.py (path:/tmp/pip-V27Eak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:50 INFO - Running setup.py (path:/tmp/pip-HbWMWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:50 INFO - Running setup.py (path:/tmp/pip-Qm8Vyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:50 INFO - Running setup.py (path:/tmp/pip-xzWtqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:50 INFO - Running setup.py (path:/tmp/pip-dq1MFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:50 INFO - Running setup.py install for manifestparser 08:40:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Running setup.py install for mozcrash 08:40:50 INFO - Running setup.py install for mozdebug 08:40:50 INFO - Running setup.py install for mozdevice 08:40:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Running setup.py install for mozfile 08:40:51 INFO - Running setup.py install for mozhttpd 08:40:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozinfo 08:40:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozInstall 08:40:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozleak 08:40:51 INFO - Running setup.py install for mozlog 08:40:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for moznetwork 08:40:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozprocess 08:40:51 INFO - Running setup.py install for mozprofile 08:40:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozrunner 08:40:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozscreenshot 08:40:52 INFO - Running setup.py install for moztest 08:40:52 INFO - Running setup.py install for mozversion 08:40:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:52 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 08:40:52 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 08:40:52 INFO - Using env: {'DISPLAY': ':0', 08:40:52 INFO - 'HOME': '/home/cltbld', 08:40:52 INFO - 'LANG': 'en_US.UTF-8', 08:40:52 INFO - 'LANGUAGE': 'en_US:en', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MAIL': '/var/mail/cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SHLVL': '1', 08:40:52 INFO - 'TERM': 'linux', 08:40:52 INFO - 'TMOUT': '86400', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - '_': '/tools/buildbot/bin/python'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:52 INFO - Running setup.py (path:/tmp/pip-lEvYSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:52 INFO - Running setup.py (path:/tmp/pip-5ZzbHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:52 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)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:52 INFO - Running setup.py (path:/tmp/pip-ABfFsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:52 INFO - Running setup.py (path:/tmp/pip-mUdAuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:52 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)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:52 INFO - Running setup.py (path:/tmp/pip-kclKJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:52 INFO - Running setup.py (path:/tmp/pip-ilnTye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:52 INFO - Running setup.py (path:/tmp/pip-Zt8EkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:53 INFO - Running setup.py (path:/tmp/pip-HCkz5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:53 INFO - Running setup.py (path:/tmp/pip-RcJ5wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:53 INFO - Running setup.py (path:/tmp/pip-feLF4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:53 INFO - Running setup.py (path:/tmp/pip-DPney7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:53 INFO - Running setup.py (path:/tmp/pip-6EaS6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:53 INFO - Running setup.py (path:/tmp/pip-zB6nx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:53 INFO - Running setup.py (path:/tmp/pip-a6OgIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:53 INFO - Running setup.py (path:/tmp/pip-1ed2dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:53 INFO - Running setup.py (path:/tmp/pip-ANvAWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:53 INFO - Running setup.py (path:/tmp/pip-bdU7w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:40:53 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)) 08:40:53 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)) 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:40:53 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)) 08:40:53 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)) 08:40:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - Downloading blessings-1.6.tar.gz 08:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:55 INFO - Installing collected packages: blessings 08:40:55 INFO - Running setup.py install for blessings 08:40:55 INFO - Successfully installed blessings 08:40:55 INFO - Cleaning up... 08:40:55 INFO - Return code: 0 08:40:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:56 INFO - Reading from file tmpfile_stdout 08:40:56 INFO - Current package versions: 08:40:56 INFO - argparse == 1.2.1 08:40:56 INFO - blessings == 1.6 08:40:56 INFO - blobuploader == 1.2.4 08:40:56 INFO - docopt == 0.6.1 08:40:56 INFO - manifestparser == 1.1 08:40:56 INFO - mozInstall == 1.12 08:40:56 INFO - mozcrash == 0.17 08:40:56 INFO - mozdebug == 0.1 08:40:56 INFO - mozdevice == 0.48 08:40:56 INFO - mozfile == 1.2 08:40:56 INFO - mozhttpd == 0.7 08:40:56 INFO - mozinfo == 0.9 08:40:56 INFO - mozleak == 0.1 08:40:56 INFO - mozlog == 3.1 08:40:56 INFO - moznetwork == 0.27 08:40:56 INFO - mozprocess == 0.22 08:40:56 INFO - mozprofile == 0.28 08:40:56 INFO - mozrunner == 6.11 08:40:56 INFO - mozscreenshot == 0.1 08:40:56 INFO - mozsystemmonitor == 0.0 08:40:56 INFO - moztest == 0.7 08:40:56 INFO - mozversion == 1.4 08:40:56 INFO - psutil == 3.1.1 08:40:56 INFO - requests == 1.2.3 08:40:56 INFO - wsgiref == 0.1.2 08:40:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:56 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 08:40:56 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 08:40:56 INFO - Using env: {'DISPLAY': ':0', 08:40:56 INFO - 'HOME': '/home/cltbld', 08:40:56 INFO - 'LANG': 'en_US.UTF-8', 08:40:56 INFO - 'LANGUAGE': 'en_US:en', 08:40:56 INFO - 'LOGNAME': 'cltbld', 08:40:56 INFO - 'MAIL': '/var/mail/cltbld', 08:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:56 INFO - 'MOZ_NO_REMOTE': '1', 08:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:56 INFO - 'NO_EM_RESTART': '1', 08:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:56 INFO - 'PWD': '/builds/slave/test', 08:40:56 INFO - 'SHELL': '/bin/bash', 08:40:56 INFO - 'SHLVL': '1', 08:40:56 INFO - 'TERM': 'linux', 08:40:56 INFO - 'TMOUT': '86400', 08:40:56 INFO - 'USER': 'cltbld', 08:40:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:56 INFO - '_': '/tools/buildbot/bin/python'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:56 INFO - Cleaning up... 08:40:56 INFO - Return code: 0 08:40:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:56 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 08:40:56 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 08:40:56 INFO - Using env: {'DISPLAY': ':0', 08:40:56 INFO - 'HOME': '/home/cltbld', 08:40:56 INFO - 'LANG': 'en_US.UTF-8', 08:40:56 INFO - 'LANGUAGE': 'en_US:en', 08:40:56 INFO - 'LOGNAME': 'cltbld', 08:40:56 INFO - 'MAIL': '/var/mail/cltbld', 08:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:56 INFO - 'MOZ_NO_REMOTE': '1', 08:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:56 INFO - 'NO_EM_RESTART': '1', 08:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:56 INFO - 'PWD': '/builds/slave/test', 08:40:56 INFO - 'SHELL': '/bin/bash', 08:40:56 INFO - 'SHLVL': '1', 08:40:56 INFO - 'TERM': 'linux', 08:40:56 INFO - 'TMOUT': '86400', 08:40:56 INFO - 'USER': 'cltbld', 08:40:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:56 INFO - '_': '/tools/buildbot/bin/python'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Downloading/unpacking jsonschema 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:58 INFO - Downloading/unpacking functools32 (from jsonschema) 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:58 INFO - warning: no files found matching '*.txt' 08:40:58 INFO - no previously-included directories found matching 'build' 08:40:58 INFO - no previously-included directories found matching 'dist' 08:40:58 INFO - no previously-included directories found matching '.git*' 08:40:58 INFO - Installing collected packages: jsonschema, functools32 08:40:58 INFO - Running setup.py install for functools32 08:40:58 INFO - warning: no files found matching '*.txt' 08:40:58 INFO - no previously-included directories found matching 'build' 08:40:58 INFO - no previously-included directories found matching 'dist' 08:40:58 INFO - no previously-included directories found matching '.git*' 08:40:58 INFO - Successfully installed jsonschema functools32 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 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 0x7fb05f888f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ed5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, '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': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:58 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 08:40:58 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 08:40:58 INFO - Using env: {'DISPLAY': ':0', 08:40:58 INFO - 'HOME': '/home/cltbld', 08:40:58 INFO - 'LANG': 'en_US.UTF-8', 08:40:58 INFO - 'LANGUAGE': 'en_US:en', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MAIL': '/var/mail/cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SHLVL': '1', 08:40:58 INFO - 'TERM': 'linux', 08:40:58 INFO - 'TMOUT': '86400', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - '_': '/tools/buildbot/bin/python'} 08:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:59 INFO - Downloading/unpacking flake8 08:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:41:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:41:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:01 INFO - no previously-included directories found matching 'docs/_build' 08:41:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:41:01 INFO - Running setup.py install for pep8 08:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:01 INFO - no previously-included directories found matching 'docs/_build' 08:41:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:41:01 INFO - Cleaning up... 08:41:01 INFO - Return code: 0 08:41:01 INFO - Running post-action listener: _resource_record_post_action 08:41:01 INFO - Running post-action listener: _start_resource_monitoring 08:41:01 INFO - Starting resource monitoring. 08:41:01 INFO - ##### 08:41:01 INFO - ##### Running install step. 08:41:01 INFO - ##### 08:41:01 INFO - Running pre-action listener: _resource_record_pre_action 08:41:01 INFO - Running main action method: install 08:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:02 INFO - Reading from file tmpfile_stdout 08:41:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:02 INFO - Reading from file tmpfile_stdout 08:41:02 INFO - Output received: 08:41:02 INFO - Usage: mozinstall [options] installer 08:41:02 INFO - Options: 08:41:02 INFO - -h, --help show this help message and exit 08:41:02 INFO - -d DEST, --destination=DEST 08:41:02 INFO - Directory to install application into. [default: 08:41:02 INFO - "/builds/slave/test"] 08:41:02 INFO - --app=APP Application being installed. [default: firefox] 08:41:02 INFO - mkdir: /builds/slave/test/build/application 08:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:17 INFO - Reading from file tmpfile_stdout 08:41:17 INFO - Output received: 08:41:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:17 INFO - Running post-action listener: _resource_record_post_action 08:41:17 INFO - ##### 08:41:17 INFO - ##### Running run-tests step. 08:41:17 INFO - ##### 08:41:17 INFO - Running pre-action listener: _resource_record_pre_action 08:41:17 INFO - Running main action method: run_tests 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:17 INFO - Python 2.7.3 08:41:17 INFO - Return code: 0 08:41:17 INFO - grabbing minidump binary from tooltool 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:17 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 0x187c410>, '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 0x187d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:41:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:17 INFO - Return code: 0 08:41:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:41:18 INFO - Return code: 0 08:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:18 INFO - Using env: {'DISPLAY': ':0', 08:41:18 INFO - 'HOME': '/home/cltbld', 08:41:18 INFO - 'LANG': 'en_US.UTF-8', 08:41:18 INFO - 'LANGUAGE': 'en_US:en', 08:41:18 INFO - 'LOGNAME': 'cltbld', 08:41:18 INFO - 'MAIL': '/var/mail/cltbld', 08:41:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:18 INFO - 'MOZ_NO_REMOTE': '1', 08:41:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:18 INFO - 'NO_EM_RESTART': '1', 08:41:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:18 INFO - 'PWD': '/builds/slave/test', 08:41:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:18 INFO - 'SHELL': '/bin/bash', 08:41:18 INFO - 'SHLVL': '1', 08:41:18 INFO - 'TERM': 'linux', 08:41:18 INFO - 'TMOUT': '86400', 08:41:18 INFO - 'USER': 'cltbld', 08:41:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184', 08:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:18 INFO - '_': '/tools/buildbot/bin/python'} 08:41:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:18 INFO - mozversion application_buildid: 20160621055904 08:41:18 INFO - mozversion application_changeset: 5f7dcce004111d3e2f78cdae83bafb8551937018 08:41:18 INFO - mozversion application_display_name: Firefox 08:41:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:18 INFO - mozversion application_name: Firefox 08:41:18 INFO - mozversion application_remotingname: firefox 08:41:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:18 INFO - mozversion application_vendor: Mozilla 08:41:18 INFO - mozversion application_version: 48.0 08:41:18 INFO - mozversion platform_buildid: 20160621055904 08:41:18 INFO - mozversion platform_changeset: 5f7dcce004111d3e2f78cdae83bafb8551937018 08:41:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:18 INFO - mozversion platform_version: 48.0 08:41:18 INFO - using testdate: 1466523678 08:41:18 INFO - actual date: 1466523678 08:41:18 INFO - starting webserver on 'localhost:51766' 08:41:18 INFO - SUITE-START | Running 2 tests 08:41:18 INFO - TEST-START | dromaeo_css 08:41:18 INFO - operating with platform_type : linux_ 08:41:18 INFO - Initialising browser for dromaeo_css test... 08:41:18 INFO - TEST-INFO | started process 5467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNre7TO/profile http://localhost:51766/getInfo.html) 08:41:23 INFO - PROCESS | 5467 | __metrics Screen width/height:1600/1200 08:41:23 INFO - PROCESS | 5467 | colorDepth:24 08:41:23 INFO - PROCESS | 5467 | Browser inner width/height: 1024/697 08:41:23 INFO - PROCESS | 5467 | __metrics 08:41:24 ERROR - PROCESS | 5467 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:41:25 INFO - TEST-INFO | 5467: exit 0 08:41:25 INFO - Browser initialized. 08:41:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:25 INFO - TEST-INFO | started process 5556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNre7TO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:37 INFO - PROCESS | 5556 | RSS: Main: 141066240 08:41:37 INFO - PROCESS | 5556 | 08:42:28 INFO - PROCESS | 5556 | 1466523748678 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:44:36 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:51766/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51766/tests/dromaeo/cssquery-ext.html) 08:44:37 INFO - PROCESS | 5556 | RSS: Main: 246214656 08:44:37 INFO - PROCESS | 5556 | 08:47:39 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:51766/tests/dromaeo/cssquery-ext.html (next: http://localhost:51766/tests/dromaeo/cssquery-jquery.html) 08:47:40 INFO - PROCESS | 5556 | RSS: Main: 228843520 08:47:40 INFO - PROCESS | 5556 | 08:50:42 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:51766/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51766/tests/dromaeo/cssquery-mootools.html) 08:50:42 INFO - PROCESS | 5556 | RSS: Main: 216211456 08:50:42 INFO - PROCESS | 5556 | 08:53:44 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:51766/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51766/tests/dromaeo/cssquery-prototype.html) 08:53:45 INFO - PROCESS | 5556 | RSS: Main: 220815360 08:53:45 INFO - PROCESS | 5556 | 08:56:47 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:51766/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51766/tests/dromaeo/cssquery-yui.html) 08:56:48 INFO - PROCESS | 5556 | RSS: Main: 180527104 08:56:48 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:51766/tests/dromaeo/cssquery-yui.html (next: http://localhost:51766/tests/dromaeo/cssquery-dojo.html) 08:59:51 INFO - PROCESS | 5556 | RSS: Main: 250785792 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | __start_tp_report 08:59:51 INFO - PROCESS | 5556 | _x_x_mozilla_page_load 08:59:51 INFO - PROCESS | 5556 | _x_x_mozilla_page_load_details 08:59:51 INFO - PROCESS | 5556 | |i|pagename|runs| 08:59:51 INFO - PROCESS | 5556 | |0;dojo.html;3307.884224052158;3371.983140084301;3386.712129468995;3396.3377141457418;3427.7257819374436;5664.291963504556;5668.801591944282;5671.26273584434;5686.0617998030275;5690.516306113975;5632.802851900174;5691.08942569189;5697.401772813857;5717.056685646863;5719;5053.267276244961;5069.239614057902;5124.666896651715;5199.87000324993;5265.4997775211295;5124.564412024983;5162.251473536335;5165.173572228444;5175.741212939357;5181.0933086709865;5143.15138002231;5215.843524694265;5233.8953220935555;5239.371275446952;5250.606204534675;5195.454477279888;5204.557612602934;5223.033738758342;5223.11207094791;5250.291210686566;4965.950340496585;5025.6733312334945;5038.949610503884;5138.409082955471;5150.871228219287;5496.093144631171;5552.805651802208;5558.249636299089;5560.6941618210985;5572.164175373686;6008.909866352008;6009.248843894513;6009.879802403972;6010.609310394811;6013.6692481913915;6072.544559158081;6086.665233412161;6123.387661233885;6128.533679014817;6136.662483563402;5628.943710562883;5675.659460432387;5680.772769089232;5690.630109042899;5705.372409035002;6000.729967151488;6231.096491008869;6236.594621349598;6237.1891654084675;6237.4698150657705;5821.53427725781;5837.416258374129;5845.620034697731;5853.356130825606;5860.912086318709;5976.491998180117;5983.282006159288;5986.850328741729;5997.910031349533;6005.219321488178;5947.791827286111;5955.583109182402;5977.820665380045;5999.040153575407;6022.728977196037;6092.421219984094;6115.848865095124;6120.416658368064;6127.662978536223;6136.723847426876;4598.908021839545;4615.192341340252;4621.607163391082;4623.653226008063;4645.558671926162;4070.3487442009728;4092.877213683594;4127.8968025798995;4134.937975930364;4140.337545992687;5801.129830525455;5805.564582656318;5807.157962095473;5811.128330750421;5812.88374232513;6060.757569697251;6082.939170608326;6119.296280927661;6119.938800611937;6120;5666.801661941812;5757.9424205757405;5807.477327040502;5814.360420353758;5835.533157347402;5057.190849464068;5074.797008119634;5074.873128171826;5079;5079.492050794965;6306.621602703853;6311.779087731908;6315.336889626615;6324.988001919763;6330.715117819709;5963.701814909324;6103.145559621567;6118.418750218722;6154.353792851865;6160.476359509492;6250.218722659668;6266.68666566679;6292.182016337847;6296.653684047421;6297.653629050446;5933.406659334205;5941.821745347646;5964;5970.820875373745;5976.103584462366;5974.133750606225;5977.103434484862;5996.760129594942;6035.9437098506705;6041.667708276087;5776.902388546331;5780.075187969905;5780.5953583248765;5787.247657804459;5790.710464476675;5722.74247658848;5776.826695199151;5777.8555536111935;5781.4507621775865;5791.160281759206;5716.228309178207;5722.885542289214;5788.652680839163;5806.709664516673;5818.301803783404;5898.8230353089475;5976.133460648269;5992.400759923973;5995.730192141451;6002.669853158118;5765.4522820332;5867.589268751147;5869.911951320648;5874.5887787854435;5875.529957603296 08:59:51 INFO - PROCESS | 5556 | |1;ext.html;665.0954701605818;672.8250654829744;676.4723515657788;743.056318475536;763.2367632367632;34097.14757131073;34791.65208347916;34891;40292.597074029254;41521.37717934234;44404.333934991;44875.55124448754;45012;45044.54955450445;45085.77457112718;8433;8891.599878005472;9057.682981095662;9060.818783624323;9070.183683468487;8501.659933602648;10865.130789536857;11087.611933582326;11129.332240065582;11130.777384452305;10794.892051079507;10829.187810914174;10843;10852.782944341148;10866.511007004665;10649.615549978493;10725.731856703645;10734.194935379839;10735.570577176943;10740.194485413625;10740.624078157227;10930.945345273223;10948.014678678957;10949.124070074455;11011.394373309546;44102.117957640665;44577;44607.330890036676;44641.10717785659;44685.776571116934;3687.575928768199;3730.552333719944;3758.5677647070665;3823.2926908521736;3863.343231650598;30074.097777066723;30372.544411833842;30542.236444088852;30925;31179.37641247185;4293.828246870122;4383.211022016036;4437.334399840018;4448.110377924428;4455.576720211575;231048;232459;232474;232487.9999999983;232995;39587;40598.97005149731;64052;64506.67746661237;64546.67726661431;38191.23617527634;38277.80861095733;38359.61640383616;38398.232035359135;38440.423393649115;16415.83584164167;16600.83399166017;16601.252943617324;16607.83392166087;16614.169291535374;12430.316332601613;13926.860731392557;14510.709785804225;14722.263886805616;14748;9341;9356.06439356059;9404.059594040678;9457.621695132118;9488.810223795486;3491.336646037245;3545.858165673344;3578.624244454347;3585.462180672868;3609.205974685565;1062.436908438529;1096;1096.9670909872716;1110.8000559899297;1185.7213554814612;33229.89679478924;33289.500657490156;33533.664663353054;33619.83190084083;33722.325553488794;1208.353530860985;1214.9915570076814;1229.557359350633;1260.4832018872219;1274.8518745913166;17889.463316100537;18343.17455714469;18800.247990080516;18842.81157188438;19233.80766192348;467104;471913;472117;472309;476066;63642.36357636364;64121.03818442727;64121.35878641247;64150.35849641537;64477.355226448075;1458.4603696632103;1548.0556860315423;1549.2718422341482;1616.2484444733254;1652.1243740817386;30393;31166;31545.21136971594;32072.396380181366;32304.515432269003;52827.73586132045;53561.464385357205;53613.731931340095;53631;53689.46310536845;350468;355172;355784;355915;479677;31010;31827.68172318247;32051.67948320487;33800;33845.323093538485;49253.50746492489;49398;50136;50312.49687503078;50795;41279.38080928849;41758.791206043774;41780.164396712506;41919.7904010478;43099;39927.2014559713;39962.60037399705;40475.36484598745;40585.59414405818;41249;40763.38854917119;41531.792341038104;42015.579844201166;42190;42349.78825105855;34675.4798678015;35711.46432803458;35829.28341433209;35842.82078589591;36656.45015324825;28283.57574636341;28355.858220708764;28503.14490565286;28584.142475725763;28748.856255719424 08:59:51 INFO - PROCESS | 5556 | |2;jquery.html;444.4555419610976;447.9227457963597;449.63804137669166;453.5623123685643;458.91739486892345;19062.42812715619;19745.605087898235;19753.703694444575;20987.47531311718;21373.893130534365;20146.798532014713;20205.494862628442;20688.586228275464;20871.582568348626;20876.791232087675;5825.330087039992;5998.070299103646;6005.459508644232;6008.639481631094;6059.939400606004;4453.131639330332;6010.849728756794;6282.183316168892;6538.444232240266;6572.572782769129;6408.231012278533;6510.056041873925;6541.149650545446;6543.1821022372205;6547.083408322815;6469.547131700783;6602.1747281589805;6614.173228346457;6618.966905165444;6622.569532980365;4052.959470405288;5632.35227948787;5842.065269556851;5845.386234445407;5926.496247818941;14082.436702531886;14742.484013059599;14773.704525909528;24638.260852174462;24681;2497.8751062446986;2786.178077467152;2790.734880186379;2810.5924640927155;2844.431113777232;10796.838047429295;10805.5677772889;11066.446677666165;11235.494402751896;11315.943420282845;2027.6857087151368;2058.3927741316347;2093.5603523260133;2105.978940210609;2110.0610228448345;68528.6573567129;75989.24010759933;76314.61842690807;83014.58492707559;85312.72030919603;11649.53401863933;11713.88286117128;11905.523779048914;11914.629817570916;12007.75984480323;16953.152342382833;17010.574735631708;17084.57288567771;17097.572560686083;17159.828401716073;9012.459252444874;9045.412048216846;9123.224525915239;9135.543222838964;9273.72178834636;8878.955605222061;8927.821443571092;8934.28525717941;9010.41432306911;9019.909800902038;5187.2478490619405;5229.346331708536;5250.422453530108;5287.259783630295;5354.759035843396;1850.8611854110995;1989.7711763147133;2062.958740825175;2080.6150862090562;2127.8084972352253;849.9150084991575;987.7876256604865;1033.3541536539663;1041.4584416103585;1064.1593141418193;18421;19914;20048.074769703984;20083;20254.79745202529;952.1763674421713;1035.5236591167995;1053;1057.8095942730229;1085.647164671485;10867.239293249397;11301.321920684784;11341.319520828776;11353.205275630791;11361.318320900773;520101;520220;538677;539770;543535;86335.1366486327;88913;89785.55107224423;91411.54294228487;91998;1034.2760067952463;1062.85651437055;1118.9720256993478;1129.0628778114146;1131.8698349689726;17276.913615431844;17417;17812.862456505303;17953.371631992817;18102.094895255446;37898.242035159696;38454;39616;39830.2033959325;39921.60078399179;54518.7274063643;55015.44984550263;55102.17346739722;55239;55470.16794748001;9357.204637605608;9414.340996130206;9420.105090016437;9659.178969787647;9707.320487565803;12554.246745195318;13929.303534823015;14019.649508762363;14034.29828508591;14178.929105354408;12033.157678962389;12454;12485.500579977062;12495.37523123822;12532;12056.276623402624;12155.81766273489;12244.571439999558;12340.382980850742;12554;12211;12573.371331433209;12599.496020159091;12619.305938173122;12773.425195866022;9213;9294.674686385944;9342.53287335644;9360;9485.383450075724;9735.756606084904;11452.599159029394;12587.24476531411;12675.619731408073;12707.745845083231 08:59:51 INFO - PROCESS | 5556 | |3;mootools.html;1380.5237193168366;1563.7341651919173;1577.9605509862251;1800.4688616858025;1913.6172765446913;8162.224588664075;9006.954965225174;9235.861462078074;9244.075592440753;9273.907260927397;8997.775055623613;9165;9179.403338782975;9183.724488265347;9216.631334746618;2488.7884529814987;2496.775290223884;2515.069424313007;2515.2328539795353;2519.7858182054456;2355.7997570206467;2487;2492.501499700058;2492.5638013347684;2494.638277449769;2461.963070553943;2476.7399423060588;2547.643329933811;2548.0572188290266;2548.7833534149618;2505.473850491408;2525.570652988987;2534.0623969131448;2546.8599227042505;2551.0688598661354;2467.346153269385;2491.352248415407;2498.800095992316;2500.2624225853415;2578.48430313938;8941.865872011926;9165.816683666357;9294.395864268801;9303.302252331103;9312.068793120634;5662.235598194274;5732.656040637575;5785;5791.073428251501;5797.449242321973;3794.924101517954;3899.220155968789;3914.393269043303;3917.082917082917;3962.9009274768073;1218.9207701499374;1301.4729034740944;1319.7162610038888;1332.4337156708457;1335.933203339829;13380.732385352336;13900.235487048209;13912.721745565032;13956.441742330295;13960.441582336694;4861.562459378602;4930.580900623487;5012.04771093491;5015.84952451427;5030.044291584587;10659.413732244646;10736.516856741466;10795.892041079645;10796.67609971702;10810.70271567417;5718.714064296769;5759.366469688331;5772.336181339116;5779.739911703983;5783;4605.263157894721;4703.506131856174;5186.6369354144845;5245.082110630625;5336.546393556591;4347.174036932973;4392.978035109868;4494.52807455219;4511.684182107221;4539.863804085882;1418.9496178022864;1446.5515690136092;1448.3265281644085;1450.8911831612672;1462.9707405852037;955.0306438964457;1033.1734612310122;1054.1303424674675;1075.876274228458;1084.978300433987;6203.596766210272;6324.9051264231075;6442.194725659293;6605.306442823435;6645.667716614246;473.3987835449029;482.5681015491116;484.16723236033965;485.14614278868737;491.47412268872677;4363.956360436418;4435.733855968652;4533.863984080483;4544.613707834805;4547.886302842456;11467.598634047768;11949.76100478003;11963.521459141537;11967.820482692767;11971.52113915451;10534.473276336152;11734.354610496333;11737.35444550558;11783;11787.174897757075;8766.91233087661;8796.560171991376;8815.867761983576;8827.719980602906;8914.197722205032;5906.320773110975;6076.969615151896;6091.695415229309;6105.45050945417;6198.845028874314;9982.500874956368;10124.13944814699;10192.796144077225;10414.635487757892;10426;10198.43908585035;10409.375437473473;10463.581456741646;10803.919608039134;10835.891641083488;8002.879956800536;8263;8270.875936860832;8275.420720549504;8531.616077276662;8778.868316975379;8831.381803273709;8832.690855820016;8835.80716603276;8850.247728943112;7730.265624765639;7848.332891704041;7870.134285228506;7924.6830126796585;7929.365650748042;7731.961340193263;7745.728899488717;7870.881936770838;7877.960610196912;8027.438079334391;6819.0794242778575;6937.236903940663;7362.6318684066655;7413.443991700537;7424.368928641126;5297.8145764898045;5345.2249423832545;5472.945270547243;5507.063799154073;5557.5831812613405;5559.58303127259;5614.803481878278;5783.421657834183;5867.559933004956;5878.3239927408895 08:59:51 INFO - PROCESS | 5556 | |4;prototype.html;373.9214764899371;379.4156998222737;381.191873228755;381.77093743753744;384.88453463960803;6215.036669316252;6342.238931328247;6408.455281301095;6419.711112999915;6431.839204019901;6324;6344.270408902978;6352.4918006559365;6382.872342553146;6447.194100737408;4909.48450412706;4921.458639549646;4940.629452791037;4941.45643979162;4945.530174633404;4715.599174070191;4807.807687692488;4921.154567037361;4955;4962.900741985158;4893.755312234392;4900.558949694527;4905.558499735023;4913.729744864031;4914.705117692932;4896.975515122437;4897.926531102036;4906.411230652309;4909.214525675875;4912.38595175603;4327.956720432787;4346.521882592912;4357.455318085239;4373.737575745466;4377.233984052778;6165.691715414211;6173.135760993465;6187.87624247517;6195.504359651217;6208.906866397007;5626.9437305626825;5755.942440575583;5756.424357564252;5759.251297331362;5761.884762304772;6724.293949135319;6763.357481039294;6764.898526522106;6766.966165169143;6770.390664840188;4804.183288840905;4807.086653535817;4807.375041244651;4808.014357056795;4821.37322148122;7043.929560704379;7047.224805271416;7047.753328633473;7062.15254169503;7062.293770622948;4953.281774142729;4961.454240033593;4961.627877909099;4962.007598480246;4962.60299176065;4893.266010098514;5025.170846810235;5033.899322013539;5035.144025515671;5053.823116190915;5708.372079071299;5712.143178523254;5741.483266506035;5762.798302059407;5776;6743.460523158135;6813.250542440328;6816.727330906808;6827.795166145023;6832;1691.4840973502953;1747.8776485645883;1773.184335205794;1773.3970450047045;1774.5297496163528;1195.6054502014315;1203.1277323940074;1213.7997230457052;1221.9816702749465;1222.437678667805;6545.345465453416;6553.967230163818;6555.246146693096;6557.213134423804;6560.573562718408;6910.861782764317;6966.5471744336455;6974.651267436608;6982.755603553953;6986.860262794716;6557.639329836905;6602.933970660328;6616.106825578581;6619.602823830489;6623.933760662428;3701.444783282529;3767.5290588676417;3767.7550959187565;3771.510253449927;3774.037620406779;7094.148702155671;7412.740554080689;7429.8142546436775;7452.441066919894;7458.664360103809;7239.493235473572;7280;7282.053333066668;7284.6721897514735;7296.051513303343;7404;7409.333160015624;7409.962950185214;7419.740309089156;7422.406207503279;6811.080504132077;7033.226345102137;7084;7084.787456376317;7097.077379940574;6900.689468974008;6959.512834101564;6972;6994.230634630085;6995.4753393494675;7342.926570734225;7351.191368949519;7365.373943214887;7365.52124111931;7426.480146389701;4847.321375007431;4897.9020419592125;4901.191303434894;4901.534354236342;4902.828401005948;6649.401553860176;6726.3609957054005;7055.047568578381;7058.717651294096;7079.327463890922;6848.657567121524;6858.554193977376;6860.5540639858245;6880.4839637026425;6883.483738719716;6788.59268443895;6817.522773405814;6825.658717064226;6826.556273842184;6829.453643708591;6669.0663307136065;6699.397054264945;6700.564463309869;6703;6708.329167083252;6639.435647969976;6884.173899132136;6892.793216203522;6905.033295338556;6909.378155965987;6685.665716714047;6706.5640733352175;6746.797596072126;6748.089007983859;6749.662516874038 08:59:51 INFO - PROCESS | 5556 | |5;yui.html;904.5477261369315;915.9725208243752;922.963081476741;924.639390637651;950;13764.862351376496;15083.547493575197;15268.236588170603;15303.464378746747;15315.770263446057;13014.28421436823;13392.196468211914;13702.109362891406;14088.225147616877;14128.293585320718;900.2887718702234;901.2744740483907;907.4419232172232;914.8078903430288;915.2860768600469;895.8700988356684;906.3429013964889;907.541691445819;907.9228265597433;912.6303846942;953.7710949372135;957.6696039866235;958.3052287091872;958.6261358070324;959.4531117263163;955.4315182466421;956.0391806234759;956.1203692602787;956.2827879090717;956.5408603870112;703.5321511195049;703.5391818358983;705.0869124483805;705.4673721340406;706.8162277807807;12976.221426714428;13026.218426894417;13027.153235039787;13030.348482575833;13036.543720969721;12816.487340506368;12917.87082129176;12919.289439080847;13038;13054.2820144892;10968.561257549689;11127.33236005834;11146.05258553024;11178.161637877192;11354.375509346983;3933.2920074386884;4019.8995025124314;4044.898877528056;4819.542143496362;4889.584385327252;50916.236256456184;53702.73148634271;55447;56402;56582.43417565772;11411.828822567668;11605.665348485032;11826.88173118275;11993.160478766402;12070.698232544257;18876.33932812345;20240.291589794288;20773.065212065492;20820.37538873836;20871.58256834855;8792.912070879338;8816.8677469838;8834.86747698785;8875.822483550293;8919.331050171264;5064.18972964324;5084.745762711849;5095.286659867622;5097.8215762448135;5202.8959420812125;3472.2361080562237;3523.735719821024;3531.7351198660203;3533.699635531009;3536.4695295705337;654.8821212181758;660.1154453032959;660.3231687520234;661.6989269882192;664.6178447392768;723.6092510044517;775.5269285735696;810.6190090657382;826.7933016745814;844.5186243840951;9768.755781105387;9866;9959.701208963743;9994.800103997879;10267.281290309757;667.7213136842988;771.2056581720836;772.6098320348301;813.7762115418308;831.5218749219223;4563.771811409416;4857.854264372075;4874.829380971649;4876.073546026244;4894.877628059327;67344.32655673381;67374.66312668503;67945.66027169832;68327.65836170787;68586.31413685899;58217.4178258212;59769.10346344808;60267.39732602706;61023;61092.38907610867;53168;53694.46305536973;54391;54551;54897.176542351895;9477.296463917985;9695.215070612596;9699.224062074876;9714.368566043184;9786.41281523111;32116.35767284688;35074.82462587671;39880.401793973695;39997;41050.79474602608;51825;52872.47127528829;53876.46123538871;54119.188212177636;54477.45522544882;13151.802722958972;13209.867901321248;13210.80183797263;13458.25979571133;13525.932370338085;14282.42870285177;14442.133471991714;14873.851261487247;15285.235738213267;15390.84609153894;13816.240106794223;14138.646533836736;14362;14651.487197948021;14711.190884501455;12953;13694.178349298676;13752.174869507462;14166.858331416553;14179.432822686977;13106.803397949228;13659.317034148055;14179.64550886236;14194.361253743813;14377;11400.600978965696;11426.371549564521;11615.012723918562;12100.394980250776;12101.515939362327;11601.941990289995;11603.419829008348;11843.763124737628;11859.169858110195;11875.703107422383 08:59:51 INFO - PROCESS | 5556 | __end_tp_report 08:59:51 INFO - PROCESS | 5556 | __start_cc_report 08:59:51 INFO - PROCESS | 5556 | _x_x_mozilla_cycle_collect,839 08:59:51 INFO - PROCESS | 5556 | __end_cc_report 08:59:51 INFO - PROCESS | 5556 | __startTimestamp1466524791309__endTimestamp 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | ------- Summary: start ------- 08:59:51 INFO - PROCESS | 5556 | Number of tests: 6 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | [#0] dojo.html Cycles:165 Average:5615.64 Median:5805.56 stddev:628.66 (10.8%) stddev-sans-first:603.96 08:59:51 INFO - PROCESS | 5556 | Values: 3307.9 3372.0 3386.7 3396.3 3427.7 5664.3 5668.8 5671.3 5686.1 5690.5 5632.8 5691.1 5697.4 5717.1 5719.0 5053.3 5069.2 5124.7 5199.9 5265.5 5124.6 5162.3 5165.2 5175.7 5181.1 5143.2 5215.8 5233.9 5239.4 5250.6 5195.5 5204.6 5223.0 5223.1 5250.3 4966.0 5025.7 5038.9 5138.4 5150.9 5496.1 5552.8 5558.2 5560.7 5572.2 6008.9 6009.2 6009.9 6010.6 6013.7 6072.5 6086.7 6123.4 6128.5 6136.7 5628.9 5675.7 5680.8 5690.6 5705.4 6000.7 6231.1 6236.6 6237.2 6237.5 5821.5 5837.4 5845.6 5853.4 5860.9 5976.5 5983.3 5986.9 5997.9 6005.2 5947.8 5955.6 5977.8 5999.0 6022.7 6092.4 6115.8 6120.4 6127.7 6136.7 4598.9 4615.2 4621.6 4623.7 4645.6 4070.3 4092.9 4127.9 4134.9 4140.3 5801.1 5805.6 5807.2 5811.1 5812.9 6060.8 6082.9 6119.3 6119.9 6120.0 5666.8 5757.9 5807.5 5814.4 5835.5 5057.2 5074.8 5074.9 5079.0 5079.5 6306.6 6311.8 6315.3 6325.0 6330.7 5963.7 6103.1 6118.4 6154.4 6160.5 6250.2 6266.7 6292.2 6296.7 6297.7 5933.4 5941.8 5964.0 5970.8 5976.1 5974.1 5977.1 5996.8 6035.9 6041.7 5776.9 5780.1 5780.6 5787.2 5790.7 5722.7 5776.8 5777.9 5781.5 5791.2 5716.2 5722.9 5788.7 5806.7 5818.3 5898.8 5976.1 5992.4 5995.7 6002.7 5765.5 5867.6 5869.9 5874.6 5875.5 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | [#1] ext.html Cycles:180 Average:53169.90 Median:19703.95 stddev:99389.91 (504.4%) stddev-sans-first:99590.55 08:59:51 INFO - PROCESS | 5556 | Values: 665.1 672.8 676.5 743.1 763.2 34097.1 34791.7 34891.0 40292.6 41521.4 44404.3 44875.6 45012.0 45044.5 45085.8 8433.0 8891.6 9057.7 9060.8 9070.2 8501.7 10865.1 11087.6 11129.3 11130.8 10794.9 10829.2 10843.0 10852.8 10866.5 10649.6 10725.7 10734.2 10735.6 10740.2 10740.6 10930.9 10948.0 10949.1 11011.4 44102.1 44577.0 44607.3 44641.1 44685.8 3687.6 3730.6 3758.6 3823.3 3863.3 30074.1 30372.5 30542.2 30925.0 31179.4 4293.8 4383.2 4437.3 4448.1 4455.6 231048.0 232459.0 232474.0 232488.0 232995.0 39587.0 40599.0 64052.0 64506.7 64546.7 38191.2 38277.8 38359.6 38398.2 38440.4 16415.8 16600.8 16601.3 16607.8 16614.2 12430.3 13926.9 14510.7 14722.3 14748.0 9341.0 9356.1 9404.1 9457.6 9488.8 3491.3 3545.9 3578.6 3585.5 3609.2 1062.4 1096.0 1097.0 1110.8 1185.7 33229.9 33289.5 33533.7 33619.8 33722.3 1208.4 1215.0 1229.6 1260.5 1274.9 17889.5 18343.2 18800.2 18842.8 19233.8 467104.0 471913.0 472117.0 472309.0 476066.0 63642.4 64121.0 64121.4 64150.4 64477.4 1458.5 1548.1 1549.3 1616.2 1652.1 30393.0 31166.0 31545.2 32072.4 32304.5 52827.7 53561.5 53613.7 53631.0 53689.5 350468.0 355172.0 355784.0 355915.0 479677.0 31010.0 31827.7 32051.7 33800.0 33845.3 49253.5 49398.0 50136.0 50312.5 50795.0 41279.4 41758.8 41780.2 41919.8 43099.0 39927.2 39962.6 40475.4 40585.6 41249.0 40763.4 41531.8 42015.6 42190.0 42349.8 34675.5 35711.5 35829.3 35842.8 36656.5 28283.6 28355.9 28503.1 28584.1 28748.9 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | [#2] jquery.html Cycles:180 Average:30224.53 Median:13589.44 stddev:87387.78 (643.1%) stddev-sans-first:87604.32 08:59:51 INFO - PROCESS | 5556 | Values: 444.5 447.9 449.6 453.6 458.9 19062.4 19745.6 19753.7 20987.5 21373.9 20146.8 20205.5 20688.6 20871.6 20876.8 5825.3 5998.1 6005.5 6008.6 6059.9 4453.1 6010.8 6282.2 6538.4 6572.6 6408.2 6510.1 6541.1 6543.2 6547.1 6469.5 6602.2 6614.2 6619.0 6622.6 4053.0 5632.4 5842.1 5845.4 5926.5 14082.4 14742.5 14773.7 24638.3 24681.0 2497.9 2786.2 2790.7 2810.6 2844.4 10796.8 10805.6 11066.4 11235.5 11315.9 2027.7 2058.4 2093.6 2106.0 2110.1 68528.7 75989.2 76314.6 83014.6 85312.7 11649.5 11713.9 11905.5 11914.6 12007.8 16953.2 17010.6 17084.6 17097.6 17159.8 9012.5 9045.4 9123.2 9135.5 9273.7 8879.0 8927.8 8934.3 9010.4 9019.9 5187.2 5229.3 5250.4 5287.3 5354.8 1850.9 1989.8 2063.0 2080.6 2127.8 849.9 987.8 1033.4 1041.5 1064.2 18421.0 19914.0 20048.1 20083.0 20254.8 952.2 1035.5 1053.0 1057.8 1085.6 10867.2 11301.3 11341.3 11353.2 11361.3 520101.0 520220.0 538677.0 539770.0 543535.0 86335.1 88913.0 89785.6 91411.5 91998.0 1034.3 1062.9 1119.0 1129.1 1131.9 17276.9 17417.0 17812.9 17953.4 18102.1 37898.2 38454.0 39616.0 39830.2 39921.6 54518.7 55015.4 55102.2 55239.0 55470.2 9357.2 9414.3 9420.1 9659.2 9707.3 12554.2 13929.3 14019.6 14034.3 14178.9 12033.2 12454.0 12485.5 12495.4 12532.0 12056.3 12155.8 12244.6 12340.4 12554.0 12211.0 12573.4 12599.5 12619.3 12773.4 9213.0 9294.7 9342.5 9360.0 9485.4 9735.8 11452.6 12587.2 12675.6 12707.7 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | [#3] mootools.html Cycles:180 Average:6149.31 Median:477.98 stddev:3487.77 (729.7%) stddev-sans-first:3479.14 08:59:51 INFO - PROCESS | 5556 | Values: 1380.5 1563.7 1578.0 1800.5 1913.6 8162.2 9007.0 9235.9 9244.1 9273.9 8997.8 9165.0 9179.4 9183.7 9216.6 2488.8 2496.8 2515.1 2515.2 2519.8 2355.8 2487.0 2492.5 2492.6 2494.6 2462.0 2476.7 2547.6 2548.1 2548.8 2505.5 2525.6 2534.1 2546.9 2551.1 2467.3 2491.4 2498.8 2500.3 2578.5 8941.9 9165.8 9294.4 9303.3 9312.1 5662.2 5732.7 5785.0 5791.1 5797.4 3794.9 3899.2 3914.4 3917.1 3962.9 1218.9 1301.5 1319.7 1332.4 1335.9 13380.7 13900.2 13912.7 13956.4 13960.4 4861.6 4930.6 5012.0 5015.8 5030.0 10659.4 10736.5 10795.9 10796.7 10810.7 5718.7 5759.4 5772.3 5779.7 5783.0 4605.3 4703.5 5186.6 5245.1 5336.5 4347.2 4393.0 4494.5 4511.7 4539.9 1418.9 1446.6 1448.3 1450.9 1463.0 955.0 1033.2 1054.1 1075.9 1085.0 6203.6 6324.9 6442.2 6605.3 6645.7 473.4 482.6 484.2 485.1 491.5 4364.0 4435.7 4533.9 4544.6 4547.9 11467.6 11949.8 11963.5 11967.8 11971.5 10534.5 11734.4 11737.4 11783.0 11787.2 8766.9 8796.6 8815.9 8827.7 8914.2 5906.3 6077.0 6091.7 6105.5 6198.8 9982.5 10124.1 10192.8 10414.6 10426.0 10198.4 10409.4 10463.6 10803.9 10835.9 8002.9 8263.0 8270.9 8275.4 8531.6 8778.9 8831.4 8832.7 8835.8 8850.2 7730.3 7848.3 7870.1 7924.7 7929.4 7732.0 7745.7 7870.9 7878.0 8027.4 6819.1 6937.2 7362.6 7413.4 7424.4 5297.8 5345.2 5472.9 5507.1 5557.6 5559.6 5614.8 5783.4 5867.6 5878.3 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | [#4] prototype.html Cycles:180 Average:5726.52 Median:6549.66 stddev:1712.18 (26.1%) stddev-sans-first:1669.18 08:59:51 INFO - PROCESS | 5556 | Values: 373.9 379.4 381.2 381.8 384.9 6215.0 6342.2 6408.5 6419.7 6431.8 6324.0 6344.3 6352.5 6382.9 6447.2 4909.5 4921.5 4940.6 4941.5 4945.5 4715.6 4807.8 4921.2 4955.0 4962.9 4893.8 4900.6 4905.6 4913.7 4914.7 4897.0 4897.9 4906.4 4909.2 4912.4 4328.0 4346.5 4357.5 4373.7 4377.2 6165.7 6173.1 6187.9 6195.5 6208.9 5626.9 5755.9 5756.4 5759.3 5761.9 6724.3 6763.4 6764.9 6767.0 6770.4 4804.2 4807.1 4807.4 4808.0 4821.4 7043.9 7047.2 7047.8 7062.2 7062.3 4953.3 4961.5 4961.6 4962.0 4962.6 4893.3 5025.2 5033.9 5035.1 5053.8 5708.4 5712.1 5741.5 5762.8 5776.0 6743.5 6813.3 6816.7 6827.8 6832.0 1691.5 1747.9 1773.2 1773.4 1774.5 1195.6 1203.1 1213.8 1222.0 1222.4 6545.3 6554.0 6555.2 6557.2 6560.6 6910.9 6966.5 6974.7 6982.8 6986.9 6557.6 6602.9 6616.1 6619.6 6623.9 3701.4 3767.5 3767.8 3771.5 3774.0 7094.1 7412.7 7429.8 7452.4 7458.7 7239.5 7280.0 7282.1 7284.7 7296.1 7404.0 7409.3 7410.0 7419.7 7422.4 6811.1 7033.2 7084.0 7084.8 7097.1 6900.7 6959.5 6972.0 6994.2 6995.5 7342.9 7351.2 7365.4 7365.5 7426.5 4847.3 4897.9 4901.2 4901.5 4902.8 6649.4 6726.4 7055.0 7058.7 7079.3 6848.7 6858.6 6860.6 6880.5 6883.5 6788.6 6817.5 6825.7 6826.6 6829.5 6669.1 6699.4 6700.6 6703.0 6708.3 6639.4 6884.2 6892.8 6905.0 6909.4 6685.7 6706.6 6746.8 6748.1 6749.7 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - PROCESS | 5556 | [#5] yui.html Cycles:180 Average:15920.36 Median:4979.53 stddev:18570.07 (372.9%) stddev-sans-first:18587.93 08:59:51 INFO - PROCESS | 5556 | Values: 904.5 916.0 923.0 924.6 950.0 13764.9 15083.5 15268.2 15303.5 15315.8 13014.3 13392.2 13702.1 14088.2 14128.3 900.3 901.3 907.4 914.8 915.3 895.9 906.3 907.5 907.9 912.6 953.8 957.7 958.3 958.6 959.5 955.4 956.0 956.1 956.3 956.5 703.5 703.5 705.1 705.5 706.8 12976.2 13026.2 13027.2 13030.3 13036.5 12816.5 12917.9 12919.3 13038.0 13054.3 10968.6 11127.3 11146.1 11178.2 11354.4 3933.3 4019.9 4044.9 4819.5 4889.6 50916.2 53702.7 55447.0 56402.0 56582.4 11411.8 11605.7 11826.9 11993.2 12070.7 18876.3 20240.3 20773.1 20820.4 20871.6 8792.9 8816.9 8834.9 8875.8 8919.3 5064.2 5084.7 5095.3 5097.8 5202.9 3472.2 3523.7 3531.7 3533.7 3536.5 654.9 660.1 660.3 661.7 664.6 723.6 775.5 810.6 826.8 844.5 9768.8 9866.0 9959.7 9994.8 10267.3 667.7 771.2 772.6 813.8 831.5 4563.8 4857.9 4874.8 4876.1 4894.9 67344.3 67374.7 67945.7 68327.7 68586.3 58217.4 59769.1 60267.4 61023.0 61092.4 53168.0 53694.5 54391.0 54551.0 54897.2 9477.3 9695.2 9699.2 9714.4 9786.4 32116.4 35074.8 39880.4 39997.0 41050.8 51825.0 52872.5 53876.5 54119.2 54477.5 13151.8 13209.9 13210.8 13458.3 13525.9 14282.4 14442.1 14873.9 15285.2 15390.8 13816.2 14138.6 14362.0 14651.5 14711.2 12953.0 13694.2 13752.2 14166.9 14179.4 13106.8 13659.3 14179.6 14194.4 14377.0 11400.6 11426.4 11615.0 12100.4 12101.5 11601.9 11603.4 11843.8 11859.2 11875.7 08:59:51 INFO - PROCESS | 5556 | -------- Summary: end -------- 08:59:51 INFO - PROCESS | 5556 | 08:59:51 INFO - TEST-INFO | 5556: exit 0 08:59:51 INFO - TEST-OK | dromaeo_css | took 1113425ms 08:59:51 INFO - TEST-START | kraken 08:59:51 INFO - operating with platform_type : linux_ 08:59:51 INFO - Initialising browser for kraken test... 08:59:51 INFO - TEST-INFO | started process 5742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmkhmwV/profile http://localhost:51766/getInfo.html) 08:59:56 INFO - PROCESS | 5742 | __metrics Screen width/height:1600/1200 08:59:56 INFO - PROCESS | 5742 | colorDepth:24 08:59:56 INFO - PROCESS | 5742 | Browser inner width/height: 1024/697 08:59:56 INFO - PROCESS | 5742 | __metrics 08:59:57 ERROR - PROCESS | 5742 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:59:58 INFO - TEST-INFO | 5742: exit 0 08:59:58 INFO - Browser initialized. 08:59:58 INFO - Running cycle 1/1 for kraken test... 08:59:58 INFO - TEST-INFO | started process 5835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmkhmwV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:10 INFO - PROCESS | 5835 | RSS: Main: 141160448 09:00:10 INFO - PROCESS | 5835 | 09:00:13 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51766/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:14 INFO - PROCESS | 5835 | RSS: Main: 197300224 09:00:14 INFO - PROCESS | 5835 | 09:00:16 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51766/tests/kraken/driver.html?testName=audio-dft) 09:00:17 INFO - PROCESS | 5835 | RSS: Main: 184627200 09:00:17 INFO - PROCESS | 5835 | 09:00:20 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51766/tests/kraken/driver.html?testName=audio-fft) 09:00:20 INFO - PROCESS | 5835 | RSS: Main: 273895424 09:00:20 INFO - PROCESS | 5835 | 09:00:22 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51766/tests/kraken/driver.html?testName=audio-oscillator) 09:00:23 INFO - PROCESS | 5835 | RSS: Main: 180305920 09:00:23 INFO - PROCESS | 5835 | 09:00:25 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51766/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:26 INFO - PROCESS | 5835 | RSS: Main: 178651136 09:00:26 INFO - PROCESS | 5835 | 09:00:29 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51766/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:29 INFO - PROCESS | 5835 | RSS: Main: 213499904 09:00:29 INFO - PROCESS | 5835 | 09:00:33 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51766/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:33 INFO - PROCESS | 5835 | RSS: Main: 214032384 09:00:33 INFO - PROCESS | 5835 | 09:00:36 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51766/tests/kraken/driver.html?testName=json-parse-financial) 09:00:36 INFO - PROCESS | 5835 | RSS: Main: 213606400 09:00:36 INFO - PROCESS | 5835 | 09:00:38 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51766/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:39 INFO - PROCESS | 5835 | RSS: Main: 194686976 09:00:39 INFO - PROCESS | 5835 | 09:00:40 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:41 INFO - PROCESS | 5835 | RSS: Main: 198344704 09:00:41 INFO - PROCESS | 5835 | 09:00:43 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:43 INFO - PROCESS | 5835 | RSS: Main: 208265216 09:00:43 INFO - PROCESS | 5835 | 09:00:46 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:46 INFO - PROCESS | 5835 | RSS: Main: 216530944 09:00:46 INFO - PROCESS | 5835 | 09:00:49 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:50 INFO - PROCESS | 5835 | RSS: Main: 214048768 09:00:50 INFO - PROCESS | 5835 | 09:00:51 INFO - PROCESS | 5835 | Cycle 1(1): loaded http://localhost:51766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51766/tests/kraken/driver.html?testName=ai-astar) 09:00:52 INFO - PROCESS | 5835 | RSS: Main: 274681856 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | __start_tp_report 09:00:52 INFO - PROCESS | 5835 | _x_x_mozilla_page_load 09:00:52 INFO - PROCESS | 5835 | _x_x_mozilla_page_load_details 09:00:52 INFO - PROCESS | 5835 | |i|pagename|runs| 09:00:52 INFO - PROCESS | 5835 | |0;ai-astar;110;110;111;110;109;110;104;107;108;108 09:00:52 INFO - PROCESS | 5835 | |1;audio-beat-detection;157;126;161;173;126;148;151;128;183;126 09:00:52 INFO - PROCESS | 5835 | |2;audio-dft;161;161;160;160;160;161;165;160;161;161 09:00:52 INFO - PROCESS | 5835 | |3;audio-fft;73;74;76;175;76;77;75;73;152;78 09:00:52 INFO - PROCESS | 5835 | |4;audio-oscillator;101;92;164;93;92;92;155;92;91;156 09:00:52 INFO - PROCESS | 5835 | |5;imaging-gaussian-blur;116;117;116;116;118;117;117;116;117;116 09:00:52 INFO - PROCESS | 5835 | |6;imaging-darkroom;146;146;146;145;146;146;145;145;146;146 09:00:52 INFO - PROCESS | 5835 | |7;imaging-desaturate;95;94;94;94;94;95;95;94;94;94 09:00:52 INFO - PROCESS | 5835 | |8;json-parse-financial;53;54;55;55;55;55;54;75;53;52 09:00:52 INFO - PROCESS | 5835 | |9;json-stringify-tinderbox;67;58;59;58;59;59;58;59;61;59 09:00:52 INFO - PROCESS | 5835 | |10;stanford-crypto-aes;72;71;72;73;72;73;72;72;73;73 09:00:52 INFO - PROCESS | 5835 | |11;stanford-crypto-ccm;124;118;114;111;119;113;111;113;130;132 09:00:52 INFO - PROCESS | 5835 | |12;stanford-crypto-pbkdf2;160;160;158;156;167;164;160;165;164;158 09:00:52 INFO - PROCESS | 5835 | |13;stanford-crypto-sha256-iterative;67;69;67;66;65;67;67;66;67;63 09:00:52 INFO - PROCESS | 5835 | __end_tp_report 09:00:52 INFO - PROCESS | 5835 | __start_cc_report 09:00:52 INFO - PROCESS | 5835 | _x_x_mozilla_cycle_collect,1599 09:00:52 INFO - PROCESS | 5835 | __end_cc_report 09:00:52 INFO - PROCESS | 5835 | __startTimestamp1466524852184__endTimestamp 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | ------- Summary: start ------- 09:00:52 INFO - PROCESS | 5835 | Number of tests: 14 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:2.06 (1.9%) stddev-sans-first:2.13 09:00:52 INFO - PROCESS | 5835 | Values: 110.0 110.0 111.0 110.0 109.0 110.0 104.0 107.0 108.0 108.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:154.00 stddev:20.98 (13.6%) stddev-sans-first:21.99 09:00:52 INFO - PROCESS | 5835 | Values: 157.0 126.0 161.0 173.0 126.0 148.0 151.0 128.0 183.0 126.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 09:00:52 INFO - PROCESS | 5835 | Values: 161.0 161.0 160.0 160.0 160.0 161.0 165.0 160.0 161.0 161.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:37.64 (49.9%) stddev-sans-first:39.23 09:00:52 INFO - PROCESS | 5835 | Values: 73.0 74.0 76.0 175.0 76.0 77.0 75.0 73.0 152.0 78.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:92.00 stddev:31.63 (34.4%) stddev-sans-first:33.26 09:00:52 INFO - PROCESS | 5835 | Values: 101.0 92.0 164.0 93.0 92.0 92.0 155.0 92.0 91.0 156.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 09:00:52 INFO - PROCESS | 5835 | Values: 116.0 117.0 116.0 116.0 118.0 117.0 117.0 116.0 117.0 116.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:00:52 INFO - PROCESS | 5835 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:00:52 INFO - PROCESS | 5835 | Values: 95.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.72 (12.2%) stddev-sans-first:7.04 09:00:52 INFO - PROCESS | 5835 | Values: 53.0 54.0 55.0 55.0 55.0 55.0 54.0 75.0 53.0 52.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:2.71 (4.6%) stddev-sans-first:0.93 09:00:52 INFO - PROCESS | 5835 | Values: 67.0 58.0 59.0 58.0 59.0 59.0 58.0 59.0 61.0 59.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.50 stddev:0.67 (0.9%) stddev-sans-first:0.71 09:00:52 INFO - PROCESS | 5835 | Values: 72.0 71.0 72.0 73.0 72.0 73.0 72.0 72.0 73.0 73.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.50 stddev:7.74 (6.5%) stddev-sans-first:7.94 09:00:52 INFO - PROCESS | 5835 | Values: 124.0 118.0 114.0 111.0 119.0 113.0 111.0 113.0 130.0 132.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.00 stddev:3.58 (2.2%) stddev-sans-first:3.77 09:00:52 INFO - PROCESS | 5835 | Values: 160.0 160.0 158.0 156.0 167.0 164.0 160.0 165.0 164.0 158.0 09:00:52 INFO - PROCESS | 5835 | 09:00:52 INFO - PROCESS | 5835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.66 09:00:52 INFO - PROCESS | 5835 | Values: 67.0 69.0 67.0 66.0 65.0 67.0 67.0 66.0 67.0 63.0 09:00:52 INFO - PROCESS | 5835 | -------- Summary: end -------- 09:00:52 INFO - PROCESS | 5835 | 09:00:53 INFO - TEST-INFO | 5835: exit 0 09:00:53 INFO - TEST-OK | kraken | took 61147ms 09:00:53 INFO - SUITE-END | took 1174s 09:00:53 INFO - Completed test suite (00:19:34) 09:00:53 INFO - javascript benchmark 09:00:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.884224052158, 3371.983140084301, 3386.712129468995, 3396.3377141457418, 3427.7257819374436, 5664.291963504556, 5668.801591944282, 5671.26273584434, 5686.0617998030275, 5690.516306113975, 5632.802851900174, 5691.08942569189, 5697.401772813857, 5717.056685646863, 5719.0, 5053.267276244961, 5069.239614057902, 5124.666896651715, 5199.87000324993, 5265.4997775211295, 5124.564412024983, 5162.251473536335, 5165.173572228444, 5175.741212939357, 5181.0933086709865, 5143.15138002231, 5215.843524694265, 5233.8953220935555, 5239.371275446952, 5250.606204534675, 5195.454477279888, 5204.557612602934, 5223.033738758342, 5223.11207094791, 5250.291210686566, 4965.950340496585, 5025.6733312334945, 5038.949610503884, 5138.409082955471, 5150.871228219287, 5496.093144631171, 5552.805651802208, 5558.249636299089, 5560.6941618210985, 5572.164175373686, 6008.909866352008, 6009.248843894513, 6009.879802403972, 6010.609310394811, 6013.6692481913915, 6072.544559158081, 6086.665233412161, 6123.387661233885, 6128.533679014817, 6136.662483563402, 5628.943710562883, 5675.659460432387, 5680.772769089232, 5690.630109042899, 5705.372409035002, 6000.729967151488, 6231.096491008869, 6236.594621349598, 6237.1891654084675, 6237.4698150657705, 5821.53427725781, 5837.416258374129, 5845.620034697731, 5853.356130825606, 5860.912086318709, 5976.491998180117, 5983.282006159288, 5986.850328741729, 5997.910031349533, 6005.219321488178, 5947.791827286111, 5955.583109182402, 5977.820665380045, 5999.040153575407, 6022.728977196037, 6092.421219984094, 6115.848865095124, 6120.416658368064, 6127.662978536223, 6136.723847426876, 4598.908021839545, 4615.192341340252, 4621.607163391082, 4623.653226008063, 4645.558671926162, 4070.3487442009728, 4092.877213683594, 4127.8968025798995, 4134.937975930364, 4140.337545992687, 5801.129830525455, 5805.564582656318, 5807.157962095473, 5811.128330750421, 5812.88374232513, 6060.757569697251, 6082.939170608326, 6119.296280927661, 6119.938800611937, 6120.0, 5666.801661941812, 5757.9424205757405, 5807.477327040502, 5814.360420353758, 5835.533157347402, 5057.190849464068, 5074.797008119634, 5074.873128171826, 5079.0, 5079.492050794965, 6306.621602703853, 6311.779087731908, 6315.336889626615, 6324.988001919763, 6330.715117819709, 5963.701814909324, 6103.145559621567, 6118.418750218722, 6154.353792851865, 6160.476359509492, 6250.218722659668, 6266.68666566679, 6292.182016337847, 6296.653684047421, 6297.653629050446, 5933.406659334205, 5941.821745347646, 5964.0, 5970.820875373745, 5976.103584462366, 5974.133750606225, 5977.103434484862, 5996.760129594942, 6035.9437098506705, 6041.667708276087, 5776.902388546331, 5780.075187969905, 5780.5953583248765, 5787.247657804459, 5790.710464476675, 5722.74247658848, 5776.826695199151, 5777.8555536111935, 5781.4507621775865, 5791.160281759206, 5716.228309178207, 5722.885542289214, 5788.652680839163, 5806.709664516673, 5818.301803783404, 5898.8230353089475, 5976.133460648269, 5992.400759923973, 5995.730192141451, 6002.669853158118, 5765.4522820332, 5867.589268751147, 5869.911951320648, 5874.5887787854435, 5875.529957603296], "value": 5574.315677084111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.0954701605818, 672.8250654829744, 676.4723515657788, 743.056318475536, 763.2367632367632, 34097.14757131073, 34791.65208347916, 34891.0, 40292.597074029254, 41521.37717934234, 44404.333934991, 44875.55124448754, 45012.0, 45044.54955450445, 45085.77457112718, 8433.0, 8891.599878005472, 9057.682981095662, 9060.818783624323, 9070.183683468487, 8501.659933602648, 10865.130789536857, 11087.611933582326, 11129.332240065582, 11130.777384452305, 10794.892051079507, 10829.187810914174, 10843.0, 10852.782944341148, 10866.511007004665, 10649.615549978493, 10725.731856703645, 10734.194935379839, 10735.570577176943, 10740.194485413625, 10740.624078157227, 10930.945345273223, 10948.014678678957, 10949.124070074455, 11011.394373309546, 44102.117957640665, 44577.0, 44607.330890036676, 44641.10717785659, 44685.776571116934, 3687.575928768199, 3730.552333719944, 3758.5677647070665, 3823.2926908521736, 3863.343231650598, 30074.097777066723, 30372.544411833842, 30542.236444088852, 30925.0, 31179.37641247185, 4293.828246870122, 4383.211022016036, 4437.334399840018, 4448.110377924428, 4455.576720211575, 231048.0, 232459.0, 232474.0, 232487.9999999983, 232995.0, 39587.0, 40598.97005149731, 64052.0, 64506.67746661237, 64546.67726661431, 38191.23617527634, 38277.80861095733, 38359.61640383616, 38398.232035359135, 38440.423393649115, 16415.83584164167, 16600.83399166017, 16601.252943617324, 16607.83392166087, 16614.169291535374, 12430.316332601613, 13926.860731392557, 14510.709785804225, 14722.263886805616, 14748.0, 9341.0, 9356.06439356059, 9404.059594040678, 9457.621695132118, 9488.810223795486, 3491.336646037245, 3545.858165673344, 3578.624244454347, 3585.462180672868, 3609.205974685565, 1062.436908438529, 1096.0, 1096.9670909872716, 1110.8000559899297, 1185.7213554814612, 33229.89679478924, 33289.500657490156, 33533.664663353054, 33619.83190084083, 33722.325553488794, 1208.353530860985, 1214.9915570076814, 1229.557359350633, 1260.4832018872219, 1274.8518745913166, 17889.463316100537, 18343.17455714469, 18800.247990080516, 18842.81157188438, 19233.80766192348, 467104.0, 471913.0, 472117.0, 472309.0, 476066.0, 63642.36357636364, 64121.03818442727, 64121.35878641247, 64150.35849641537, 64477.355226448075, 1458.4603696632103, 1548.0556860315423, 1549.2718422341482, 1616.2484444733254, 1652.1243740817386, 30393.0, 31166.0, 31545.21136971594, 32072.396380181366, 32304.515432269003, 52827.73586132045, 53561.464385357205, 53613.731931340095, 53631.0, 53689.46310536845, 350468.0, 355172.0, 355784.0, 355915.0, 479677.0, 31010.0, 31827.68172318247, 32051.67948320487, 33800.0, 33845.323093538485, 49253.50746492489, 49398.0, 50136.0, 50312.49687503078, 50795.0, 41279.38080928849, 41758.791206043774, 41780.164396712506, 41919.7904010478, 43099.0, 39927.2014559713, 39962.60037399705, 40475.36484598745, 40585.59414405818, 41249.0, 40763.38854917119, 41531.792341038104, 42015.579844201166, 42190.0, 42349.78825105855, 34675.4798678015, 35711.46432803458, 35829.28341433209, 35842.82078589591, 36656.45015324825, 28283.57574636341, 28355.858220708764, 28503.14490565286, 28584.142475725763, 28748.856255719424], "value": 19654.272759494852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.4555419610976, 447.9227457963597, 449.63804137669166, 453.5623123685643, 458.91739486892345, 19062.42812715619, 19745.605087898235, 19753.703694444575, 20987.47531311718, 21373.893130534365, 20146.798532014713, 20205.494862628442, 20688.586228275464, 20871.582568348626, 20876.791232087675, 5825.330087039992, 5998.070299103646, 6005.459508644232, 6008.639481631094, 6059.939400606004, 4453.131639330332, 6010.849728756794, 6282.183316168892, 6538.444232240266, 6572.572782769129, 6408.231012278533, 6510.056041873925, 6541.149650545446, 6543.1821022372205, 6547.083408322815, 6469.547131700783, 6602.1747281589805, 6614.173228346457, 6618.966905165444, 6622.569532980365, 4052.959470405288, 5632.35227948787, 5842.065269556851, 5845.386234445407, 5926.496247818941, 14082.436702531886, 14742.484013059599, 14773.704525909528, 24638.260852174462, 24681.0, 2497.8751062446986, 2786.178077467152, 2790.734880186379, 2810.5924640927155, 2844.431113777232, 10796.838047429295, 10805.5677772889, 11066.446677666165, 11235.494402751896, 11315.943420282845, 2027.6857087151368, 2058.3927741316347, 2093.5603523260133, 2105.978940210609, 2110.0610228448345, 68528.6573567129, 75989.24010759933, 76314.61842690807, 83014.58492707559, 85312.72030919603, 11649.53401863933, 11713.88286117128, 11905.523779048914, 11914.629817570916, 12007.75984480323, 16953.152342382833, 17010.574735631708, 17084.57288567771, 17097.572560686083, 17159.828401716073, 9012.459252444874, 9045.412048216846, 9123.224525915239, 9135.543222838964, 9273.72178834636, 8878.955605222061, 8927.821443571092, 8934.28525717941, 9010.41432306911, 9019.909800902038, 5187.2478490619405, 5229.346331708536, 5250.422453530108, 5287.259783630295, 5354.759035843396, 1850.8611854110995, 1989.7711763147133, 2062.958740825175, 2080.6150862090562, 2127.8084972352253, 849.9150084991575, 987.7876256604865, 1033.3541536539663, 1041.4584416103585, 1064.1593141418193, 18421.0, 19914.0, 20048.074769703984, 20083.0, 20254.79745202529, 952.1763674421713, 1035.5236591167995, 1053.0, 1057.8095942730229, 1085.647164671485, 10867.239293249397, 11301.321920684784, 11341.319520828776, 11353.205275630791, 11361.318320900773, 520101.0, 520220.0, 538677.0, 539770.0, 543535.0, 86335.1366486327, 88913.0, 89785.55107224423, 91411.54294228487, 91998.0, 1034.2760067952463, 1062.85651437055, 1118.9720256993478, 1129.0628778114146, 1131.8698349689726, 17276.913615431844, 17417.0, 17812.862456505303, 17953.371631992817, 18102.094895255446, 37898.242035159696, 38454.0, 39616.0, 39830.2033959325, 39921.60078399179, 54518.7274063643, 55015.44984550263, 55102.17346739722, 55239.0, 55470.16794748001, 9357.204637605608, 9414.340996130206, 9420.105090016437, 9659.178969787647, 9707.320487565803, 12554.246745195318, 13929.303534823015, 14019.649508762363, 14034.29828508591, 14178.929105354408, 12033.157678962389, 12454.0, 12485.500579977062, 12495.37523123822, 12532.0, 12056.276623402624, 12155.81766273489, 12244.571439999558, 12340.382980850742, 12554.0, 12211.0, 12573.371331433209, 12599.496020159091, 12619.305938173122, 12773.425195866022, 9213.0, 9294.674686385944, 9342.53287335644, 9360.0, 9485.383450075724, 9735.756606084904, 11452.599159029394, 12587.24476531411, 12675.619731408073, 12707.745845083231], "value": 9686.485722255768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.5237193168366, 1563.7341651919173, 1577.9605509862251, 1800.4688616858025, 1913.6172765446913, 8162.224588664075, 9006.954965225174, 9235.861462078074, 9244.075592440753, 9273.907260927397, 8997.775055623613, 9165.0, 9179.403338782975, 9183.724488265347, 9216.631334746618, 2488.7884529814987, 2496.775290223884, 2515.069424313007, 2515.2328539795353, 2519.7858182054456, 2355.7997570206467, 2487.0, 2492.501499700058, 2492.5638013347684, 2494.638277449769, 2461.963070553943, 2476.7399423060588, 2547.643329933811, 2548.0572188290266, 2548.7833534149618, 2505.473850491408, 2525.570652988987, 2534.0623969131448, 2546.8599227042505, 2551.0688598661354, 2467.346153269385, 2491.352248415407, 2498.800095992316, 2500.2624225853415, 2578.48430313938, 8941.865872011926, 9165.816683666357, 9294.395864268801, 9303.302252331103, 9312.068793120634, 5662.235598194274, 5732.656040637575, 5785.0, 5791.073428251501, 5797.449242321973, 3794.924101517954, 3899.220155968789, 3914.393269043303, 3917.082917082917, 3962.9009274768073, 1218.9207701499374, 1301.4729034740944, 1319.7162610038888, 1332.4337156708457, 1335.933203339829, 13380.732385352336, 13900.235487048209, 13912.721745565032, 13956.441742330295, 13960.441582336694, 4861.562459378602, 4930.580900623487, 5012.04771093491, 5015.84952451427, 5030.044291584587, 10659.413732244646, 10736.516856741466, 10795.892041079645, 10796.67609971702, 10810.70271567417, 5718.714064296769, 5759.366469688331, 5772.336181339116, 5779.739911703983, 5783.0, 4605.263157894721, 4703.506131856174, 5186.6369354144845, 5245.082110630625, 5336.546393556591, 4347.174036932973, 4392.978035109868, 4494.52807455219, 4511.684182107221, 4539.863804085882, 1418.9496178022864, 1446.5515690136092, 1448.3265281644085, 1450.8911831612672, 1462.9707405852037, 955.0306438964457, 1033.1734612310122, 1054.1303424674675, 1075.876274228458, 1084.978300433987, 6203.596766210272, 6324.9051264231075, 6442.194725659293, 6605.306442823435, 6645.667716614246, 473.3987835449029, 482.5681015491116, 484.16723236033965, 485.14614278868737, 491.47412268872677, 4363.956360436418, 4435.733855968652, 4533.863984080483, 4544.613707834805, 4547.886302842456, 11467.598634047768, 11949.76100478003, 11963.521459141537, 11967.820482692767, 11971.52113915451, 10534.473276336152, 11734.354610496333, 11737.35444550558, 11783.0, 11787.174897757075, 8766.91233087661, 8796.560171991376, 8815.867761983576, 8827.719980602906, 8914.197722205032, 5906.320773110975, 6076.969615151896, 6091.695415229309, 6105.45050945417, 6198.845028874314, 9982.500874956368, 10124.13944814699, 10192.796144077225, 10414.635487757892, 10426.0, 10198.43908585035, 10409.375437473473, 10463.581456741646, 10803.919608039134, 10835.891641083488, 8002.879956800536, 8263.0, 8270.875936860832, 8275.420720549504, 8531.616077276662, 8778.868316975379, 8831.381803273709, 8832.690855820016, 8835.80716603276, 8850.247728943112, 7730.265624765639, 7848.332891704041, 7870.134285228506, 7924.6830126796585, 7929.365650748042, 7731.961340193263, 7745.728899488717, 7870.881936770838, 7877.960610196912, 8027.438079334391, 6819.0794242778575, 6937.236903940663, 7362.6318684066655, 7413.443991700537, 7424.368928641126, 5297.8145764898045, 5345.2249423832545, 5472.945270547243, 5507.063799154073, 5557.5831812613405, 5559.58303127259, 5614.803481878278, 5783.421657834183, 5867.559933004956, 5878.3239927408895], "value": 4872.865731801381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.9214764899371, 379.4156998222737, 381.191873228755, 381.77093743753744, 384.88453463960803, 6215.036669316252, 6342.238931328247, 6408.455281301095, 6419.711112999915, 6431.839204019901, 6324.0, 6344.270408902978, 6352.4918006559365, 6382.872342553146, 6447.194100737408, 4909.48450412706, 4921.458639549646, 4940.629452791037, 4941.45643979162, 4945.530174633404, 4715.599174070191, 4807.807687692488, 4921.154567037361, 4955.0, 4962.900741985158, 4893.755312234392, 4900.558949694527, 4905.558499735023, 4913.729744864031, 4914.705117692932, 4896.975515122437, 4897.926531102036, 4906.411230652309, 4909.214525675875, 4912.38595175603, 4327.956720432787, 4346.521882592912, 4357.455318085239, 4373.737575745466, 4377.233984052778, 6165.691715414211, 6173.135760993465, 6187.87624247517, 6195.504359651217, 6208.906866397007, 5626.9437305626825, 5755.942440575583, 5756.424357564252, 5759.251297331362, 5761.884762304772, 6724.293949135319, 6763.357481039294, 6764.898526522106, 6766.966165169143, 6770.390664840188, 4804.183288840905, 4807.086653535817, 4807.375041244651, 4808.014357056795, 4821.37322148122, 7043.929560704379, 7047.224805271416, 7047.753328633473, 7062.15254169503, 7062.293770622948, 4953.281774142729, 4961.454240033593, 4961.627877909099, 4962.007598480246, 4962.60299176065, 4893.266010098514, 5025.170846810235, 5033.899322013539, 5035.144025515671, 5053.823116190915, 5708.372079071299, 5712.143178523254, 5741.483266506035, 5762.798302059407, 5776.0, 6743.460523158135, 6813.250542440328, 6816.727330906808, 6827.795166145023, 6832.0, 1691.4840973502953, 1747.8776485645883, 1773.184335205794, 1773.3970450047045, 1774.5297496163528, 1195.6054502014315, 1203.1277323940074, 1213.7997230457052, 1221.9816702749465, 1222.437678667805, 6545.345465453416, 6553.967230163818, 6555.246146693096, 6557.213134423804, 6560.573562718408, 6910.861782764317, 6966.5471744336455, 6974.651267436608, 6982.755603553953, 6986.860262794716, 6557.639329836905, 6602.933970660328, 6616.106825578581, 6619.602823830489, 6623.933760662428, 3701.444783282529, 3767.5290588676417, 3767.7550959187565, 3771.510253449927, 3774.037620406779, 7094.148702155671, 7412.740554080689, 7429.8142546436775, 7452.441066919894, 7458.664360103809, 7239.493235473572, 7280.0, 7282.053333066668, 7284.6721897514735, 7296.051513303343, 7404.0, 7409.333160015624, 7409.962950185214, 7419.740309089156, 7422.406207503279, 6811.080504132077, 7033.226345102137, 7084.0, 7084.787456376317, 7097.077379940574, 6900.689468974008, 6959.512834101564, 6972.0, 6994.230634630085, 6995.4753393494675, 7342.926570734225, 7351.191368949519, 7365.373943214887, 7365.52124111931, 7426.480146389701, 4847.321375007431, 4897.9020419592125, 4901.191303434894, 4901.534354236342, 4902.828401005948, 6649.401553860176, 6726.3609957054005, 7055.047568578381, 7058.717651294096, 7079.327463890922, 6848.657567121524, 6858.554193977376, 6860.5540639858245, 6880.4839637026425, 6883.483738719716, 6788.59268443895, 6817.522773405814, 6825.658717064226, 6826.556273842184, 6829.453643708591, 6669.0663307136065, 6699.397054264945, 6700.564463309869, 6703.0, 6708.329167083252, 6639.435647969976, 6884.173899132136, 6892.793216203522, 6905.033295338556, 6909.378155965987, 6685.665716714047, 6706.5640733352175, 6746.797596072126, 6748.089007983859, 6749.662516874038], "value": 5178.993122384302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.5477261369315, 915.9725208243752, 922.963081476741, 924.639390637651, 950.0, 13764.862351376496, 15083.547493575197, 15268.236588170603, 15303.464378746747, 15315.770263446057, 13014.28421436823, 13392.196468211914, 13702.109362891406, 14088.225147616877, 14128.293585320718, 900.2887718702234, 901.2744740483907, 907.4419232172232, 914.8078903430288, 915.2860768600469, 895.8700988356684, 906.3429013964889, 907.541691445819, 907.9228265597433, 912.6303846942, 953.7710949372135, 957.6696039866235, 958.3052287091872, 958.6261358070324, 959.4531117263163, 955.4315182466421, 956.0391806234759, 956.1203692602787, 956.2827879090717, 956.5408603870112, 703.5321511195049, 703.5391818358983, 705.0869124483805, 705.4673721340406, 706.8162277807807, 12976.221426714428, 13026.218426894417, 13027.153235039787, 13030.348482575833, 13036.543720969721, 12816.487340506368, 12917.87082129176, 12919.289439080847, 13038.0, 13054.2820144892, 10968.561257549689, 11127.33236005834, 11146.05258553024, 11178.161637877192, 11354.375509346983, 3933.2920074386884, 4019.8995025124314, 4044.898877528056, 4819.542143496362, 4889.584385327252, 50916.236256456184, 53702.73148634271, 55447.0, 56402.0, 56582.43417565772, 11411.828822567668, 11605.665348485032, 11826.88173118275, 11993.160478766402, 12070.698232544257, 18876.33932812345, 20240.291589794288, 20773.065212065492, 20820.37538873836, 20871.58256834855, 8792.912070879338, 8816.8677469838, 8834.86747698785, 8875.822483550293, 8919.331050171264, 5064.18972964324, 5084.745762711849, 5095.286659867622, 5097.8215762448135, 5202.8959420812125, 3472.2361080562237, 3523.735719821024, 3531.7351198660203, 3533.699635531009, 3536.4695295705337, 654.8821212181758, 660.1154453032959, 660.3231687520234, 661.6989269882192, 664.6178447392768, 723.6092510044517, 775.5269285735696, 810.6190090657382, 826.7933016745814, 844.5186243840951, 9768.755781105387, 9866.0, 9959.701208963743, 9994.800103997879, 10267.281290309757, 667.7213136842988, 771.2056581720836, 772.6098320348301, 813.7762115418308, 831.5218749219223, 4563.771811409416, 4857.854264372075, 4874.829380971649, 4876.073546026244, 4894.877628059327, 67344.32655673381, 67374.66312668503, 67945.66027169832, 68327.65836170787, 68586.31413685899, 58217.4178258212, 59769.10346344808, 60267.39732602706, 61023.0, 61092.38907610867, 53168.0, 53694.46305536973, 54391.0, 54551.0, 54897.176542351895, 9477.296463917985, 9695.215070612596, 9699.224062074876, 9714.368566043184, 9786.41281523111, 32116.35767284688, 35074.82462587671, 39880.401793973695, 39997.0, 41050.79474602608, 51825.0, 52872.47127528829, 53876.46123538871, 54119.188212177636, 54477.45522544882, 13151.802722958972, 13209.867901321248, 13210.80183797263, 13458.25979571133, 13525.932370338085, 14282.42870285177, 14442.133471991714, 14873.851261487247, 15285.235738213267, 15390.84609153894, 13816.240106794223, 14138.646533836736, 14362.0, 14651.487197948021, 14711.190884501455, 12953.0, 13694.178349298676, 13752.174869507462, 14166.858331416553, 14179.432822686977, 13106.803397949228, 13659.317034148055, 14179.64550886236, 14194.361253743813, 14377.0, 11400.600978965696, 11426.371549564521, 11615.012723918562, 12100.394980250776, 12101.515939362327, 11601.941990289995, 11603.419829008348, 11843.763124737628, 11859.169858110195, 11875.703107422383], "value": 7276.8387253159735, "unit": "score"}], "name": "dromaeo_css", "value": 7614.424743039609, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 104.0, 107.0, 108.0, 108.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 161.0, 173.0, 126.0, 148.0, 151.0, 128.0, 183.0, 126.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 165.0, 160.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 175.0, 76.0, 77.0, 75.0, 73.0, 152.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 92.0, 164.0, 93.0, 92.0, 92.0, 155.0, 92.0, 91.0, 156.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 75.0, 53.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0, 61.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 72.0, 73.0, 72.0, 72.0, 73.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 114.0, 111.0, 119.0, 113.0, 111.0, 113.0, 130.0, 132.0], "value": 118.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 158.0, 156.0, 167.0, 164.0, 160.0, 165.0, 164.0, 158.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 65.0, 67.0, 67.0, 66.0, 67.0, 63.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1514.1, "alertThreshold": 2.0}]} 09:00:53 INFO - Return code: 0 09:00:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:00:53 ERROR - # TBPL SUCCESS # 09:00:53 INFO - Running post-action listener: _resource_record_post_action 09:00:53 INFO - Running post-run listener: _resource_record_post_run 09:00:54 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463544320; Read time: 4; Write time: 1576072 09:00:54 INFO - install - Wall time: 15s; CPU: 21.0%; Read bytes: 0; Write bytes: 250318848; Read time: 0; Write time: 1227104 09:00:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 212627456; Read time: 4; Write time: 348864 09:00:54 INFO - Running post-run listener: _upload_blobber_files 09:00:54 INFO - Blob upload gear active. 09:00:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:00:54 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:00:54 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:00:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:55 INFO - (blobuploader) - INFO - Done attempting. 09:00:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:00:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:56 INFO - (blobuploader) - INFO - Done attempting. 09:00:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:56 INFO - Return code: 0 09:00:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a93d2134207082d182a7a85b21f62b9e722b8814b4517eb49ccc2a7b6464b763813bdf3f7195403889aa65429e50342375e2c8e73367a2b9329eacedfbd6134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1aa22e5ff1a3ad68cbaa51888c7f3d401ef55820667f66887e310316876e727a92cde54dc3b53666c204eb00ac05a3f0ee57c18286022df972729bdc2a9b5df1"} 09:00:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:56 INFO - Contents: 09:00:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a93d2134207082d182a7a85b21f62b9e722b8814b4517eb49ccc2a7b6464b763813bdf3f7195403889aa65429e50342375e2c8e73367a2b9329eacedfbd6134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1aa22e5ff1a3ad68cbaa51888c7f3d401ef55820667f66887e310316876e727a92cde54dc3b53666c204eb00ac05a3f0ee57c18286022df972729bdc2a9b5df1"} 09:00:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:56 INFO - Copying logs to upload dir... 09:00:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.960081 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-21 09:00:56.201102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:56.206043) ========= 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=df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a93d2134207082d182a7a85b21f62b9e722b8814b4517eb49ccc2a7b6464b763813bdf3f7195403889aa65429e50342375e2c8e73367a2b9329eacedfbd6134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1aa22e5ff1a3ad68cbaa51888c7f3d401ef55820667f66887e310316876e727a92cde54dc3b53666c204eb00ac05a3f0ee57c18286022df972729bdc2a9b5df1"} build_url:https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a93d2134207082d182a7a85b21f62b9e722b8814b4517eb49ccc2a7b6464b763813bdf3f7195403889aa65429e50342375e2c8e73367a2b9329eacedfbd6134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1aa22e5ff1a3ad68cbaa51888c7f3d401ef55820667f66887e310316876e727a92cde54dc3b53666c204eb00ac05a3f0ee57c18286022df972729bdc2a9b5df1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:56.231926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:56.232255) ========= 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=df17445c3590ff7897617a0e00000225-1466523620.976478-1867492184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:56.315453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 09:00:56.315779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 09:00:56.316125) ========= ========= Total master_lag: 0.18 =========