builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1461753578.24 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.235524) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.235996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.236260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.264377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.264619) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:39:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.8M=0s 2016-04-27 03:39:38 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110293 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.422719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.422984) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015528 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.470019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.470350) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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=03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:39:38,867 truncating revision to first 12 chars 2016-04-27 03:39:38,867 Setting DEBUG logging. 2016-04-27 03:39:38,867 attempt 1/10 2016-04-27 03:39:38,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:39:39,117 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.012811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.013080) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.013435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.013709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.022277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-27 03:39:39.022561) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:39 INFO - MultiFileLogger online at 20160427 03:39:39 in /builds/slave/test 03:39:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:39 INFO - {'append_to_log': False, 03:39:39 INFO - 'base_work_dir': '/builds/slave/test', 03:39:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:39 INFO - 'branch': 'Mozilla-Aurora', 03:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:39 INFO - 'config_files': ('talos/linux_config.py',), 03:39:39 INFO - 'default_actions': ('clobber', 03:39:39 INFO - 'read-buildbot-config', 03:39:39 INFO - 'download-and-extract', 03:39:39 INFO - 'populate-webroot', 03:39:39 INFO - 'create-virtualenv', 03:39:39 INFO - 'install', 03:39:39 INFO - 'run-tests'), 03:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:39 INFO - 'download_minidump_stackwalk': True, 03:39:39 INFO - 'download_symbols': 'ondemand', 03:39:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:39 INFO - 'installer_path': 'installer.exe', 03:39:39 INFO - 'log_level': 'info', 03:39:39 INFO - 'log_name': 'talos', 03:39:39 INFO - 'log_to_console': True, 03:39:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:39 INFO - 'opt_config_files': (), 03:39:39 INFO - 'pip_index': False, 03:39:39 INFO - 'sps_profile': False, 03:39:39 INFO - 'sps_profile_interval': 0, 03:39:39 INFO - 'suite': 'dromaeojs-e10s', 03:39:39 INFO - 'system_bits': '32', 03:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:39 INFO - 'title': 'talos-linux64-ix-047', 03:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:39 INFO - 'use_talos_json': True, 03:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:39 INFO - 'work_dir': 'build'} 03:39:39 INFO - ##### 03:39:39 INFO - ##### Running clobber step. 03:39:39 INFO - ##### 03:39:39 INFO - Running pre-action listener: _resource_record_pre_action 03:39:39 INFO - Running main action method: clobber 03:39:39 INFO - rmtree: /builds/slave/test/build 03:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:40 INFO - Running post-action listener: _resource_record_post_action 03:39:40 INFO - ##### 03:39:40 INFO - ##### Running read-buildbot-config step. 03:39:40 INFO - ##### 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: read_buildbot_config 03:39:40 INFO - Using buildbot properties: 03:39:40 INFO - { 03:39:40 INFO - "project": "", 03:39:40 INFO - "product": "firefox", 03:39:40 INFO - "script_repo_revision": "production", 03:39:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:39:40 INFO - "repository": "", 03:39:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:39:40 INFO - "buildid": "20160425062348", 03:39:40 INFO - "pgo_build": "True", 03:39:40 INFO - "basedir": "/builds/slave/test", 03:39:40 INFO - "buildnumber": 327, 03:39:40 INFO - "slavename": "talos-linux64-ix-047", 03:39:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:39:40 INFO - "platform": "ubuntu64_hw", 03:39:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:40 INFO - "branch": "mozilla-aurora", 03:39:40 INFO - "repo_path": "releases/mozilla-aurora", 03:39:40 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 03:39:40 INFO - "stage_platform": "linux64-pgo", 03:39:40 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 03:39:40 INFO - "slavebuilddir": "test" 03:39:40 INFO - } 03:39:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:39:40 INFO - Running post-action listener: _resource_record_post_action 03:39:40 INFO - ##### 03:39:40 INFO - ##### Running download-and-extract step. 03:39:40 INFO - ##### 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: download_and_extract 03:39:40 INFO - mkdir: /builds/slave/test/build/tests 03:39: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')]} 03:39:40 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:39:46 INFO - Downloaded 1448 bytes. 03:39:46 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:46 INFO - Using the following test package requirements: 03:39:46 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:46 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:46 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:46 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'jsshell-linux-x86_64.zip'], 03:39:46 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:46 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:46 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:46 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:46 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:46 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:46 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:46 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')]} 03:39:46 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:50 INFO - Downloaded 23359918 bytes. 03:39:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:39:52 INFO - Return code: 0 03:39:52 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:39: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')]} 03:39:52 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:22 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip: timed out 03:40:22 INFO - retry: attempt #1 caught exception: timed out 03:40:22 INFO - retry: Failed, sleeping 30 seconds before retrying 03:40:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:40:53 INFO - Downloaded 23359918 bytes. 03:40:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:55 INFO - Return code: 0 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:55 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:55 INFO - Downloaded 10845194 bytes. 03:40:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:40:56 INFO - Return code: 0 03: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')]} 03:40:56 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:40:59 INFO - Downloaded 60835591 bytes. 03:40:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:59 INFO - mkdir: /builds/slave/test/properties 03:40:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:59 INFO - Contents: 03:40:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:41:01 INFO - Running post-action listener: _resource_record_post_action 03:41:01 INFO - Running post-action listener: set_extra_try_arguments 03:41:01 INFO - ##### 03:41:01 INFO - ##### Running populate-webroot step. 03:41:01 INFO - ##### 03:41:01 INFO - Running pre-action listener: _resource_record_pre_action 03:41:01 INFO - Running main action method: populate_webroot 03:41:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:01 INFO - '--tppagecycles', 03:41:01 INFO - '7'], 03:41:01 INFO - 'tests': ['tsvgm']}}, 03:41:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:41:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:41:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'tests': ['damp', 'tps']}, 03:41:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['damp', 'tps']}, 03:41:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:41:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:01 INFO - 'other': {'tests': ['a11yr', 03:41:01 INFO - 'ts_paint', 03:41:01 INFO - 'tpaint', 03:41:01 INFO - 'sessionrestore', 03:41:01 INFO - 'sessionrestore_no_auto_restore', 03:41:01 INFO - 'tabpaint']}, 03:41:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['a11yr', 03:41:01 INFO - 'ts_paint', 03:41:01 INFO - 'tpaint', 03:41:01 INFO - 'sessionrestore', 03:41:01 INFO - 'sessionrestore_no_auto_restore', 03:41:01 INFO - 'tabpaint']}, 03:41:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['a11yr', 03:41:01 INFO - 'ts_paint', 03:41:01 INFO - 'tpaint', 03:41:01 INFO - 'sessionrestore', 03:41:01 INFO - 'sessionrestore_no_auto_restore', 03:41:01 INFO - 'tabpaint']}, 03:41:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['a11yr', 03:41:01 INFO - 'ts_paint', 03:41:01 INFO - 'tpaint', 03:41:01 INFO - 'sessionrestore', 03:41:01 INFO - 'sessionrestore_no_auto_restore', 03:41:01 INFO - 'tabpaint']}, 03:41:01 INFO - 'other_l64': {'tests': ['a11yr', 03:41:01 INFO - 'ts_paint', 03:41:01 INFO - 'tpaint', 03:41:01 INFO - 'sessionrestore', 03:41:01 INFO - 'sessionrestore_no_auto_restore', 03:41:01 INFO - 'tabpaint']}, 03:41:01 INFO - 'other_nol64': {'tests': ['a11yr', 03:41:01 INFO - 'ts_paint', 03:41:01 INFO - 'tpaint', 03:41:01 INFO - 'sessionrestore', 03:41:01 INFO - 'sessionrestore_no_auto_restore', 03:41:01 INFO - 'tabpaint']}, 03:41:01 INFO - 'svgr': {'tests': ['tsvgx', 03:41:01 INFO - 'tsvgr_opacity', 03:41:01 INFO - 'tart', 03:41:01 INFO - 'tscrollx', 03:41:01 INFO - 'cart']}, 03:41:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['tsvgx', 03:41:01 INFO - 'tsvgr_opacity', 03:41:01 INFO - 'tart', 03:41:01 INFO - 'tscrollx', 03:41:01 INFO - 'cart']}, 03:41:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'tests': ['tp5o']}, 03:41:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'talos_options': ['--e10s'], 03:41:01 INFO - 'tests': ['tp5o']}, 03:41:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'talos_options': ['--xperf_path', 03:41:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:01 INFO - 'tests': ['tp5n']}, 03:41:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:01 INFO - 'talos_options': ['--e10s', 03:41:01 INFO - '--xperf_path', 03:41:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:01 INFO - 'tests': ['tp5n']}}, 03:41:01 INFO - 'talos.zip': {'path': '', 03:41:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:01 INFO - Running post-action listener: _resource_record_post_action 03:41:01 INFO - ##### 03:41:01 INFO - ##### Running create-virtualenv step. 03:41:01 INFO - ##### 03:41:01 INFO - Running pre-action listener: _resource_record_pre_action 03:41:01 INFO - Running main action method: create_virtualenv 03:41:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:01 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 03:41:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:01 INFO - Using real prefix '/usr' 03:41:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:03 INFO - Installing pip.................done. 03:41:03 INFO - Return code: 0 03:41:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:03 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:03 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 03:41:03 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 03:41:03 INFO - Using env: {'DISPLAY': ':0', 03:41:03 INFO - 'HOME': '/home/cltbld', 03:41:03 INFO - 'LANG': 'en_US.UTF-8', 03:41:03 INFO - 'LANGUAGE': 'en_US:en', 03:41:03 INFO - 'LOGNAME': 'cltbld', 03:41:03 INFO - 'MAIL': '/var/mail/cltbld', 03:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:03 INFO - 'MOZ_NO_REMOTE': '1', 03:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:03 INFO - 'NO_EM_RESTART': '1', 03:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:03 INFO - 'PWD': '/builds/slave/test', 03:41:03 INFO - 'SHELL': '/bin/bash', 03:41:03 INFO - 'SHLVL': '1', 03:41:03 INFO - 'TERM': 'linux', 03:41:03 INFO - 'TMOUT': '86400', 03:41:03 INFO - 'USER': 'cltbld', 03:41:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:03 INFO - '_': '/tools/buildbot/bin/python'} 03:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:03 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 03:41:03 INFO - Cleaning up... 03:41:03 INFO - Return code: 0 03:41:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:03 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:03 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 03:41:03 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 03:41:03 INFO - Using env: {'DISPLAY': ':0', 03:41:03 INFO - 'HOME': '/home/cltbld', 03:41:03 INFO - 'LANG': 'en_US.UTF-8', 03:41:03 INFO - 'LANGUAGE': 'en_US:en', 03:41:03 INFO - 'LOGNAME': 'cltbld', 03:41:03 INFO - 'MAIL': '/var/mail/cltbld', 03:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:03 INFO - 'MOZ_NO_REMOTE': '1', 03:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:03 INFO - 'NO_EM_RESTART': '1', 03:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:03 INFO - 'PWD': '/builds/slave/test', 03:41:03 INFO - 'SHELL': '/bin/bash', 03:41:03 INFO - 'SHLVL': '1', 03:41:03 INFO - 'TERM': 'linux', 03:41:03 INFO - 'TMOUT': '86400', 03:41:03 INFO - 'USER': 'cltbld', 03:41:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:03 INFO - '_': '/tools/buildbot/bin/python'} 03:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:04 INFO - Downloading/unpacking psutil>=0.7.1 03:41:04 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 03:41:04 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 03:41:04 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 03:41:04 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 03:41:04 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 03:41:04 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 03:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:06 INFO - Installing collected packages: psutil 03:41:06 INFO - Running setup.py install for psutil 03:41:06 INFO - building 'psutil._psutil_linux' extension 03:41:06 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 03:41:06 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 03:41:06 INFO - building 'psutil._psutil_posix' extension 03:41:06 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 03:41:06 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 03:41:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:06 INFO - Successfully installed psutil 03:41:06 INFO - Cleaning up... 03:41:06 INFO - Return code: 0 03:41:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:06 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:06 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 03:41:06 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 03:41:06 INFO - Using env: {'DISPLAY': ':0', 03:41:06 INFO - 'HOME': '/home/cltbld', 03:41:06 INFO - 'LANG': 'en_US.UTF-8', 03:41:06 INFO - 'LANGUAGE': 'en_US:en', 03:41:06 INFO - 'LOGNAME': 'cltbld', 03:41:06 INFO - 'MAIL': '/var/mail/cltbld', 03:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:06 INFO - 'MOZ_NO_REMOTE': '1', 03:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:06 INFO - 'NO_EM_RESTART': '1', 03:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:06 INFO - 'PWD': '/builds/slave/test', 03:41:06 INFO - 'SHELL': '/bin/bash', 03:41:06 INFO - 'SHLVL': '1', 03:41:06 INFO - 'TERM': 'linux', 03:41:06 INFO - 'TMOUT': '86400', 03:41:06 INFO - 'USER': 'cltbld', 03:41:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:06 INFO - '_': '/tools/buildbot/bin/python'} 03:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:41:06 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 03:41:06 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 03:41:06 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 03:41:06 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 03:41:06 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 03:41:06 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 03:41:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:41:08 INFO - Installing collected packages: mozsystemmonitor 03:41:08 INFO - Running setup.py install for mozsystemmonitor 03:41:08 INFO - Successfully installed mozsystemmonitor 03:41:08 INFO - Cleaning up... 03:41:09 INFO - Return code: 0 03:41:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:09 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')]} 03:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:09 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')]} 03:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:09 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:09 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 03:41:09 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 03:41:09 INFO - Using env: {'DISPLAY': ':0', 03:41:09 INFO - 'HOME': '/home/cltbld', 03:41:09 INFO - 'LANG': 'en_US.UTF-8', 03:41:09 INFO - 'LANGUAGE': 'en_US:en', 03:41:09 INFO - 'LOGNAME': 'cltbld', 03:41:09 INFO - 'MAIL': '/var/mail/cltbld', 03:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:09 INFO - 'MOZ_NO_REMOTE': '1', 03:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:09 INFO - 'NO_EM_RESTART': '1', 03:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:09 INFO - 'PWD': '/builds/slave/test', 03:41:09 INFO - 'SHELL': '/bin/bash', 03:41:09 INFO - 'SHLVL': '1', 03:41:09 INFO - 'TERM': 'linux', 03:41:09 INFO - 'TMOUT': '86400', 03:41:09 INFO - 'USER': 'cltbld', 03:41:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:09 INFO - '_': '/tools/buildbot/bin/python'} 03:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:09 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 03:41:09 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 03:41:09 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 03:41:09 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 03:41:09 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 03:41:09 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 03:41:11 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 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 03:41:11 INFO - Downloading docopt-0.6.1.tar.gz 03:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:11 INFO - Running setup.py install for blobuploader 03:41:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:11 INFO - Running setup.py install for requests 03:41:12 INFO - Running setup.py install for docopt 03:41:12 INFO - Successfully installed blobuploader requests docopt 03:41:12 INFO - Cleaning up... 03:41:12 INFO - Return code: 0 03:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:12 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:12 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 03:41:12 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 03:41:12 INFO - Using env: {'DISPLAY': ':0', 03:41:12 INFO - 'HOME': '/home/cltbld', 03:41:12 INFO - 'LANG': 'en_US.UTF-8', 03:41:12 INFO - 'LANGUAGE': 'en_US:en', 03:41:12 INFO - 'LOGNAME': 'cltbld', 03:41:12 INFO - 'MAIL': '/var/mail/cltbld', 03:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:12 INFO - 'MOZ_NO_REMOTE': '1', 03:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:12 INFO - 'NO_EM_RESTART': '1', 03:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:12 INFO - 'PWD': '/builds/slave/test', 03:41:12 INFO - 'SHELL': '/bin/bash', 03:41:12 INFO - 'SHLVL': '1', 03:41:12 INFO - 'TERM': 'linux', 03:41:12 INFO - 'TMOUT': '86400', 03:41:12 INFO - 'USER': 'cltbld', 03:41:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:12 INFO - '_': '/tools/buildbot/bin/python'} 03:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:12 INFO - Running setup.py (path:/tmp/pip-x4qesp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:12 INFO - Running setup.py (path:/tmp/pip-1LGRsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:12 INFO - Running setup.py (path:/tmp/pip-W542J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:12 INFO - Running setup.py (path:/tmp/pip-29T3PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:12 INFO - Running setup.py (path:/tmp/pip-XyHL6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:13 INFO - Running setup.py (path:/tmp/pip-FxOFaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:13 INFO - Running setup.py (path:/tmp/pip-UPw3CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:13 INFO - Running setup.py (path:/tmp/pip-i47uXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:13 INFO - Running setup.py (path:/tmp/pip-YzCfez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:13 INFO - Running setup.py (path:/tmp/pip-LFZ_pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:13 INFO - Running setup.py (path:/tmp/pip-NBo3iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:13 INFO - Running setup.py (path:/tmp/pip-4SVf73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:13 INFO - Running setup.py (path:/tmp/pip-WVvoHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:13 INFO - Running setup.py (path:/tmp/pip-3jyfuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:13 INFO - Running setup.py (path:/tmp/pip-7tT_au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:13 INFO - Running setup.py (path:/tmp/pip-yb58vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:13 INFO - Running setup.py (path:/tmp/pip-IY936Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:13 INFO - Running setup.py install for manifestparser 03:41:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Running setup.py install for mozcrash 03:41:14 INFO - Running setup.py install for mozdebug 03:41:14 INFO - Running setup.py install for mozdevice 03:41:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Running setup.py install for mozfile 03:41:14 INFO - Running setup.py install for mozhttpd 03:41:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Running setup.py install for mozinfo 03:41:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Running setup.py install for mozInstall 03:41:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Running setup.py install for mozleak 03:41:14 INFO - Running setup.py install for mozlog 03:41:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:14 INFO - Running setup.py install for moznetwork 03:41:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:15 INFO - Running setup.py install for mozprocess 03:41:15 INFO - Running setup.py install for mozprofile 03:41:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:15 INFO - Running setup.py install for mozrunner 03:41:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:15 INFO - Running setup.py install for mozscreenshot 03:41:15 INFO - Running setup.py install for moztest 03:41:15 INFO - Running setup.py install for mozversion 03:41:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:15 INFO - Cleaning up... 03:41:15 INFO - Return code: 0 03:41:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:15 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:15 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 03:41:15 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 03:41:15 INFO - Using env: {'DISPLAY': ':0', 03:41:15 INFO - 'HOME': '/home/cltbld', 03:41:15 INFO - 'LANG': 'en_US.UTF-8', 03:41:15 INFO - 'LANGUAGE': 'en_US:en', 03:41:15 INFO - 'LOGNAME': 'cltbld', 03:41:15 INFO - 'MAIL': '/var/mail/cltbld', 03:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:15 INFO - 'MOZ_NO_REMOTE': '1', 03:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:15 INFO - 'NO_EM_RESTART': '1', 03:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:15 INFO - 'PWD': '/builds/slave/test', 03:41:15 INFO - 'SHELL': '/bin/bash', 03:41:15 INFO - 'SHLVL': '1', 03:41:15 INFO - 'TERM': 'linux', 03:41:15 INFO - 'TMOUT': '86400', 03:41:15 INFO - 'USER': 'cltbld', 03:41:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:15 INFO - '_': '/tools/buildbot/bin/python'} 03:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:15 INFO - Running setup.py (path:/tmp/pip-GfSL4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:16 INFO - Running setup.py (path:/tmp/pip-PYBAUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:16 INFO - Running setup.py (path:/tmp/pip-oGoJWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:16 INFO - Running setup.py (path:/tmp/pip-7k9hbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:16 INFO - Running setup.py (path:/tmp/pip-PkXpOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:16 INFO - Running setup.py (path:/tmp/pip-1tfQH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:16 INFO - Running setup.py (path:/tmp/pip-_nWMlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:16 INFO - Running setup.py (path:/tmp/pip-dvGo2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:16 INFO - Running setup.py (path:/tmp/pip-JnUPzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:16 INFO - Running setup.py (path:/tmp/pip-O33pDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:16 INFO - Running setup.py (path:/tmp/pip-e5okqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:16 INFO - Running setup.py (path:/tmp/pip-89Yl2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:16 INFO - Running setup.py (path:/tmp/pip-bHKcmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:16 INFO - Running setup.py (path:/tmp/pip-Q4gbbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:16 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)) 03:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:16 INFO - Running setup.py (path:/tmp/pip-mFg1dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:17 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)) 03:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:17 INFO - Running setup.py (path:/tmp/pip-XSXyjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:17 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)) 03:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:17 INFO - Running setup.py (path:/tmp/pip-aGIje8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:17 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)) 03:41:17 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)) 03:41:17 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)) 03:41:17 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)) 03:41:17 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)) 03:41:17 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)) 03:41:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:17 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 03:41:17 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 03:41:17 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 03:41:17 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 03:41:17 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 03:41:17 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 03:41:19 INFO - Downloading blessings-1.6.tar.gz 03:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:19 INFO - Installing collected packages: blessings 03:41:19 INFO - Running setup.py install for blessings 03:41:19 INFO - Successfully installed blessings 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:19 INFO - Reading from file tmpfile_stdout 03:41:19 INFO - Current package versions: 03:41:19 INFO - argparse == 1.2.1 03:41:19 INFO - blessings == 1.6 03:41:19 INFO - blobuploader == 1.2.4 03:41:19 INFO - docopt == 0.6.1 03:41:19 INFO - manifestparser == 1.1 03:41:19 INFO - mozInstall == 1.12 03:41:19 INFO - mozcrash == 0.17 03:41:19 INFO - mozdebug == 0.1 03:41:19 INFO - mozdevice == 0.48 03:41:19 INFO - mozfile == 1.2 03:41:19 INFO - mozhttpd == 0.7 03:41:19 INFO - mozinfo == 0.9 03:41:19 INFO - mozleak == 0.1 03:41:19 INFO - mozlog == 3.1 03:41:19 INFO - moznetwork == 0.27 03:41:19 INFO - mozprocess == 0.22 03:41:19 INFO - mozprofile == 0.28 03:41:19 INFO - mozrunner == 6.11 03:41:19 INFO - mozscreenshot == 0.1 03:41:19 INFO - mozsystemmonitor == 0.0 03:41:19 INFO - moztest == 0.7 03:41:19 INFO - mozversion == 1.4 03:41:19 INFO - psutil == 3.1.1 03:41:19 INFO - requests == 1.2.3 03:41:19 INFO - wsgiref == 0.1.2 03:41:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:19 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')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:19 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 03:41:19 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 03:41:19 INFO - Using env: {'DISPLAY': ':0', 03:41:19 INFO - 'HOME': '/home/cltbld', 03:41:19 INFO - 'LANG': 'en_US.UTF-8', 03:41:19 INFO - 'LANGUAGE': 'en_US:en', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MAIL': '/var/mail/cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SHLVL': '1', 03:41:19 INFO - 'TERM': 'linux', 03:41:19 INFO - 'TMOUT': '86400', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - '_': '/tools/buildbot/bin/python'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 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)) 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:19 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')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:19 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 03:41:19 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 03:41:19 INFO - Using env: {'DISPLAY': ':0', 03:41:19 INFO - 'HOME': '/home/cltbld', 03:41:19 INFO - 'LANG': 'en_US.UTF-8', 03:41:19 INFO - 'LANGUAGE': 'en_US:en', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MAIL': '/var/mail/cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SHLVL': '1', 03:41:19 INFO - 'TERM': 'linux', 03:41:19 INFO - 'TMOUT': '86400', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - '_': '/tools/buildbot/bin/python'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Downloading/unpacking jsonschema 03:41:19 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 03:41:19 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 03:41:19 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 03:41:19 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 03:41:19 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 03:41:19 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 03:41:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:21 INFO - Downloading/unpacking functools32 (from jsonschema) 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:22 INFO - warning: no files found matching '*.txt' 03:41:22 INFO - no previously-included directories found matching 'build' 03:41:22 INFO - no previously-included directories found matching 'dist' 03:41:22 INFO - no previously-included directories found matching '.git*' 03:41:22 INFO - Installing collected packages: jsonschema, functools32 03:41:22 INFO - Running setup.py install for functools32 03:41:22 INFO - warning: no files found matching '*.txt' 03:41:22 INFO - no previously-included directories found matching 'build' 03:41:22 INFO - no previously-included directories found matching 'dist' 03:41:22 INFO - no previously-included directories found matching '.git*' 03:41:22 INFO - Successfully installed jsonschema functools32 03:41:22 INFO - Cleaning up... 03:41:22 INFO - Return code: 0 03:41:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:22 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 0x7f40c66eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', '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 03:41:22 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 03:41:22 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 03:41:22 INFO - Using env: {'DISPLAY': ':0', 03:41:22 INFO - 'HOME': '/home/cltbld', 03:41:22 INFO - 'LANG': 'en_US.UTF-8', 03:41:22 INFO - 'LANGUAGE': 'en_US:en', 03:41:22 INFO - 'LOGNAME': 'cltbld', 03:41:22 INFO - 'MAIL': '/var/mail/cltbld', 03:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:22 INFO - 'MOZ_NO_REMOTE': '1', 03:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:22 INFO - 'NO_EM_RESTART': '1', 03:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:22 INFO - 'PWD': '/builds/slave/test', 03:41:22 INFO - 'SHELL': '/bin/bash', 03:41:22 INFO - 'SHLVL': '1', 03:41:22 INFO - 'TERM': 'linux', 03:41:22 INFO - 'TMOUT': '86400', 03:41:22 INFO - 'USER': 'cltbld', 03:41:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:22 INFO - '_': '/tools/buildbot/bin/python'} 03:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:22 INFO - Downloading/unpacking flake8 03:41:22 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 03:41:22 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 03:41:22 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 03:41:22 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 03:41:22 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 03:41:22 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 03:41:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:41:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:41:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:24 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 03:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:41:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:25 INFO - no previously-included directories found matching 'docs/_build' 03:41:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:41:25 INFO - Running setup.py install for pep8 03:41:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:25 INFO - no previously-included directories found matching 'docs/_build' 03:41:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:41:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:41:25 INFO - Cleaning up... 03:41:26 INFO - Return code: 0 03:41:26 INFO - Running post-action listener: _resource_record_post_action 03:41:26 INFO - Running post-action listener: _start_resource_monitoring 03:41:26 INFO - Starting resource monitoring. 03:41:26 INFO - ##### 03:41:26 INFO - ##### Running install step. 03:41:26 INFO - ##### 03:41:26 INFO - Running pre-action listener: _resource_record_pre_action 03:41:26 INFO - Running main action method: install 03:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:26 INFO - Reading from file tmpfile_stdout 03:41:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:26 INFO - Reading from file tmpfile_stdout 03:41:26 INFO - Output received: 03:41:26 INFO - Usage: mozinstall [options] installer 03:41:26 INFO - Options: 03:41:26 INFO - -h, --help show this help message and exit 03:41:26 INFO - -d DEST, --destination=DEST 03:41:26 INFO - Directory to install application into. [default: 03:41:26 INFO - "/builds/slave/test"] 03:41:26 INFO - --app=APP Application being installed. [default: firefox] 03:41:26 INFO - mkdir: /builds/slave/test/build/application 03:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:41 INFO - Reading from file tmpfile_stdout 03:41:41 INFO - Output received: 03:41:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:41 INFO - Running post-action listener: _resource_record_post_action 03:41:41 INFO - ##### 03:41:41 INFO - ##### Running run-tests step. 03:41:41 INFO - ##### 03:41:41 INFO - Running pre-action listener: _resource_record_pre_action 03:41:41 INFO - Running main action method: run_tests 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:41 INFO - Python 2.7.3 03:41:41 INFO - Return code: 0 03:41:41 INFO - grabbing minidump binary from tooltool 03:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:41 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 0x137f160>, '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 0x1380060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13804f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:41 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 03:41:41 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 03:41:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:41 INFO - Return code: 0 03:41:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:41:42 INFO - Return code: 0 03:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:41:42 INFO - Using env: {'DISPLAY': ':0', 03:41:42 INFO - 'HOME': '/home/cltbld', 03:41:42 INFO - 'LANG': 'en_US.UTF-8', 03:41:42 INFO - 'LANGUAGE': 'en_US:en', 03:41:42 INFO - 'LOGNAME': 'cltbld', 03:41:42 INFO - 'MAIL': '/var/mail/cltbld', 03:41:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:42 INFO - 'MOZ_NO_REMOTE': '1', 03:41:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:42 INFO - 'NO_EM_RESTART': '1', 03:41:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:42 INFO - 'PWD': '/builds/slave/test', 03:41:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:42 INFO - 'SHELL': '/bin/bash', 03:41:42 INFO - 'SHLVL': '1', 03:41:42 INFO - 'TERM': 'linux', 03:41:42 INFO - 'TMOUT': '86400', 03:41:42 INFO - 'USER': 'cltbld', 03:41:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826', 03:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:42 INFO - '_': '/tools/buildbot/bin/python'} 03:41:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:41:42 INFO - mozversion application_buildid: 20160425062348 03:41:42 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:41:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:42 INFO - mozversion application_name: Firefox 03:41:42 INFO - mozversion application_remotingname: firefox-dev 03:41:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:42 INFO - mozversion application_vendor: Mozilla 03:41:42 INFO - mozversion application_version: 47.0a2 03:41:42 INFO - mozversion platform_buildid: 20160425062348 03:41:42 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:41:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:42 INFO - mozversion platform_version: 47.0a2 03:41:42 INFO - using testdate: 1461753702 03:41:42 INFO - actual date: 1461753702 03:41:42 INFO - starting webserver on 'localhost:55542' 03:41:42 INFO - SUITE-START | Running 2 tests 03:41:42 INFO - TEST-START | dromaeo_css 03:41:42 INFO - operating with platform_type : linux_ 03:41:42 INFO - Initialising browser for dromaeo_css test... 03:41:42 INFO - TEST-INFO | started process 23252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBHAYux/profile http://localhost:55542/getInfo.html) 03:41:46 INFO - PROCESS | 23252 | 03:41:46 INFO - PROCESS | 23252 | (process:23329): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:41:47 INFO - PROCESS | 23252 | __metrics Screen width/height:1600/1200 03:41:47 INFO - PROCESS | 23252 | colorDepth:24 03:41:47 INFO - PROCESS | 23252 | Browser inner width/height: 1024/697 03:41:47 INFO - PROCESS | 23252 | __metrics 03:41:48 ERROR - PROCESS | 23252 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:41:49 INFO - TEST-INFO | 23252: exit 0 03:41:49 INFO - Browser initialized. 03:41:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:49 INFO - TEST-INFO | started process 23380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBHAYux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:50 INFO - PROCESS | 23380 | 03:41:50 INFO - PROCESS | 23380 | (process:23447): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:42:00 INFO - PROCESS | 23380 | RSS: Main: 151437312 03:42:00 INFO - PROCESS | 23380 | 03:42:50 INFO - PROCESS | 23380 | 1461753770526 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] 03:44:59 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:55542/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55542/tests/dromaeo/cssquery-ext.html) 03:45:00 INFO - PROCESS | 23380 | RSS: Main: 155463680 03:45:00 INFO - PROCESS | 23380 | 03:48:02 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:55542/tests/dromaeo/cssquery-ext.html (next: http://localhost:55542/tests/dromaeo/cssquery-jquery.html) 03:48:02 INFO - PROCESS | 23380 | RSS: Main: 153776128 03:48:02 INFO - PROCESS | 23380 | 03:51:04 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:55542/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55542/tests/dromaeo/cssquery-mootools.html) 03:51:05 INFO - PROCESS | 23380 | RSS: Main: 152997888 03:51:05 INFO - PROCESS | 23380 | 03:54:06 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:55542/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55542/tests/dromaeo/cssquery-prototype.html) 03:54:07 INFO - PROCESS | 23380 | RSS: Main: 152670208 03:54:07 INFO - PROCESS | 23380 | 03:57:09 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:55542/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55542/tests/dromaeo/cssquery-yui.html) 03:57:10 INFO - PROCESS | 23380 | RSS: Main: 154046464 03:57:10 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:55542/tests/dromaeo/cssquery-yui.html (next: http://localhost:55542/tests/dromaeo/cssquery-dojo.html) 04:00:12 INFO - PROCESS | 23380 | RSS: Main: 155238400 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | __start_tp_report 04:00:12 INFO - PROCESS | 23380 | _x_x_mozilla_page_load 04:00:12 INFO - PROCESS | 23380 | _x_x_mozilla_page_load_details 04:00:12 INFO - PROCESS | 23380 | |i|pagename|runs| 04:00:12 INFO - PROCESS | 23380 | |0;dojo.html;3303.223742420531;3413.590369155702;3430.845611947462;3457.2394073303863;3467.3758723429787;5580.748866301016;5619.6066275360745;5622.437756224375;5638.746256418461;5666.0650992586225;5594.272744543214;5638.774449022045;5682.659040457575;5684.062129748597;5684.2326285951385;5102.413222479407;5184.403793563732;5193.818216362428;5225.738713064351;5227.242049902762;5081.771320290596;5197.376314842224;5273.2617433559335;5276.34045744282;5276.683398996053;5110.616703747215;5135.8202462913805;5153.69077855328;5244.265802787613;5264.789408423659;5132.923006154892;5156.484351564833;5186.092433824104;5199.714015729133;5224.294720212761;4657.604103651193;5029.245613158056;5070.797168113271;5173.249878767595;5192.532672059495;5386.865328366783;5400.486953739389;5423.430539793304;5429.212764149216;5448.645838020516;5995.010823214208;6049.667268300242;6054;6055.091736239555;6062.060380640964;6063.9090413643835;6117.2184870185665;6132.172156758825;6133.67681124688;6142.2839182294965;5705.2012718219485;5721.6853073080965;5758.992176369161;5760.567957403212;5763.567732420085;6071.392860713893;6131.560175786049;6292.748290068437;6297.181366422427;6308.085327627468;6004.519638428916;6011.609245399035;6024.246969128859;6064.575479716465;6092.969535152296;6105.816825495153;6113.541484388688;6119.296280927751;6137.60105593135;6150.876982460415;5907.320658124285;6085.939140608626;6101.786437474667;6107.480864126599;6133.110698948717;5976.073708575178;6045.123457098696;6045.969770151209;6058.515318774487;6058.636481811105;4565.155446242456;4579.564941330568;4581.541845815392;4601.378813860086;4601.976990115028;4029.899252518652;4043.4945631796027;4103.835846566104;4114.855980040744;4173.144505376391;5575.665460072409;5718.942810571924;5736.541076713853;5799.942000580025;5816.854578635568;6140.846478837975;6177.69111544421;6180.072989051679;6201.906971395432;6202.534809889276;5593.440655934455;5753.539716822728;5832.270966129234;5845.1232315153065;5869.853253668607;5182.5594824439595;5261.736913154327;5277.155655095243;5280.392754833167;5301.655392399482;6278.183836101278;6314.652694101776;6338;6345.04824276353;6358.650274234961;5953.553483488842;6074.605150665193;6138.109974053827;6160.722767475385;6164.106204600397;6280.214973128359;6280.685965701605;6309.242890853127;6309.589876658002;6317.241930968129;5810.244668193108;6020.488258498077;6027.517798576016;6048;6048.304444988883;6112.442689633966;6183.3816618337805;6222.751089956351;6229.314775374796;6238.532110091852;5917.940820591911;5937;5960.4635582797755;5963.0459126539545;5969.104634304889;5844.590878638624;5898.085796701518;5951.91072133927;5964.314103877936;5973.313068997121;5788.0739081746715;5830.47525722687;5831.300243970751;5855.707214639337;5881.353051164454;5984.102384642339;5994.160817485468;6011.7595296187665;6041.848953776191;6052.66710330936;5715.942840571707;5752.942470575408;5819.5344372450945;5915.378885217162;5915.40845915405 04:00:12 INFO - PROCESS | 23380 | |1;ext.html;544.278551324349;569.4732372555391;572.8968785618592;574.6293640601812;591.7810410148246;37268.44097338539;37942;38012.61987380125;38091;38173.23653526928;39628.40557391642;40002.399964000564;40029;40087.19825603486;40160.39759403611;8665.653373865038;8933.776655583597;8934;8955.641774329019;8959.955200223989;8777.078406767294;8877.46735195887;8899.466032038099;8919.10808919106;8943.284537237005;8921.55392230389;8967.372283940127;8987;8987.325950553703;8992.100789920989;8814.382993190447;8909.554522273893;8917.464952102895;8919.821603567958;8941.016488186295;8716.956415217946;8919.509426981513;8919.777005574848;8925.687600934001;8936.240419564345;37399;39895.20209595792;40199.397009044886;40261.59738402608;40281;3627.3108109459117;3854.2484215577692;3933.3116704576582;3957.426173204869;3997.160596274786;28544;28671.13986580406;28720.563971801326;28840.855795721098;28998.13005609835;3675.1547144156993;3688.7786732796117;3721.441783732435;3803.5245594300713;3808.638179372955;185193;185874;185920.99999999866;186599;186810;46055;46299;46352;60154.398456015755;61230;47124.76437617859;47154.764226178646;47430.5256947433;47437.525624744;47625.76187119042;16580.75128873068;16838;16864.831351686327;16898.915505422396;16915.40796072156;12991.350432478339;13276;13284.73430531384;13301.26843023643;13361.599152025261;15629.06225626466;15695.764563531557;15829.417058294079;15839.208039597974;15839.287232074585;6056.697165141725;6118.20463339763;6230.096635987757;6274.090256912813;6307.653079080603;1050.464263225745;1073.7530368015243;1121.9214654974073;1143.0455569599312;1163.3543383422113;29056.85471572671;29699.10902672923;29999;30464.238394040327;30550.388992220032;1152.9769404611861;1159.7390587118;1180.0677464802882;1263.1536870296923;1302.990182608486;15699.822513311547;15700.136492492795;15706.293216805272;15873.2063396832;15925.920370398306;309323;310160;311024;312625;313561;56431.71784141053;56712.86574268574;56987.430125699044;57013.42986570164;57117.42882571121;1448.449589156114;1462.7367073926796;1483;1485.613740427475;1486.0860570749128;28402.715972840007;29135.85432072826;29294.414111718073;30231.69768302377;30279.545806813356;44341.55658443374;44400.33399498946;44415.333769994126;44452.777736111115;44471.33293000672;296998;299538;300689;302073;303147;35214.47178292379;35435.82282088573;35491.29017419689;35685.46471802977;35800;46798;47092.7645361771;47619.523804762895;47633.76183119201;47895.760521198565;40235;40387.596124039555;40416.59583404128;41185.58814411937;41447.171056579304;38164.236715266095;39461.2107757849;39900.20199595934;40653.593464066165;40782.38826417547;36081.819590901876;39898.40152397658;40323.79838100791;44862.3270650934;46011.079778404914;39170.2165956685;39304.80347598244;41880;43266.783666081465;43382.56617433785;25011.499770004863;25207.326621087486;25460.108896188543;25476.872615636803;25545.872270638527 04:00:12 INFO - PROCESS | 23380 | |2;jquery.html;374.1114852225965;381.3307645082879;382.41872354021876;390.33058305006915;392.98231579578913;17929.103544822756;18750.156242969064;18763.249470021183;19353.22587096518;19570.11934462949;17353.566160845985;18235.452936411897;18638.53403664909;18766.906165469154;18784.906075469637;5278.99999999999;5393.865153371158;5397.946020539784;5410.675359478444;5413.729313534327;5381.246625472437;5606;5615.634983726045;5618.15727640853;5644.379118296984;5465.344158700961;5558.749856256478;5566.805161819337;5835.970820145914;5845.181674565543;5837.532997360201;5843.912341314884;5868.677222752747;5876.1479585459865;5884.911726324109;5218.8695282617855;5439.292891924025;5441.564674826044;5700.458456446672;5701;21411.35765927025;22052.448688782748;22104.778952210432;22333.55332893333;22457.887710561507;2325.3024092772102;2459.446624509489;2465.29739024379;2730.6723193216744;2973.4201830643033;9544;9654.179394751454;9786.266030047704;9836.754081147958;10043.129701063186;1810.4297146398974;1864.1797609051973;1889.23485988175;1896.9715454268196;1920.4334721257262;64677.67661161711;64741.35258647447;65047.3495265046;65216.673916630585;68025.65987170082;10549.578016879239;10647.094996925192;10798.94600527008;10894.509747061402;10933.507992140372;15354.309056092503;15422.228888555528;15519.767203491956;15534.378624855106;15552.066875987251;7826.804329891798;7966.920330796618;8017.959910200529;8031.678732850737;8175.223353781381;7589.392848572101;7669.693212271447;7688.269614386624;7733.535987840747;7764.456488045783;4379.627731642782;4587.908241835212;4742;4776.068666610047;4834.154023045953;1930.6621341265222;1962.2837664252731;2005.1578337098454;2058.9485262868247;2105.515731381791;987.4420952162005;992.1071036067597;1089.330062011857;1109.672646569248;1111.7776444710928;16681.666366672598;16683.332666693197;16805.91597042007;17257.827421725622;17487.213075411637;997.2371136080903;1006.7634105985088;1022.9846552301722;1039.2517387481003;1050.5115121468555;9486.90513094874;9806.901930980599;9809.215262779104;9931.553080111413;10134.645287415053;398994;404269;408829;410654;417705;76011.23988760042;76041.23958760452;76606;77607.61196194096;78176;1043.2540733375672;1052.4264275969615;1064.499685147979;1067.2795862792584;1078.1267173589417;14956;15011.174385408907;15174.620634484227;15212.087274763107;15261.313240904408;32898.5065224017;32931.34137317288;33198.33603327968;33604.32791344208;34424.82787586046;44578.55421445744;45857.77071114623;47352.52647473481;47471.287930681756;48130.27804583004;8546.35902307317;8657.177568131017;8712.607932642919;8960.507172105597;9024.954875225845;9716.9028309716;12282.219078233786;13101.868981310065;13121.278329691959;13155.210687358789;11217.943910280397;11543.4805433754;11603.12976526747;11767.411629418324;11795.469203885674;11433.714157146138;11555.422228888354;11639.41802909868;11888.702782430508;12255.75488490243;11551;11713.297202167556;11730.648080557597;11857.229280096766;12024.819627705767;8882.511461869659;8938.4190027648;8971.32715046361;9011.369204155646;9240.491772952551;10445.268831181744;10604.681859544226;11610.361430121424;11620.535178592761;11770.470328835052 04:00:12 INFO - PROCESS | 23380 | |3;mootools.html;1586.7857839191709;1612.709712251795;1862.2271757220747;1892.470108369657;1934.139308007936;7669.846603067949;7783.41624378171;8393;8667.133286671338;8689.956550217248;8010.239027292412;8287.046989596198;8368.079511253758;8601.09688482708;8679.392442529026;2430.708315002202;2432.3554258121567;2445.58425067738;2456.9508609827794;2476.1333533263305;2447.112635791883;2497.725250222474;2515.4466017476216;2524.066095544642;2527.1028784781415;2385.153270588942;2389.151851092863;2437.622168563875;2451.399407145252;2452.399162205262;2443.8044956403533;2457.0294733580313;2460.6063029915217;2479.5412848623064;2483.2922617054055;2506.348349429143;2513.472170844125;2527.19129878439;2533.0880882882147;2533.3413312538687;8550.358723095793;8587.61355738987;8602.612882420306;8641.092685268019;8676.739697809076;5215.973920130413;5306.09796334624;5334.306540149794;5337.546308563777;5341.919871201935;3293.9835300823584;3307.2889328794186;3332.683395077464;3353.2958078803235;3371.342588195303;1060.194252368198;1081.5349399758102;1086.1365214654368;1090.0353187429102;1105.4914739219887;11825.940870295593;11903.464344104535;11946.820797688042;11951.701207469796;11961.700957476045;4500.4149460569915;4503.437070366204;4507.188706032945;4536.274196128604;4572.634189264851;9555.283353748497;9581.425114493153;9599.856002159973;9622.615095396106;9626.66306679277;5233.450487698737;5251.396089449686;5259.474052594786;5268.446813084647;5269.604779641542;4204.348326009474;4751.382320298409;4772.737499437495;4823.397075365579;4838.564529192389;3688.243909998444;3724.3110024645525;3754.6433088856515;3802.144517483544;3817.4464702617965;1129.3393364881472;1135.5628083188033;1138.783631110103;1149.0922171484433;1151.5508951508918;1155.7630685709578;1164.6273192578294;1169;1216.039328930153;1274.4456161569747;7698.692052317957;7726.497777644435;7778.961105194438;8009.879851802228;8160.3471722262075;1225.3444407242082;1235.4193529041336;1235.4502246500222;1243.4031664800946;1246.7818131826893;6256.530760192913;6354.586951848208;6355.523335749837;6439.710213040425;6442.806715798533;10321.74195645115;10736.30214036085;10737.731556710989;10777.78444431107;10782.299150555189;10233.334833235816;10420.114290285259;10486.685399438029;10552.47237638115;10554.947225263824;8101.068377136587;8118.797030074295;8149.877751833727;8166.7958301042945;8181.590920453954;7311.561306321638;7342.6695798688115;7609.581473019037;7916.4062695299235;7945.443818932619;9160.175584197454;9215.44707317563;9280.535973201448;9316.20812230968;9453.621855125717;9084.273258139465;9174;9289.67486138009;9639.277054220822;9760.951195243979;6781.762638307636;7261.346478816932;7490.101187857274;7515.549067055776;7650.617469126632;8089.757307280791;8128.227818357246;8137.552434616153;8142.4300298978505;8160;7219;7501.699932002659;7531.096268447603;7560.470767046474;7575.053118360205;7328.3404493595835;7472.178060413459;7508.662110205163;7508.962455187689;7524.736634217776;7550.056242969629;7572.507786993828;7586.165521792709;7613.581253030915;7617.085949686073;6917.377436030782;6935.826604334932;6960.095187625779;6961.37347638715;7016.508844381048;6991.825204369931;7002.3697867192195;7013;7017.3684368407085;7051 04:00:12 INFO - PROCESS | 23380 | |4;prototype.html;366.1450513052024;366.8752624107803;369.2448941913786;372.20348454307805;372.7800597647387;6349.841253968653;6356.777512787054;6378.362163783625;6384.5211609129265;6424.325445828191;6348.36516348365;6349.365063493648;6364.459020983222;6371.808845734624;6375.203099612549;4735.715857048571;4817.084753896748;4844.346013288196;4889.9511004889855;4936.629752768547;4872.366592342991;4874.244492103712;4880.8047678092835;4883.096627123976;4894.730789806559;4814.9037019259595;4834.97582512087;4860.4896485869;4872.878178045559;4875.878103047435;4830.2030165022725;4838.419389673227;4873.34209881665;4890.682105663138;4893.902121957576;4237.851675191354;4262.041040765834;4268.786560671985;4275.679324050678;4289.206496798102;5894.823155305347;6089.756409743605;6096.573239873211;6106.114613381079;6108.908366374508;5679.176519404663;5686.459786320293;5689.544836413077;5696.629719068247;5698.772049118031;6694.899576506356;6709.09427227323;6711.127553418073;6730.629815360153;6742.764003259911;4703.929441058387;4711.104890070876;4712.034033023222;4714;4722.905541889178;7011.158660960667;7020.648967551653;7094.858102837966;7099.290070992911;7105.253948335454;4732.550407711262;4803.519648035239;4844.8304309349705;4853.980664060587;4861.562459378673;4870.707757534559;4897.828575999894;4900.558949694545;4907.55831975124;4919.2867034279825;5626.268585083994;5638;5656.660600363992;5660.490555849993;5660.7169641518585;6778.966105169443;6790.830229244309;6811.25076241613;6837.931620683729;6845.14435695538;1720.8623310135158;1741.1903464888887;1746.1007581095746;1747.8376879375328;1748.4404990403202;1093.1637297467444;1138.5275110828914;1143.685486491205;1149.655103468956;1162.215504534436;6514.771982980573;6524.934750652433;6548.148740663779;6560.803175904731;6573.671316434255;6991.93008069923;7015.193252775894;7046.43628509718;7067.469939754539;7118.110236220473;6438.456809560197;6546.607203567801;6610.801675949633;6616.86766264672;6619.569727967667;3783.4892289540558;3843.8078096095082;3847.6921846252235;3851.691864650821;3864.7294689371474;7330.340269375782;7357.742479013209;7381.926180738124;7392.408607311402;7403.51877127985;7275;7306.342429181399;7341.88987165193;7345.449091318173;7347.632618369167;7212.531185472927;7341.743038993716;7371.336579707852;7382.44631652639;7389.445791565654;7087.964560177166;7101.609411482418;7112.35988761014;7115.75094871677;7122.857542849218;7015.158181018311;7019.438444924496;7021;7022.332878376546;7030.4024157945105;7290.088738907637;7319.707211711472;7324.560526368435;7362.815929601588;7401.444891633041;4718.7640617969655;4892.730899800546;4905.705657660552;4909.288153217834;4922.827701030446;7077.752278670428;7082.220955694766;7083.185433675193;7092.6099064551945;7129.714811407693;6810.659467026728;6866;6870.141232345957;6877.105976223059;6877.3810357068105;6866.622335771581;6902.93097069043;6904.689288982108;6908.93091069103;6923.134608173978;6512.6092434454085;6599.703013364314;6636.568623039487;6638.701258443285;6674.566153200027;6835.760748373982;6862.245153033063;6888.345607167311;6896.344847239504;6918.377346038881;6716.731330746716;6722.663866806738;6737.932620673927;6756.358145976124;6757.493188011017 04:00:12 INFO - PROCESS | 23380 | |5;yui.html;732.2311572848507;753.9896538638224;774.570113586959;787.5904529644584;797.3621103117505;13713.862861371383;13798;13835.239061851595;13903.721925561495;13966.231857247847;13148.145370550932;14790.704185916275;15005.099694018367;15011.549653510412;15055.54833355001;911.9042500537447;914.995425022874;923.8706581078654;929.0477260807659;929.1498279074639;935.4854829843592;938.8544775559765;940.8118376324728;941.5715849288591;943.0192599696308;971.2715463402449;973.9172170365528;974.3812678948883;974.9707508774712;977.7848873247874;961.697065424389;964.5514835601444;965.3194497878978;966.5408930757834;967.816114938163;711.7046425733314;714.3963350968423;718.9748358807469;719.6042176802738;719.910011248594;14381.209033503153;14382.496612618508;14418.351174197187;14435.639109022253;14442.855571444255;11981.28112313264;12005.699857503545;12074.721145004636;12144.3320617366;12403.13178077535;10213.591456341737;10245.436500992442;10270.075693187575;10280.588776448933;10291;3032.5906002689794;3084.8611812468494;3193.2176616728816;3195.7443404527817;3390.915227119317;50332.24501632442;50339.999999999636;50814.23778643323;50914.236286455736;51369.229461557734;8644.178803013703;9112.681056163003;9172.954135229282;9402.529873506297;9525.237980961645;17638.91180544089;17736.556586085193;17767.644647106987;17770.200340984688;17777.911110444365;7115.324044215791;7216.530925489931;7301.342879140797;7402.518836275733;7477.439192060618;3780.2250538639514;3794.8671796487542;3803.0682482791894;3885.339492286318;3899.395593682984;3373.4265174920324;3373.595168579737;3389.5932488101585;3399.5070714746716;3405.0976491229844;587.2043381218473;590.0264563470308;599.3976054065636;600.6156060121526;606.9969650151809;724.5037149552574;736.6942718771757;737.9963100184572;739.6264886232418;752.5484709174561;8310.792230194293;8373;8413.747587572383;8429.072801991775;8540.14598540141;597.9671118088547;681.3356976947437;684.1482354468718;713.8322494213855;734.4821900560092;3916.3050124528427;3928.8022671903404;3986.86045988389;4010.5187377514303;4140.399642051946;58474.7076264616;58694.7065264671;58792;59338.10992835111;59749;53123.20315195275;53204.733976330645;53633;53776.19335709968;54346.72826635841;47044.529554704015;47175.52824471711;47886.76056619694;48368;48848;8790.13624412383;8875.911240887508;8926.241269492166;8983;8993.896357761001;35596;35682.10794730153;35703.82148089347;36918;38040.619593803705;40843;44567.77716111398;45717.08565828732;45729.54270457253;46129.30806037845;11912.463939122934;11955.342456164994;12145.939270303592;12155.209911355734;12178.634640960785;11846.170768046499;11879.881201188224;12193.634190974284;13369.598912032654;13581.932090339486;11781.469833857669;11969.222000570284;12029;12047.759044818878;12204.938975305067;11399.943000285277;11456.885431145914;11494.425278736197;11592.88407115918;11737.061035117342;11337.603183888525;11342.829857552308;11611.303321800719;12165.087618428477;12367.505299787908;9814.263930205407;9917.008299170313;10008.84986725185;10318.690439286833;10680.145588353069;10452.268341216346;10728.624498142528;10802.729931751455;10898.509567069343;10958.287711299059 04:00:12 INFO - PROCESS | 23380 | __end_tp_report 04:00:12 INFO - PROCESS | 23380 | __start_cc_report 04:00:12 INFO - PROCESS | 23380 | _x_x_mozilla_cycle_collect,344 04:00:12 INFO - PROCESS | 23380 | __end_cc_report 04:00:12 INFO - PROCESS | 23380 | __startTimestamp1461754812419__endTimestamp 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | ------- Summary: start ------- 04:00:12 INFO - PROCESS | 23380 | Number of tests: 6 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | [#0] dojo.html Cycles:165 Average:5648.38 Median:5855.71 stddev:646.13 (11.0%) stddev-sans-first:621.37 04:00:12 INFO - PROCESS | 23380 | Values: 3303.2 3413.6 3430.8 3457.2 3467.4 5580.7 5619.6 5622.4 5638.7 5666.1 5594.3 5638.8 5682.7 5684.1 5684.2 5102.4 5184.4 5193.8 5225.7 5227.2 5081.8 5197.4 5273.3 5276.3 5276.7 5110.6 5135.8 5153.7 5244.3 5264.8 5132.9 5156.5 5186.1 5199.7 5224.3 4657.6 5029.2 5070.8 5173.2 5192.5 5386.9 5400.5 5423.4 5429.2 5448.6 5995.0 6049.7 6054.0 6055.1 6062.1 6063.9 6117.2 6132.2 6133.7 6142.3 5705.2 5721.7 5759.0 5760.6 5763.6 6071.4 6131.6 6292.7 6297.2 6308.1 6004.5 6011.6 6024.2 6064.6 6093.0 6105.8 6113.5 6119.3 6137.6 6150.9 5907.3 6085.9 6101.8 6107.5 6133.1 5976.1 6045.1 6046.0 6058.5 6058.6 4565.2 4579.6 4581.5 4601.4 4602.0 4029.9 4043.5 4103.8 4114.9 4173.1 5575.7 5718.9 5736.5 5799.9 5816.9 6140.8 6177.7 6180.1 6201.9 6202.5 5593.4 5753.5 5832.3 5845.1 5869.9 5182.6 5261.7 5277.2 5280.4 5301.7 6278.2 6314.7 6338.0 6345.0 6358.7 5953.6 6074.6 6138.1 6160.7 6164.1 6280.2 6280.7 6309.2 6309.6 6317.2 5810.2 6020.5 6027.5 6048.0 6048.3 6112.4 6183.4 6222.8 6229.3 6238.5 5917.9 5937.0 5960.5 5963.0 5969.1 5844.6 5898.1 5951.9 5964.3 5973.3 5788.1 5830.5 5831.3 5855.7 5881.4 5984.1 5994.2 6011.8 6041.8 6052.7 5715.9 5752.9 5819.5 5915.4 5915.4 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | [#1] ext.html Cycles:180 Average:44449.01 Median:39237.51 stddev:70987.19 (180.9%) stddev-sans-first:71109.78 04:00:12 INFO - PROCESS | 23380 | Values: 544.3 569.5 572.9 574.6 591.8 37268.4 37942.0 38012.6 38091.0 38173.2 39628.4 40002.4 40029.0 40087.2 40160.4 8665.7 8933.8 8934.0 8955.6 8960.0 8777.1 8877.5 8899.5 8919.1 8943.3 8921.6 8967.4 8987.0 8987.3 8992.1 8814.4 8909.6 8917.5 8919.8 8941.0 8717.0 8919.5 8919.8 8925.7 8936.2 37399.0 39895.2 40199.4 40261.6 40281.0 3627.3 3854.2 3933.3 3957.4 3997.2 28544.0 28671.1 28720.6 28840.9 28998.1 3675.2 3688.8 3721.4 3803.5 3808.6 185193.0 185874.0 185921.0 186599.0 186810.0 46055.0 46299.0 46352.0 60154.4 61230.0 47124.8 47154.8 47430.5 47437.5 47625.8 16580.8 16838.0 16864.8 16898.9 16915.4 12991.4 13276.0 13284.7 13301.3 13361.6 15629.1 15695.8 15829.4 15839.2 15839.3 6056.7 6118.2 6230.1 6274.1 6307.7 1050.5 1073.8 1121.9 1143.0 1163.4 29056.9 29699.1 29999.0 30464.2 30550.4 1153.0 1159.7 1180.1 1263.2 1303.0 15699.8 15700.1 15706.3 15873.2 15925.9 309323.0 310160.0 311024.0 312625.0 313561.0 56431.7 56712.9 56987.4 57013.4 57117.4 1448.4 1462.7 1483.0 1485.6 1486.1 28402.7 29135.9 29294.4 30231.7 30279.5 44341.6 44400.3 44415.3 44452.8 44471.3 296998.0 299538.0 300689.0 302073.0 303147.0 35214.5 35435.8 35491.3 35685.5 35800.0 46798.0 47092.8 47619.5 47633.8 47895.8 40235.0 40387.6 40416.6 41185.6 41447.2 38164.2 39461.2 39900.2 40653.6 40782.4 36081.8 39898.4 40323.8 44862.3 46011.1 39170.2 39304.8 41880.0 43266.8 43382.6 25011.5 25207.3 25460.1 25476.9 25545.9 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | [#2] jquery.html Cycles:180 Average:25071.88 Median:33401.33 stddev:67033.68 (200.7%) stddev-sans-first:67196.08 04:00:12 INFO - PROCESS | 23380 | Values: 374.1 381.3 382.4 390.3 393.0 17929.1 18750.2 18763.2 19353.2 19570.1 17353.6 18235.5 18638.5 18766.9 18784.9 5279.0 5393.9 5397.9 5410.7 5413.7 5381.2 5606.0 5615.6 5618.2 5644.4 5465.3 5558.7 5566.8 5836.0 5845.2 5837.5 5843.9 5868.7 5876.1 5884.9 5218.9 5439.3 5441.6 5700.5 5701.0 21411.4 22052.4 22104.8 22333.6 22457.9 2325.3 2459.4 2465.3 2730.7 2973.4 9544.0 9654.2 9786.3 9836.8 10043.1 1810.4 1864.2 1889.2 1897.0 1920.4 64677.7 64741.4 65047.3 65216.7 68025.7 10549.6 10647.1 10798.9 10894.5 10933.5 15354.3 15422.2 15519.8 15534.4 15552.1 7826.8 7966.9 8018.0 8031.7 8175.2 7589.4 7669.7 7688.3 7733.5 7764.5 4379.6 4587.9 4742.0 4776.1 4834.2 1930.7 1962.3 2005.2 2058.9 2105.5 987.4 992.1 1089.3 1109.7 1111.8 16681.7 16683.3 16805.9 17257.8 17487.2 997.2 1006.8 1023.0 1039.3 1050.5 9486.9 9806.9 9809.2 9931.6 10134.6 398994.0 404269.0 408829.0 410654.0 417705.0 76011.2 76041.2 76606.0 77607.6 78176.0 1043.3 1052.4 1064.5 1067.3 1078.1 14956.0 15011.2 15174.6 15212.1 15261.3 32898.5 32931.3 33198.3 33604.3 34424.8 44578.6 45857.8 47352.5 47471.3 48130.3 8546.4 8657.2 8712.6 8960.5 9025.0 9716.9 12282.2 13101.9 13121.3 13155.2 11217.9 11543.5 11603.1 11767.4 11795.5 11433.7 11555.4 11639.4 11888.7 12255.8 11551.0 11713.3 11730.6 11857.2 12024.8 8882.5 8938.4 8971.3 9011.4 9240.5 10445.3 10604.7 11610.4 11620.5 11770.5 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | [#3] mootools.html Cycles:180 Average:5949.91 Median:5287.85 stddev:3112.21 (58.9%) stddev-sans-first:3103.66 04:00:12 INFO - PROCESS | 23380 | Values: 1586.8 1612.7 1862.2 1892.5 1934.1 7669.8 7783.4 8393.0 8667.1 8690.0 8010.2 8287.0 8368.1 8601.1 8679.4 2430.7 2432.4 2445.6 2457.0 2476.1 2447.1 2497.7 2515.4 2524.1 2527.1 2385.2 2389.2 2437.6 2451.4 2452.4 2443.8 2457.0 2460.6 2479.5 2483.3 2506.3 2513.5 2527.2 2533.1 2533.3 8550.4 8587.6 8602.6 8641.1 8676.7 5216.0 5306.1 5334.3 5337.5 5341.9 3294.0 3307.3 3332.7 3353.3 3371.3 1060.2 1081.5 1086.1 1090.0 1105.5 11825.9 11903.5 11946.8 11951.7 11961.7 4500.4 4503.4 4507.2 4536.3 4572.6 9555.3 9581.4 9599.9 9622.6 9626.7 5233.5 5251.4 5259.5 5268.4 5269.6 4204.3 4751.4 4772.7 4823.4 4838.6 3688.2 3724.3 3754.6 3802.1 3817.4 1129.3 1135.6 1138.8 1149.1 1151.6 1155.8 1164.6 1169.0 1216.0 1274.4 7698.7 7726.5 7779.0 8009.9 8160.3 1225.3 1235.4 1235.5 1243.4 1246.8 6256.5 6354.6 6355.5 6439.7 6442.8 10321.7 10736.3 10737.7 10777.8 10782.3 10233.3 10420.1 10486.7 10552.5 10554.9 8101.1 8118.8 8149.9 8166.8 8181.6 7311.6 7342.7 7609.6 7916.4 7945.4 9160.2 9215.4 9280.5 9316.2 9453.6 9084.3 9174.0 9289.7 9639.3 9761.0 6781.8 7261.3 7490.1 7515.5 7650.6 8089.8 8128.2 8137.6 8142.4 8160.0 7219.0 7501.7 7531.1 7560.5 7575.1 7328.3 7472.2 7508.7 7509.0 7524.7 7550.1 7572.5 7586.2 7613.6 7617.1 6917.4 6935.8 6960.1 6961.4 7016.5 6991.8 7002.4 7013.0 7017.4 7051.0 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | [#4] prototype.html Cycles:180 Average:5710.60 Median:6475.53 stddev:1732.00 (26.7%) stddev-sans-first:1689.77 04:00:12 INFO - PROCESS | 23380 | Values: 366.1 366.9 369.2 372.2 372.8 6349.8 6356.8 6378.4 6384.5 6424.3 6348.4 6349.4 6364.5 6371.8 6375.2 4735.7 4817.1 4844.3 4890.0 4936.6 4872.4 4874.2 4880.8 4883.1 4894.7 4814.9 4835.0 4860.5 4872.9 4875.9 4830.2 4838.4 4873.3 4890.7 4893.9 4237.9 4262.0 4268.8 4275.7 4289.2 5894.8 6089.8 6096.6 6106.1 6108.9 5679.2 5686.5 5689.5 5696.6 5698.8 6694.9 6709.1 6711.1 6730.6 6742.8 4703.9 4711.1 4712.0 4714.0 4722.9 7011.2 7020.6 7094.9 7099.3 7105.3 4732.6 4803.5 4844.8 4854.0 4861.6 4870.7 4897.8 4900.6 4907.6 4919.3 5626.3 5638.0 5656.7 5660.5 5660.7 6779.0 6790.8 6811.3 6837.9 6845.1 1720.9 1741.2 1746.1 1747.8 1748.4 1093.2 1138.5 1143.7 1149.7 1162.2 6514.8 6524.9 6548.1 6560.8 6573.7 6991.9 7015.2 7046.4 7067.5 7118.1 6438.5 6546.6 6610.8 6616.9 6619.6 3783.5 3843.8 3847.7 3851.7 3864.7 7330.3 7357.7 7381.9 7392.4 7403.5 7275.0 7306.3 7341.9 7345.4 7347.6 7212.5 7341.7 7371.3 7382.4 7389.4 7088.0 7101.6 7112.4 7115.8 7122.9 7015.2 7019.4 7021.0 7022.3 7030.4 7290.1 7319.7 7324.6 7362.8 7401.4 4718.8 4892.7 4905.7 4909.3 4922.8 7077.8 7082.2 7083.2 7092.6 7129.7 6810.7 6866.0 6870.1 6877.1 6877.4 6866.6 6902.9 6904.7 6908.9 6923.1 6512.6 6599.7 6636.6 6638.7 6674.6 6835.8 6862.2 6888.3 6896.3 6918.4 6716.7 6722.7 6737.9 6756.4 6757.5 04:00:12 INFO - PROCESS | 23380 | 04:00:12 INFO - PROCESS | 23380 | [#5] yui.html Cycles:180 Average:14210.52 Median:45723.31 stddev:16493.03 (36.1%) stddev-sans-first:16508.23 04:00:12 INFO - PROCESS | 23380 | Values: 732.2 754.0 774.6 787.6 797.4 13713.9 13798.0 13835.2 13903.7 13966.2 13148.1 14790.7 15005.1 15011.5 15055.5 911.9 915.0 923.9 929.0 929.1 935.5 938.9 940.8 941.6 943.0 971.3 973.9 974.4 975.0 977.8 961.7 964.6 965.3 966.5 967.8 711.7 714.4 719.0 719.6 719.9 14381.2 14382.5 14418.4 14435.6 14442.9 11981.3 12005.7 12074.7 12144.3 12403.1 10213.6 10245.4 10270.1 10280.6 10291.0 3032.6 3084.9 3193.2 3195.7 3390.9 50332.2 50340.0 50814.2 50914.2 51369.2 8644.2 9112.7 9173.0 9402.5 9525.2 17638.9 17736.6 17767.6 17770.2 17777.9 7115.3 7216.5 7301.3 7402.5 7477.4 3780.2 3794.9 3803.1 3885.3 3899.4 3373.4 3373.6 3389.6 3399.5 3405.1 587.2 590.0 599.4 600.6 607.0 724.5 736.7 738.0 739.6 752.5 8310.8 8373.0 8413.7 8429.1 8540.1 598.0 681.3 684.1 713.8 734.5 3916.3 3928.8 3986.9 4010.5 4140.4 58474.7 58694.7 58792.0 59338.1 59749.0 53123.2 53204.7 53633.0 53776.2 54346.7 47044.5 47175.5 47886.8 48368.0 48848.0 8790.1 8875.9 8926.2 8983.0 8993.9 35596.0 35682.1 35703.8 36918.0 38040.6 40843.0 44567.8 45717.1 45729.5 46129.3 11912.5 11955.3 12145.9 12155.2 12178.6 11846.2 11879.9 12193.6 13369.6 13581.9 11781.5 11969.2 12029.0 12047.8 12204.9 11399.9 11456.9 11494.4 11592.9 11737.1 11337.6 11342.8 11611.3 12165.1 12367.5 9814.3 9917.0 10008.8 10318.7 10680.1 10452.3 10728.6 10802.7 10898.5 10958.3 04:00:12 INFO - PROCESS | 23380 | -------- Summary: end -------- 04:00:12 INFO - PROCESS | 23380 | 04:00:13 INFO - TEST-INFO | 23380: exit 0 04:00:13 INFO - TEST-OK | dromaeo_css | took 1110286ms 04:00:13 INFO - TEST-START | kraken 04:00:13 INFO - operating with platform_type : linux_ 04:00:13 INFO - Initialising browser for kraken test... 04:00:13 INFO - TEST-INFO | started process 23622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoeZQ0d/profile http://localhost:55542/getInfo.html) 04:00:16 INFO - PROCESS | 23622 | 04:00:16 INFO - PROCESS | 23622 | (process:23700): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:17 INFO - PROCESS | 23622 | __metrics Screen width/height:1600/1200 04:00:17 INFO - PROCESS | 23622 | colorDepth:24 04:00:17 INFO - PROCESS | 23622 | Browser inner width/height: 1024/697 04:00:17 INFO - PROCESS | 23622 | __metrics 04:00:18 ERROR - PROCESS | 23622 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:00:19 INFO - TEST-INFO | 23622: exit 0 04:00:19 INFO - Browser initialized. 04:00:19 INFO - Running cycle 1/1 for kraken test... 04:00:19 INFO - TEST-INFO | started process 23751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoeZQ0d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:21 INFO - PROCESS | 23751 | 04:00:21 INFO - PROCESS | 23751 | (process:23821): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:31 INFO - PROCESS | 23751 | RSS: Main: 151592960 04:00:31 INFO - PROCESS | 23751 | 04:00:33 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55542/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:34 INFO - PROCESS | 23751 | RSS: Main: 156360704 04:00:34 INFO - PROCESS | 23751 | 04:00:36 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55542/tests/kraken/driver.html?testName=audio-dft) 04:00:37 INFO - PROCESS | 23751 | RSS: Main: 156225536 04:00:37 INFO - PROCESS | 23751 | 04:00:40 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55542/tests/kraken/driver.html?testName=audio-fft) 04:00:40 INFO - PROCESS | 23751 | RSS: Main: 156794880 04:00:40 INFO - PROCESS | 23751 | 04:00:42 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55542/tests/kraken/driver.html?testName=audio-oscillator) 04:00:43 INFO - PROCESS | 23751 | RSS: Main: 156930048 04:00:43 INFO - PROCESS | 23751 | 04:00:45 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55542/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:46 INFO - PROCESS | 23751 | RSS: Main: 156766208 04:00:46 INFO - PROCESS | 23751 | 04:00:49 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55542/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:49 INFO - PROCESS | 23751 | RSS: Main: 156831744 04:00:49 INFO - PROCESS | 23751 | 04:00:53 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55542/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:53 INFO - PROCESS | 23751 | RSS: Main: 153808896 04:00:53 INFO - PROCESS | 23751 | 04:00:56 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55542/tests/kraken/driver.html?testName=json-parse-financial) 04:00:57 INFO - PROCESS | 23751 | RSS: Main: 154550272 04:00:57 INFO - PROCESS | 23751 | 04:00:58 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55542/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:59 INFO - PROCESS | 23751 | RSS: Main: 154574848 04:00:59 INFO - PROCESS | 23751 | 04:01:01 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:01 INFO - PROCESS | 23751 | RSS: Main: 155209728 04:01:01 INFO - PROCESS | 23751 | 04:01:03 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:04 INFO - PROCESS | 23751 | RSS: Main: 155533312 04:01:04 INFO - PROCESS | 23751 | 04:01:06 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:07 INFO - PROCESS | 23751 | RSS: Main: 155672576 04:01:07 INFO - PROCESS | 23751 | 04:01:10 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:10 INFO - PROCESS | 23751 | RSS: Main: 155586560 04:01:10 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | Cycle 1(1): loaded http://localhost:55542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55542/tests/kraken/driver.html?testName=ai-astar) 04:01:12 INFO - PROCESS | 23751 | RSS: Main: 157130752 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | __start_tp_report 04:01:12 INFO - PROCESS | 23751 | _x_x_mozilla_page_load 04:01:12 INFO - PROCESS | 23751 | _x_x_mozilla_page_load_details 04:01:12 INFO - PROCESS | 23751 | |i|pagename|runs| 04:01:12 INFO - PROCESS | 23751 | |0;ai-astar;112;108;112;109;112;124;111;111;113;114 04:01:12 INFO - PROCESS | 23751 | |1;audio-beat-detection;155;126;151;174;129;152;150;128;168;134 04:01:12 INFO - PROCESS | 23751 | |2;audio-dft;169;162;164;165;164;163;162;162;164;164 04:01:12 INFO - PROCESS | 23751 | |3;audio-fft;78;79;77;168;77;72;77;73;161;73 04:01:12 INFO - PROCESS | 23751 | |4;audio-oscillator;93;92;141;94;93;93;147;95;94;147 04:01:12 INFO - PROCESS | 23751 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;118;118 04:01:12 INFO - PROCESS | 23751 | |6;imaging-darkroom;146;146;146;146;147;146;146;148;150;150 04:01:12 INFO - PROCESS | 23751 | |7;imaging-desaturate;95;96;96;97;98;97;96;96;95;96 04:01:12 INFO - PROCESS | 23751 | |8;json-parse-financial;58;63;62;59;63;60;62;65;58;57 04:01:12 INFO - PROCESS | 23751 | |9;json-stringify-tinderbox;65;64;63;65;65;67;65;63;64;64 04:01:12 INFO - PROCESS | 23751 | |10;stanford-crypto-aes;80;79;83;79;78;79;79;78;78;78 04:01:12 INFO - PROCESS | 23751 | |11;stanford-crypto-ccm;116;113;112;112;114;112;123;111;115;129 04:01:12 INFO - PROCESS | 23751 | |12;stanford-crypto-pbkdf2;139;151;149;148;147;145;155;148;147;136 04:01:12 INFO - PROCESS | 23751 | |13;stanford-crypto-sha256-iterative;79;68;69;77;69;74;66;66;65;64 04:01:12 INFO - PROCESS | 23751 | __end_tp_report 04:01:12 INFO - PROCESS | 23751 | __start_cc_report 04:01:12 INFO - PROCESS | 23751 | _x_x_mozilla_cycle_collect,816 04:01:12 INFO - PROCESS | 23751 | __end_cc_report 04:01:12 INFO - PROCESS | 23751 | __startTimestamp1461754872604__endTimestamp 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | ------- Summary: start ------- 04:01:12 INFO - PROCESS | 23751 | Number of tests: 14 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:4.38 (3.9%) stddev-sans-first:4.64 04:01:12 INFO - PROCESS | 23751 | Values: 112.0 108.0 112.0 109.0 112.0 124.0 111.0 111.0 113.0 114.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.50 stddev:16.92 (11.2%) stddev-sans-first:17.68 04:01:12 INFO - PROCESS | 23751 | Values: 155.0 126.0 151.0 174.0 129.0 152.0 150.0 128.0 168.0 134.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.08 (1.3%) stddev-sans-first:1.12 04:01:12 INFO - PROCESS | 23751 | Values: 169.0 162.0 164.0 165.0 164.0 163.0 162.0 162.0 164.0 164.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#3] audio-fft Cycles:10 Average:93.50 Median:77.00 stddev:37.53 (48.7%) stddev-sans-first:39.39 04:01:12 INFO - PROCESS | 23751 | Values: 78.0 79.0 77.0 168.0 77.0 72.0 77.0 73.0 161.0 73.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:24.98 (26.9%) stddev-sans-first:25.82 04:01:12 INFO - PROCESS | 23751 | Values: 93.0 92.0 141.0 94.0 93.0 93.0 147.0 95.0 94.0 147.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:01:12 INFO - PROCESS | 23751 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:146.50 stddev:1.66 (1.1%) stddev-sans-first:1.72 04:01:12 INFO - PROCESS | 23751 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 150.0 150.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 04:01:12 INFO - PROCESS | 23751 | Values: 95.0 96.0 96.0 97.0 98.0 97.0 96.0 96.0 95.0 96.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:62.00 stddev:2.67 (4.3%) stddev-sans-first:2.65 04:01:12 INFO - PROCESS | 23751 | Values: 58.0 63.0 62.0 59.0 63.0 60.0 62.0 65.0 58.0 57.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 04:01:12 INFO - PROCESS | 23751 | Values: 65.0 64.0 63.0 65.0 65.0 67.0 65.0 63.0 64.0 64.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.52 (1.9%) stddev-sans-first:1.58 04:01:12 INFO - PROCESS | 23751 | Values: 80.0 79.0 83.0 79.0 78.0 79.0 79.0 78.0 78.0 78.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:114.50 stddev:5.81 (5.1%) stddev-sans-first:6.16 04:01:12 INFO - PROCESS | 23751 | Values: 116.0 113.0 112.0 112.0 114.0 112.0 123.0 111.0 115.0 129.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:148.00 stddev:5.50 (3.7%) stddev-sans-first:5.12 04:01:12 INFO - PROCESS | 23751 | Values: 139.0 151.0 149.0 148.0 147.0 145.0 155.0 148.0 147.0 136.0 04:01:12 INFO - PROCESS | 23751 | 04:01:12 INFO - PROCESS | 23751 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:5.21 (7.5%) stddev-sans-first:4.30 04:01:12 INFO - PROCESS | 23751 | Values: 79.0 68.0 69.0 77.0 69.0 74.0 66.0 66.0 65.0 64.0 04:01:12 INFO - PROCESS | 23751 | -------- Summary: end -------- 04:01:12 INFO - PROCESS | 23751 | 04:01:13 INFO - TEST-INFO | 23751: exit 0 04:01:13 INFO - TEST-OK | kraken | took 60383ms 04:01:13 INFO - SUITE-END | took 1170s 04:01:13 INFO - Completed test suite (00:19:30) 04:01:13 INFO - javascript benchmark 04:01:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3303.223742420531, 3413.590369155702, 3430.845611947462, 3457.2394073303863, 3467.3758723429787, 5580.748866301016, 5619.6066275360745, 5622.437756224375, 5638.746256418461, 5666.0650992586225, 5594.272744543214, 5638.774449022045, 5682.659040457575, 5684.062129748597, 5684.2326285951385, 5102.413222479407, 5184.403793563732, 5193.818216362428, 5225.738713064351, 5227.242049902762, 5081.771320290596, 5197.376314842224, 5273.2617433559335, 5276.34045744282, 5276.683398996053, 5110.616703747215, 5135.8202462913805, 5153.69077855328, 5244.265802787613, 5264.789408423659, 5132.923006154892, 5156.484351564833, 5186.092433824104, 5199.714015729133, 5224.294720212761, 4657.604103651193, 5029.245613158056, 5070.797168113271, 5173.249878767595, 5192.532672059495, 5386.865328366783, 5400.486953739389, 5423.430539793304, 5429.212764149216, 5448.645838020516, 5995.010823214208, 6049.667268300242, 6054.0, 6055.091736239555, 6062.060380640964, 6063.9090413643835, 6117.2184870185665, 6132.172156758825, 6133.67681124688, 6142.2839182294965, 5705.2012718219485, 5721.6853073080965, 5758.992176369161, 5760.567957403212, 5763.567732420085, 6071.392860713893, 6131.560175786049, 6292.748290068437, 6297.181366422427, 6308.085327627468, 6004.519638428916, 6011.609245399035, 6024.246969128859, 6064.575479716465, 6092.969535152296, 6105.816825495153, 6113.541484388688, 6119.296280927751, 6137.60105593135, 6150.876982460415, 5907.320658124285, 6085.939140608626, 6101.786437474667, 6107.480864126599, 6133.110698948717, 5976.073708575178, 6045.123457098696, 6045.969770151209, 6058.515318774487, 6058.636481811105, 4565.155446242456, 4579.564941330568, 4581.541845815392, 4601.378813860086, 4601.976990115028, 4029.899252518652, 4043.4945631796027, 4103.835846566104, 4114.855980040744, 4173.144505376391, 5575.665460072409, 5718.942810571924, 5736.541076713853, 5799.942000580025, 5816.854578635568, 6140.846478837975, 6177.69111544421, 6180.072989051679, 6201.906971395432, 6202.534809889276, 5593.440655934455, 5753.539716822728, 5832.270966129234, 5845.1232315153065, 5869.853253668607, 5182.5594824439595, 5261.736913154327, 5277.155655095243, 5280.392754833167, 5301.655392399482, 6278.183836101278, 6314.652694101776, 6338.0, 6345.04824276353, 6358.650274234961, 5953.553483488842, 6074.605150665193, 6138.109974053827, 6160.722767475385, 6164.106204600397, 6280.214973128359, 6280.685965701605, 6309.242890853127, 6309.589876658002, 6317.241930968129, 5810.244668193108, 6020.488258498077, 6027.517798576016, 6048.0, 6048.304444988883, 6112.442689633966, 6183.3816618337805, 6222.751089956351, 6229.314775374796, 6238.532110091852, 5917.940820591911, 5937.0, 5960.4635582797755, 5963.0459126539545, 5969.104634304889, 5844.590878638624, 5898.085796701518, 5951.91072133927, 5964.314103877936, 5973.313068997121, 5788.0739081746715, 5830.47525722687, 5831.300243970751, 5855.707214639337, 5881.353051164454, 5984.102384642339, 5994.160817485468, 6011.7595296187665, 6041.848953776191, 6052.66710330936, 5715.942840571707, 5752.942470575408, 5819.5344372450945, 5915.378885217162, 5915.40845915405], "unit": "score", "name": "dojo.html", "value": 5605.435766220282}, {"lowerIsBetter": false, "replicates": [544.278551324349, 569.4732372555391, 572.8968785618592, 574.6293640601812, 591.7810410148246, 37268.44097338539, 37942.0, 38012.61987380125, 38091.0, 38173.23653526928, 39628.40557391642, 40002.399964000564, 40029.0, 40087.19825603486, 40160.39759403611, 8665.653373865038, 8933.776655583597, 8934.0, 8955.641774329019, 8959.955200223989, 8777.078406767294, 8877.46735195887, 8899.466032038099, 8919.10808919106, 8943.284537237005, 8921.55392230389, 8967.372283940127, 8987.0, 8987.325950553703, 8992.100789920989, 8814.382993190447, 8909.554522273893, 8917.464952102895, 8919.821603567958, 8941.016488186295, 8716.956415217946, 8919.509426981513, 8919.777005574848, 8925.687600934001, 8936.240419564345, 37399.0, 39895.20209595792, 40199.397009044886, 40261.59738402608, 40281.0, 3627.3108109459117, 3854.2484215577692, 3933.3116704576582, 3957.426173204869, 3997.160596274786, 28544.0, 28671.13986580406, 28720.563971801326, 28840.855795721098, 28998.13005609835, 3675.1547144156993, 3688.7786732796117, 3721.441783732435, 3803.5245594300713, 3808.638179372955, 185193.0, 185874.0, 185920.99999999866, 186599.0, 186810.0, 46055.0, 46299.0, 46352.0, 60154.398456015755, 61230.0, 47124.76437617859, 47154.764226178646, 47430.5256947433, 47437.525624744, 47625.76187119042, 16580.75128873068, 16838.0, 16864.831351686327, 16898.915505422396, 16915.40796072156, 12991.350432478339, 13276.0, 13284.73430531384, 13301.26843023643, 13361.599152025261, 15629.06225626466, 15695.764563531557, 15829.417058294079, 15839.208039597974, 15839.287232074585, 6056.697165141725, 6118.20463339763, 6230.096635987757, 6274.090256912813, 6307.653079080603, 1050.464263225745, 1073.7530368015243, 1121.9214654974073, 1143.0455569599312, 1163.3543383422113, 29056.85471572671, 29699.10902672923, 29999.0, 30464.238394040327, 30550.388992220032, 1152.9769404611861, 1159.7390587118, 1180.0677464802882, 1263.1536870296923, 1302.990182608486, 15699.822513311547, 15700.136492492795, 15706.293216805272, 15873.2063396832, 15925.920370398306, 309323.0, 310160.0, 311024.0, 312625.0, 313561.0, 56431.71784141053, 56712.86574268574, 56987.430125699044, 57013.42986570164, 57117.42882571121, 1448.449589156114, 1462.7367073926796, 1483.0, 1485.613740427475, 1486.0860570749128, 28402.715972840007, 29135.85432072826, 29294.414111718073, 30231.69768302377, 30279.545806813356, 44341.55658443374, 44400.33399498946, 44415.333769994126, 44452.777736111115, 44471.33293000672, 296998.0, 299538.0, 300689.0, 302073.0, 303147.0, 35214.47178292379, 35435.82282088573, 35491.29017419689, 35685.46471802977, 35800.0, 46798.0, 47092.7645361771, 47619.523804762895, 47633.76183119201, 47895.760521198565, 40235.0, 40387.596124039555, 40416.59583404128, 41185.58814411937, 41447.171056579304, 38164.236715266095, 39461.2107757849, 39900.20199595934, 40653.593464066165, 40782.38826417547, 36081.819590901876, 39898.40152397658, 40323.79838100791, 44862.3270650934, 46011.079778404914, 39170.2165956685, 39304.80347598244, 41880.0, 43266.783666081465, 43382.56617433785, 25011.499770004863, 25207.326621087486, 25460.108896188543, 25476.872615636803, 25545.872270638527], "unit": "score", "name": "ext.html", "value": 18707.070364741518}, {"lowerIsBetter": false, "replicates": [374.1114852225965, 381.3307645082879, 382.41872354021876, 390.33058305006915, 392.98231579578913, 17929.103544822756, 18750.156242969064, 18763.249470021183, 19353.22587096518, 19570.11934462949, 17353.566160845985, 18235.452936411897, 18638.53403664909, 18766.906165469154, 18784.906075469637, 5278.99999999999, 5393.865153371158, 5397.946020539784, 5410.675359478444, 5413.729313534327, 5381.246625472437, 5606.0, 5615.634983726045, 5618.15727640853, 5644.379118296984, 5465.344158700961, 5558.749856256478, 5566.805161819337, 5835.970820145914, 5845.181674565543, 5837.532997360201, 5843.912341314884, 5868.677222752747, 5876.1479585459865, 5884.911726324109, 5218.8695282617855, 5439.292891924025, 5441.564674826044, 5700.458456446672, 5701.0, 21411.35765927025, 22052.448688782748, 22104.778952210432, 22333.55332893333, 22457.887710561507, 2325.3024092772102, 2459.446624509489, 2465.29739024379, 2730.6723193216744, 2973.4201830643033, 9544.0, 9654.179394751454, 9786.266030047704, 9836.754081147958, 10043.129701063186, 1810.4297146398974, 1864.1797609051973, 1889.23485988175, 1896.9715454268196, 1920.4334721257262, 64677.67661161711, 64741.35258647447, 65047.3495265046, 65216.673916630585, 68025.65987170082, 10549.578016879239, 10647.094996925192, 10798.94600527008, 10894.509747061402, 10933.507992140372, 15354.309056092503, 15422.228888555528, 15519.767203491956, 15534.378624855106, 15552.066875987251, 7826.804329891798, 7966.920330796618, 8017.959910200529, 8031.678732850737, 8175.223353781381, 7589.392848572101, 7669.693212271447, 7688.269614386624, 7733.535987840747, 7764.456488045783, 4379.627731642782, 4587.908241835212, 4742.0, 4776.068666610047, 4834.154023045953, 1930.6621341265222, 1962.2837664252731, 2005.1578337098454, 2058.9485262868247, 2105.515731381791, 987.4420952162005, 992.1071036067597, 1089.330062011857, 1109.672646569248, 1111.7776444710928, 16681.666366672598, 16683.332666693197, 16805.91597042007, 17257.827421725622, 17487.213075411637, 997.2371136080903, 1006.7634105985088, 1022.9846552301722, 1039.2517387481003, 1050.5115121468555, 9486.90513094874, 9806.901930980599, 9809.215262779104, 9931.553080111413, 10134.645287415053, 398994.0, 404269.0, 408829.0, 410654.0, 417705.0, 76011.23988760042, 76041.23958760452, 76606.0, 77607.61196194096, 78176.0, 1043.2540733375672, 1052.4264275969615, 1064.499685147979, 1067.2795862792584, 1078.1267173589417, 14956.0, 15011.174385408907, 15174.620634484227, 15212.087274763107, 15261.313240904408, 32898.5065224017, 32931.34137317288, 33198.33603327968, 33604.32791344208, 34424.82787586046, 44578.55421445744, 45857.77071114623, 47352.52647473481, 47471.287930681756, 48130.27804583004, 8546.35902307317, 8657.177568131017, 8712.607932642919, 8960.507172105597, 9024.954875225845, 9716.9028309716, 12282.219078233786, 13101.868981310065, 13121.278329691959, 13155.210687358789, 11217.943910280397, 11543.4805433754, 11603.12976526747, 11767.411629418324, 11795.469203885674, 11433.714157146138, 11555.422228888354, 11639.41802909868, 11888.702782430508, 12255.75488490243, 11551.0, 11713.297202167556, 11730.648080557597, 11857.229280096766, 12024.819627705767, 8882.511461869659, 8938.4190027648, 8971.32715046361, 9011.369204155646, 9240.491772952551, 10445.268831181744, 10604.681859544226, 11610.361430121424, 11620.535178592761, 11770.470328835052], "unit": "score", "name": "jquery.html", "value": 8843.767024318266}, {"lowerIsBetter": false, "replicates": [1586.7857839191709, 1612.709712251795, 1862.2271757220747, 1892.470108369657, 1934.139308007936, 7669.846603067949, 7783.41624378171, 8393.0, 8667.133286671338, 8689.956550217248, 8010.239027292412, 8287.046989596198, 8368.079511253758, 8601.09688482708, 8679.392442529026, 2430.708315002202, 2432.3554258121567, 2445.58425067738, 2456.9508609827794, 2476.1333533263305, 2447.112635791883, 2497.725250222474, 2515.4466017476216, 2524.066095544642, 2527.1028784781415, 2385.153270588942, 2389.151851092863, 2437.622168563875, 2451.399407145252, 2452.399162205262, 2443.8044956403533, 2457.0294733580313, 2460.6063029915217, 2479.5412848623064, 2483.2922617054055, 2506.348349429143, 2513.472170844125, 2527.19129878439, 2533.0880882882147, 2533.3413312538687, 8550.358723095793, 8587.61355738987, 8602.612882420306, 8641.092685268019, 8676.739697809076, 5215.973920130413, 5306.09796334624, 5334.306540149794, 5337.546308563777, 5341.919871201935, 3293.9835300823584, 3307.2889328794186, 3332.683395077464, 3353.2958078803235, 3371.342588195303, 1060.194252368198, 1081.5349399758102, 1086.1365214654368, 1090.0353187429102, 1105.4914739219887, 11825.940870295593, 11903.464344104535, 11946.820797688042, 11951.701207469796, 11961.700957476045, 4500.4149460569915, 4503.437070366204, 4507.188706032945, 4536.274196128604, 4572.634189264851, 9555.283353748497, 9581.425114493153, 9599.856002159973, 9622.615095396106, 9626.66306679277, 5233.450487698737, 5251.396089449686, 5259.474052594786, 5268.446813084647, 5269.604779641542, 4204.348326009474, 4751.382320298409, 4772.737499437495, 4823.397075365579, 4838.564529192389, 3688.243909998444, 3724.3110024645525, 3754.6433088856515, 3802.144517483544, 3817.4464702617965, 1129.3393364881472, 1135.5628083188033, 1138.783631110103, 1149.0922171484433, 1151.5508951508918, 1155.7630685709578, 1164.6273192578294, 1169.0, 1216.039328930153, 1274.4456161569747, 7698.692052317957, 7726.497777644435, 7778.961105194438, 8009.879851802228, 8160.3471722262075, 1225.3444407242082, 1235.4193529041336, 1235.4502246500222, 1243.4031664800946, 1246.7818131826893, 6256.530760192913, 6354.586951848208, 6355.523335749837, 6439.710213040425, 6442.806715798533, 10321.74195645115, 10736.30214036085, 10737.731556710989, 10777.78444431107, 10782.299150555189, 10233.334833235816, 10420.114290285259, 10486.685399438029, 10552.47237638115, 10554.947225263824, 8101.068377136587, 8118.797030074295, 8149.877751833727, 8166.7958301042945, 8181.590920453954, 7311.561306321638, 7342.6695798688115, 7609.581473019037, 7916.4062695299235, 7945.443818932619, 9160.175584197454, 9215.44707317563, 9280.535973201448, 9316.20812230968, 9453.621855125717, 9084.273258139465, 9174.0, 9289.67486138009, 9639.277054220822, 9760.951195243979, 6781.762638307636, 7261.346478816932, 7490.101187857274, 7515.549067055776, 7650.617469126632, 8089.757307280791, 8128.227818357246, 8137.552434616153, 8142.4300298978505, 8160.0, 7219.0, 7501.699932002659, 7531.096268447603, 7560.470767046474, 7575.053118360205, 7328.3404493595835, 7472.178060413459, 7508.662110205163, 7508.962455187689, 7524.736634217776, 7550.056242969629, 7572.507786993828, 7586.165521792709, 7613.581253030915, 7617.085949686073, 6917.377436030782, 6935.826604334932, 6960.095187625779, 6961.37347638715, 7016.508844381048, 6991.825204369931, 7002.3697867192195, 7013.0, 7017.3684368407085, 7051.0], "unit": "score", "name": "mootools.html", "value": 4870.731417161127}, {"lowerIsBetter": false, "replicates": [366.1450513052024, 366.8752624107803, 369.2448941913786, 372.20348454307805, 372.7800597647387, 6349.841253968653, 6356.777512787054, 6378.362163783625, 6384.5211609129265, 6424.325445828191, 6348.36516348365, 6349.365063493648, 6364.459020983222, 6371.808845734624, 6375.203099612549, 4735.715857048571, 4817.084753896748, 4844.346013288196, 4889.9511004889855, 4936.629752768547, 4872.366592342991, 4874.244492103712, 4880.8047678092835, 4883.096627123976, 4894.730789806559, 4814.9037019259595, 4834.97582512087, 4860.4896485869, 4872.878178045559, 4875.878103047435, 4830.2030165022725, 4838.419389673227, 4873.34209881665, 4890.682105663138, 4893.902121957576, 4237.851675191354, 4262.041040765834, 4268.786560671985, 4275.679324050678, 4289.206496798102, 5894.823155305347, 6089.756409743605, 6096.573239873211, 6106.114613381079, 6108.908366374508, 5679.176519404663, 5686.459786320293, 5689.544836413077, 5696.629719068247, 5698.772049118031, 6694.899576506356, 6709.09427227323, 6711.127553418073, 6730.629815360153, 6742.764003259911, 4703.929441058387, 4711.104890070876, 4712.034033023222, 4714.0, 4722.905541889178, 7011.158660960667, 7020.648967551653, 7094.858102837966, 7099.290070992911, 7105.253948335454, 4732.550407711262, 4803.519648035239, 4844.8304309349705, 4853.980664060587, 4861.562459378673, 4870.707757534559, 4897.828575999894, 4900.558949694545, 4907.55831975124, 4919.2867034279825, 5626.268585083994, 5638.0, 5656.660600363992, 5660.490555849993, 5660.7169641518585, 6778.966105169443, 6790.830229244309, 6811.25076241613, 6837.931620683729, 6845.14435695538, 1720.8623310135158, 1741.1903464888887, 1746.1007581095746, 1747.8376879375328, 1748.4404990403202, 1093.1637297467444, 1138.5275110828914, 1143.685486491205, 1149.655103468956, 1162.215504534436, 6514.771982980573, 6524.934750652433, 6548.148740663779, 6560.803175904731, 6573.671316434255, 6991.93008069923, 7015.193252775894, 7046.43628509718, 7067.469939754539, 7118.110236220473, 6438.456809560197, 6546.607203567801, 6610.801675949633, 6616.86766264672, 6619.569727967667, 3783.4892289540558, 3843.8078096095082, 3847.6921846252235, 3851.691864650821, 3864.7294689371474, 7330.340269375782, 7357.742479013209, 7381.926180738124, 7392.408607311402, 7403.51877127985, 7275.0, 7306.342429181399, 7341.88987165193, 7345.449091318173, 7347.632618369167, 7212.531185472927, 7341.743038993716, 7371.336579707852, 7382.44631652639, 7389.445791565654, 7087.964560177166, 7101.609411482418, 7112.35988761014, 7115.75094871677, 7122.857542849218, 7015.158181018311, 7019.438444924496, 7021.0, 7022.332878376546, 7030.4024157945105, 7290.088738907637, 7319.707211711472, 7324.560526368435, 7362.815929601588, 7401.444891633041, 4718.7640617969655, 4892.730899800546, 4905.705657660552, 4909.288153217834, 4922.827701030446, 7077.752278670428, 7082.220955694766, 7083.185433675193, 7092.6099064551945, 7129.714811407693, 6810.659467026728, 6866.0, 6870.141232345957, 6877.105976223059, 6877.3810357068105, 6866.622335771581, 6902.93097069043, 6904.689288982108, 6908.93091069103, 6923.134608173978, 6512.6092434454085, 6599.703013364314, 6636.568623039487, 6638.701258443285, 6674.566153200027, 6835.760748373982, 6862.245153033063, 6888.345607167311, 6896.344847239504, 6918.377346038881, 6716.731330746716, 6722.663866806738, 6737.932620673927, 6756.358145976124, 6757.493188011017], "unit": "score", "name": "prototype.html", "value": 5149.543648938981}, {"lowerIsBetter": false, "replicates": [732.2311572848507, 753.9896538638224, 774.570113586959, 787.5904529644584, 797.3621103117505, 13713.862861371383, 13798.0, 13835.239061851595, 13903.721925561495, 13966.231857247847, 13148.145370550932, 14790.704185916275, 15005.099694018367, 15011.549653510412, 15055.54833355001, 911.9042500537447, 914.995425022874, 923.8706581078654, 929.0477260807659, 929.1498279074639, 935.4854829843592, 938.8544775559765, 940.8118376324728, 941.5715849288591, 943.0192599696308, 971.2715463402449, 973.9172170365528, 974.3812678948883, 974.9707508774712, 977.7848873247874, 961.697065424389, 964.5514835601444, 965.3194497878978, 966.5408930757834, 967.816114938163, 711.7046425733314, 714.3963350968423, 718.9748358807469, 719.6042176802738, 719.910011248594, 14381.209033503153, 14382.496612618508, 14418.351174197187, 14435.639109022253, 14442.855571444255, 11981.28112313264, 12005.699857503545, 12074.721145004636, 12144.3320617366, 12403.13178077535, 10213.591456341737, 10245.436500992442, 10270.075693187575, 10280.588776448933, 10291.0, 3032.5906002689794, 3084.8611812468494, 3193.2176616728816, 3195.7443404527817, 3390.915227119317, 50332.24501632442, 50339.999999999636, 50814.23778643323, 50914.236286455736, 51369.229461557734, 8644.178803013703, 9112.681056163003, 9172.954135229282, 9402.529873506297, 9525.237980961645, 17638.91180544089, 17736.556586085193, 17767.644647106987, 17770.200340984688, 17777.911110444365, 7115.324044215791, 7216.530925489931, 7301.342879140797, 7402.518836275733, 7477.439192060618, 3780.2250538639514, 3794.8671796487542, 3803.0682482791894, 3885.339492286318, 3899.395593682984, 3373.4265174920324, 3373.595168579737, 3389.5932488101585, 3399.5070714746716, 3405.0976491229844, 587.2043381218473, 590.0264563470308, 599.3976054065636, 600.6156060121526, 606.9969650151809, 724.5037149552574, 736.6942718771757, 737.9963100184572, 739.6264886232418, 752.5484709174561, 8310.792230194293, 8373.0, 8413.747587572383, 8429.072801991775, 8540.14598540141, 597.9671118088547, 681.3356976947437, 684.1482354468718, 713.8322494213855, 734.4821900560092, 3916.3050124528427, 3928.8022671903404, 3986.86045988389, 4010.5187377514303, 4140.399642051946, 58474.7076264616, 58694.7065264671, 58792.0, 59338.10992835111, 59749.0, 53123.20315195275, 53204.733976330645, 53633.0, 53776.19335709968, 54346.72826635841, 47044.529554704015, 47175.52824471711, 47886.76056619694, 48368.0, 48848.0, 8790.13624412383, 8875.911240887508, 8926.241269492166, 8983.0, 8993.896357761001, 35596.0, 35682.10794730153, 35703.82148089347, 36918.0, 38040.619593803705, 40843.0, 44567.77716111398, 45717.08565828732, 45729.54270457253, 46129.30806037845, 11912.463939122934, 11955.342456164994, 12145.939270303592, 12155.209911355734, 12178.634640960785, 11846.170768046499, 11879.881201188224, 12193.634190974284, 13369.598912032654, 13581.932090339486, 11781.469833857669, 11969.222000570284, 12029.0, 12047.759044818878, 12204.938975305067, 11399.943000285277, 11456.885431145914, 11494.425278736197, 11592.88407115918, 11737.061035117342, 11337.603183888525, 11342.829857552308, 11611.303321800719, 12165.087618428477, 12367.505299787908, 9814.263930205407, 9917.008299170313, 10008.84986725185, 10318.690439286833, 10680.145588353069, 10452.268341216346, 10728.624498142528, 10802.729931751455, 10898.509567069343, 10958.287711299059], "unit": "score", "name": "yui.html", "value": 6551.666176049672}], "name": "dromaeo_css", "value": 7308.5860432966865}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 109.0, 112.0, 124.0, 111.0, 111.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 151.0, 174.0, 129.0, 152.0, 150.0, 128.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [169.0, 162.0, 164.0, 165.0, 164.0, 163.0, 162.0, 162.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 77.0, 168.0, 77.0, 72.0, 77.0, 73.0, 161.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 141.0, 94.0, 93.0, 93.0, 147.0, 95.0, 94.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 150.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 98.0, 97.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 63.0, 62.0, 59.0, 63.0, 60.0, 62.0, 65.0, 58.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 63.0, 65.0, 65.0, 67.0, 65.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 83.0, 79.0, 78.0, 79.0, 79.0, 78.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [116.0, 113.0, 112.0, 112.0, 114.0, 112.0, 123.0, 111.0, 115.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [139.0, 151.0, 149.0, 148.0, 147.0, 145.0, 155.0, 148.0, 147.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [79.0, 68.0, 69.0, 77.0, 69.0, 74.0, 66.0, 66.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1522.7}]} 04:01:13 INFO - Return code: 0 04:01:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:01:13 ERROR - # TBPL SUCCESS # 04:01:13 INFO - Running post-action listener: _resource_record_post_action 04:01:13 INFO - Running post-run listener: _resource_record_post_run 04:01:14 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391385088; Read time: 12; Write time: 411632 04:01:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 127475712; Read time: 0; Write time: 156112 04:01:15 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247988224; Read time: 12; Write time: 232140 04:01:15 INFO - Running post-run listener: _upload_blobber_files 04:01:15 INFO - Blob upload gear active. 04:01:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:15 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 04:01:15 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:01:15 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:01:15 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:16 INFO - (blobuploader) - INFO - Done attempting. 04:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:17 INFO - (blobuploader) - INFO - Done attempting. 04:01:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:17 INFO - Return code: 0 04:01:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce2e2cafc012349490ffc9b1f2b5c9b4c255a929102db92c435c15ee5e4f8e24ef549f81bd466784b0dc0e014d7c80128f97c879244e0cc8f57eff8916a0a114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11bc2abe418f529f0e79f46c8cbacf7163365e04a071774d582b30fa62238d58c42bbf68010f35e83acabe8c81d57f406c504c8e1fab2d14782b838af391791e"} 04:01:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:17 INFO - Contents: 04:01:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce2e2cafc012349490ffc9b1f2b5c9b4c255a929102db92c435c15ee5e4f8e24ef549f81bd466784b0dc0e014d7c80128f97c879244e0cc8f57eff8916a0a114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11bc2abe418f529f0e79f46c8cbacf7163365e04a071774d582b30fa62238d58c42bbf68010f35e83acabe8c81d57f406c504c8e1fab2d14782b838af391791e"} 04:01:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:17 INFO - Copying logs to upload dir... 04:01:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.768372 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-27 04:01:16.814949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:16.818088) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce2e2cafc012349490ffc9b1f2b5c9b4c255a929102db92c435c15ee5e4f8e24ef549f81bd466784b0dc0e014d7c80128f97c879244e0cc8f57eff8916a0a114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11bc2abe418f529f0e79f46c8cbacf7163365e04a071774d582b30fa62238d58c42bbf68010f35e83acabe8c81d57f406c504c8e1fab2d14782b838af391791e"} build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce2e2cafc012349490ffc9b1f2b5c9b4c255a929102db92c435c15ee5e4f8e24ef549f81bd466784b0dc0e014d7c80128f97c879244e0cc8f57eff8916a0a114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11bc2abe418f529f0e79f46c8cbacf7163365e04a071774d582b30fa62238d58c42bbf68010f35e83acabe8c81d57f406c504c8e1fab2d14782b838af391791e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:16.847991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:16.848326) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461752880.359130-61941826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:16.903519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:01:16.903836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:01:16.904117) ========= ========= Total master_lag: 0.19 =========