builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1463537115.07 results: success (0) buildid: 20160517161854 builduid: 1bc274a47c334b54828779b0cf9588e5 revision: 63933fe5bb3f0148c2c276a941f8baa92acf4987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.069080) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.069680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.070121) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.089137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.089728) ========= 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=32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 19:05:15-- 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% 34.3M=0s 2016-05-17 19:05:15 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.265759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.266560) ========= 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=32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021038 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.321393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.322409) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 63933fe5bb3f0148c2c276a941f8baa92acf4987 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 63933fe5bb3f0148c2c276a941f8baa92acf4987 --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=32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 19:05:15,718 truncating revision to first 12 chars 2016-05-17 19:05:15,718 Setting DEBUG logging. 2016-05-17 19:05:15,718 attempt 1/10 2016-05-17 19:05:15,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/63933fe5bb3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 19:05:15,967 unpacking tar archive at: mozilla-beta-63933fe5bb3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.863952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.864805) ========= script_repo_revision: 63933fe5bb3f0148c2c276a941f8baa92acf4987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.865882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.866626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 19:05:15.877503) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-17 19:05:15.877834) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:16 INFO - MultiFileLogger online at 20160517 19:05:16 in /builds/slave/test 19:05:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:05:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:16 INFO - {'append_to_log': False, 19:05:16 INFO - 'base_work_dir': '/builds/slave/test', 19:05:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:05:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:16 INFO - 'branch': 'Mozilla-Beta', 19:05:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:16 INFO - 'config_files': ('talos/linux_config.py',), 19:05:16 INFO - 'default_actions': ('clobber', 19:05:16 INFO - 'read-buildbot-config', 19:05:16 INFO - 'download-and-extract', 19:05:16 INFO - 'populate-webroot', 19:05:16 INFO - 'create-virtualenv', 19:05:16 INFO - 'install', 19:05:16 INFO - 'run-tests'), 19:05:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:16 INFO - 'download_minidump_stackwalk': True, 19:05:16 INFO - 'download_symbols': 'ondemand', 19:05:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:16 INFO - 'installer_path': 'installer.exe', 19:05:16 INFO - 'log_level': 'info', 19:05:16 INFO - 'log_name': 'talos', 19:05:16 INFO - 'log_to_console': True, 19:05:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:16 INFO - 'opt_config_files': (), 19:05:16 INFO - 'pip_index': False, 19:05:16 INFO - 'sps_profile': False, 19:05:16 INFO - 'sps_profile_interval': 0, 19:05:16 INFO - 'suite': 'dromaeojs-e10s', 19:05:16 INFO - 'system_bits': '32', 19:05:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:16 INFO - 'title': 'talos-linux64-ix-008', 19:05:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:16 INFO - 'use_talos_json': True, 19:05:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:16 INFO - 'work_dir': 'build'} 19:05:16 INFO - ##### 19:05:16 INFO - ##### Running clobber step. 19:05:16 INFO - ##### 19:05:16 INFO - Running pre-action listener: _resource_record_pre_action 19:05:16 INFO - Running main action method: clobber 19:05:16 INFO - rmtree: /builds/slave/test/build 19:05:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:17 INFO - Running post-action listener: _resource_record_post_action 19:05:17 INFO - ##### 19:05:17 INFO - ##### Running read-buildbot-config step. 19:05:17 INFO - ##### 19:05:17 INFO - Running pre-action listener: _resource_record_pre_action 19:05:17 INFO - Running main action method: read_buildbot_config 19:05:17 INFO - Using buildbot properties: 19:05:17 INFO - { 19:05:17 INFO - "project": "", 19:05:17 INFO - "product": "firefox", 19:05:17 INFO - "script_repo_revision": "production", 19:05:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:05:17 INFO - "repository": "", 19:05:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 19:05:17 INFO - "buildid": "20160517161854", 19:05:17 INFO - "pgo_build": "True", 19:05:17 INFO - "basedir": "/builds/slave/test", 19:05:17 INFO - "buildnumber": 109, 19:05:17 INFO - "slavename": "talos-linux64-ix-008", 19:05:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:05:17 INFO - "platform": "ubuntu64_hw", 19:05:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:05:17 INFO - "branch": "mozilla-beta", 19:05:17 INFO - "repo_path": "releases/mozilla-beta", 19:05:17 INFO - "revision": "63933fe5bb3f0148c2c276a941f8baa92acf4987", 19:05:17 INFO - "stage_platform": "linux64-pgo", 19:05:17 INFO - "builduid": "1bc274a47c334b54828779b0cf9588e5", 19:05:17 INFO - "slavebuilddir": "test" 19:05:17 INFO - } 19:05:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 19:05:17 INFO - Running post-action listener: _resource_record_post_action 19:05:17 INFO - ##### 19:05:17 INFO - ##### Running download-and-extract step. 19:05:17 INFO - ##### 19:05:17 INFO - Running pre-action listener: _resource_record_pre_action 19:05:17 INFO - Running main action method: download_and_extract 19:05:17 INFO - mkdir: /builds/slave/test/build/tests 19:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:17 INFO - https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:05:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:05:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:05:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:05:20 INFO - Downloaded 1412 bytes. 19:05:20 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:05:20 INFO - Using the following test package requirements: 19:05:20 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:05:20 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:05:20 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 19:05:20 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'jsshell-linux-x86_64.zip'], 19:05:20 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:05:20 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:05:20 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 19:05:20 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 19:05:20 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:05:20 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:05:20 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:05:20 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:05:20 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:20 INFO - https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:05:23 INFO - Downloaded 23364973 bytes. 19:05:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:05:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:05:25 INFO - Return code: 0 19:05:25 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:25 INFO - https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:05:33 INFO - Downloaded 23364973 bytes. 19:05:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:05:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:05:34 INFO - Return code: 0 19:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:34 INFO - https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:05:36 INFO - Downloaded 10845194 bytes. 19:05:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:05:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:05:36 INFO - Return code: 0 19:05:36 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')]} 19:05:36 INFO - https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:05:37 INFO - Downloaded 53797663 bytes. 19:05:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:05:37 INFO - mkdir: /builds/slave/test/properties 19:05:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:37 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:37 INFO - Contents: 19:05:37 INFO - build_url:https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:05:38 INFO - Running post-action listener: _resource_record_post_action 19:05:38 INFO - Running post-action listener: set_extra_try_arguments 19:05:38 INFO - ##### 19:05:38 INFO - ##### Running populate-webroot step. 19:05:38 INFO - ##### 19:05:38 INFO - Running pre-action listener: _resource_record_pre_action 19:05:38 INFO - Running main action method: populate_webroot 19:05:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:38 INFO - '--tppagecycles', 19:05:38 INFO - '7'], 19:05:38 INFO - 'tests': ['tsvgm']}}, 19:05:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:05:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:05:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:05:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'tests': ['damp', 'tps']}, 19:05:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['damp', 'tps']}, 19:05:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:05:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:38 INFO - 'other': {'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other_l64': {'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other_nol64': {'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'svgr': {'tests': ['tsvgx', 19:05:38 INFO - 'tsvgr_opacity', 19:05:38 INFO - 'tart', 19:05:38 INFO - 'tscrollx', 19:05:38 INFO - 'cart']}, 19:05:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['tsvgx', 19:05:38 INFO - 'tsvgr_opacity', 19:05:38 INFO - 'tart', 19:05:38 INFO - 'tscrollx', 19:05:38 INFO - 'cart']}, 19:05:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'tests': ['tp5o']}, 19:05:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--e10s'], 19:05:38 INFO - 'tests': ['tp5o']}, 19:05:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--xperf_path', 19:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:38 INFO - 'tests': ['tp5n']}, 19:05:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--e10s', 19:05:38 INFO - '--xperf_path', 19:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:38 INFO - 'tests': ['tp5n']}}, 19:05:38 INFO - 'talos.zip': {'path': '', 19:05:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:38 INFO - Running post-action listener: _resource_record_post_action 19:05:38 INFO - ##### 19:05:38 INFO - ##### Running create-virtualenv step. 19:05:38 INFO - ##### 19:05:38 INFO - Running pre-action listener: _resource_record_pre_action 19:05:38 INFO - Running main action method: create_virtualenv 19:05:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:38 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 19:05:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:38 INFO - Using real prefix '/usr' 19:05:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:38 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:40 INFO - Installing pip.................done. 19:05:40 INFO - Return code: 0 19:05:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:05:40 INFO - Using env: {'DISPLAY': ':0', 19:05:40 INFO - 'HOME': '/home/cltbld', 19:05:40 INFO - 'LANG': 'en_US.UTF-8', 19:05:40 INFO - 'LANGUAGE': 'en_US:en', 19:05:40 INFO - 'LOGNAME': 'cltbld', 19:05:40 INFO - 'MAIL': '/var/mail/cltbld', 19:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:40 INFO - 'MOZ_NO_REMOTE': '1', 19:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:40 INFO - 'NO_EM_RESTART': '1', 19:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:40 INFO - 'PWD': '/builds/slave/test', 19:05:40 INFO - 'SHELL': '/bin/bash', 19:05:40 INFO - 'SHLVL': '1', 19:05:40 INFO - 'TERM': 'linux', 19:05:40 INFO - 'TMOUT': '86400', 19:05:40 INFO - 'USER': 'cltbld', 19:05:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:40 INFO - '_': '/tools/buildbot/bin/python'} 19:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:05:40 INFO - Cleaning up... 19:05:40 INFO - Return code: 0 19:05:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:05:40 INFO - Using env: {'DISPLAY': ':0', 19:05:40 INFO - 'HOME': '/home/cltbld', 19:05:40 INFO - 'LANG': 'en_US.UTF-8', 19:05:40 INFO - 'LANGUAGE': 'en_US:en', 19:05:40 INFO - 'LOGNAME': 'cltbld', 19:05:40 INFO - 'MAIL': '/var/mail/cltbld', 19:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:40 INFO - 'MOZ_NO_REMOTE': '1', 19:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:40 INFO - 'NO_EM_RESTART': '1', 19:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:40 INFO - 'PWD': '/builds/slave/test', 19:05:40 INFO - 'SHELL': '/bin/bash', 19:05:40 INFO - 'SHLVL': '1', 19:05:40 INFO - 'TERM': 'linux', 19:05:40 INFO - 'TMOUT': '86400', 19:05:40 INFO - 'USER': 'cltbld', 19:05:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:40 INFO - '_': '/tools/buildbot/bin/python'} 19:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:41 INFO - Downloading/unpacking psutil>=0.7.1 19:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:43 INFO - Installing collected packages: psutil 19:05:43 INFO - Running setup.py install for psutil 19:05:43 INFO - building 'psutil._psutil_linux' extension 19:05:43 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 19:05:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:05:43 INFO - building 'psutil._psutil_posix' extension 19:05:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:05:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:43 INFO - Successfully installed psutil 19:05:43 INFO - Cleaning up... 19:05:43 INFO - Return code: 0 19:05:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:05:43 INFO - Using env: {'DISPLAY': ':0', 19:05:43 INFO - 'HOME': '/home/cltbld', 19:05:43 INFO - 'LANG': 'en_US.UTF-8', 19:05:43 INFO - 'LANGUAGE': 'en_US:en', 19:05:43 INFO - 'LOGNAME': 'cltbld', 19:05:43 INFO - 'MAIL': '/var/mail/cltbld', 19:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:43 INFO - 'MOZ_NO_REMOTE': '1', 19:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:43 INFO - 'NO_EM_RESTART': '1', 19:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:43 INFO - 'PWD': '/builds/slave/test', 19:05:43 INFO - 'SHELL': '/bin/bash', 19:05:43 INFO - 'SHLVL': '1', 19:05:43 INFO - 'TERM': 'linux', 19:05:43 INFO - 'TMOUT': '86400', 19:05:43 INFO - 'USER': 'cltbld', 19:05:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:43 INFO - '_': '/tools/buildbot/bin/python'} 19:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:05:45 INFO - Installing collected packages: mozsystemmonitor 19:05:45 INFO - Running setup.py install for mozsystemmonitor 19:05:45 INFO - Successfully installed mozsystemmonitor 19:05:45 INFO - Cleaning up... 19:05:46 INFO - Return code: 0 19:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 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 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:46 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 19:05:46 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 19:05:46 INFO - Using env: {'DISPLAY': ':0', 19:05:46 INFO - 'HOME': '/home/cltbld', 19:05:46 INFO - 'LANG': 'en_US.UTF-8', 19:05:46 INFO - 'LANGUAGE': 'en_US:en', 19:05:46 INFO - 'LOGNAME': 'cltbld', 19:05:46 INFO - 'MAIL': '/var/mail/cltbld', 19:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:46 INFO - 'MOZ_NO_REMOTE': '1', 19:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:46 INFO - 'NO_EM_RESTART': '1', 19:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:46 INFO - 'PWD': '/builds/slave/test', 19:05:46 INFO - 'SHELL': '/bin/bash', 19:05:46 INFO - 'SHLVL': '1', 19:05:46 INFO - 'TERM': 'linux', 19:05:46 INFO - 'TMOUT': '86400', 19:05:46 INFO - 'USER': 'cltbld', 19:05:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:46 INFO - '_': '/tools/buildbot/bin/python'} 19:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:46 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:46 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 19:05:46 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 19:05:46 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 19:05:46 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 19:05:46 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 19:05:46 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 19:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:48 INFO - Downloading docopt-0.6.1.tar.gz 19:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:48 INFO - Running setup.py install for blobuploader 19:05:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:48 INFO - Running setup.py install for requests 19:05:49 INFO - Running setup.py install for docopt 19:05:49 INFO - Successfully installed blobuploader requests docopt 19:05:49 INFO - Cleaning up... 19:05:49 INFO - Return code: 0 19:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:49 INFO - Using env: {'DISPLAY': ':0', 19:05:49 INFO - 'HOME': '/home/cltbld', 19:05:49 INFO - 'LANG': 'en_US.UTF-8', 19:05:49 INFO - 'LANGUAGE': 'en_US:en', 19:05:49 INFO - 'LOGNAME': 'cltbld', 19:05:49 INFO - 'MAIL': '/var/mail/cltbld', 19:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:49 INFO - 'MOZ_NO_REMOTE': '1', 19:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:49 INFO - 'NO_EM_RESTART': '1', 19:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:49 INFO - 'PWD': '/builds/slave/test', 19:05:49 INFO - 'SHELL': '/bin/bash', 19:05:49 INFO - 'SHLVL': '1', 19:05:49 INFO - 'TERM': 'linux', 19:05:49 INFO - 'TMOUT': '86400', 19:05:49 INFO - 'USER': 'cltbld', 19:05:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:49 INFO - '_': '/tools/buildbot/bin/python'} 19:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:49 INFO - Running setup.py (path:/tmp/pip-Db5aW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:49 INFO - Running setup.py (path:/tmp/pip-GNTOEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:49 INFO - Running setup.py (path:/tmp/pip-U4jzcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:49 INFO - Running setup.py (path:/tmp/pip-v_3j7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:49 INFO - Running setup.py (path:/tmp/pip-FKSmlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:50 INFO - Running setup.py (path:/tmp/pip-HqZpWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:50 INFO - Running setup.py (path:/tmp/pip-gJfc34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:50 INFO - Running setup.py (path:/tmp/pip-IoKgmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:50 INFO - Running setup.py (path:/tmp/pip-gpWpRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:50 INFO - Running setup.py (path:/tmp/pip-Gs2ubX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:50 INFO - Running setup.py (path:/tmp/pip-vr3_of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:50 INFO - Running setup.py (path:/tmp/pip-cdgZ2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:50 INFO - Running setup.py (path:/tmp/pip-aHtBtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:50 INFO - Running setup.py (path:/tmp/pip-i1YUqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:50 INFO - Running setup.py (path:/tmp/pip-MABWl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:50 INFO - Running setup.py (path:/tmp/pip-EKdt_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:50 INFO - Running setup.py (path:/tmp/pip-qeGMMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:50 INFO - Running setup.py install for manifestparser 19:05:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:50 INFO - Running setup.py install for mozcrash 19:05:51 INFO - Running setup.py install for mozdebug 19:05:51 INFO - Running setup.py install for mozdevice 19:05:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozfile 19:05:51 INFO - Running setup.py install for mozhttpd 19:05:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozinfo 19:05:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozInstall 19:05:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozleak 19:05:51 INFO - Running setup.py install for mozlog 19:05:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for moznetwork 19:05:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Running setup.py install for mozprocess 19:05:52 INFO - Running setup.py install for mozprofile 19:05:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Running setup.py install for mozrunner 19:05:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Running setup.py install for mozscreenshot 19:05:52 INFO - Running setup.py install for moztest 19:05:52 INFO - Running setup.py install for mozversion 19:05:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:52 INFO - Cleaning up... 19:05:52 INFO - Return code: 0 19:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:52 INFO - Using env: {'DISPLAY': ':0', 19:05:52 INFO - 'HOME': '/home/cltbld', 19:05:52 INFO - 'LANG': 'en_US.UTF-8', 19:05:52 INFO - 'LANGUAGE': 'en_US:en', 19:05:52 INFO - 'LOGNAME': 'cltbld', 19:05:52 INFO - 'MAIL': '/var/mail/cltbld', 19:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:52 INFO - 'MOZ_NO_REMOTE': '1', 19:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:52 INFO - 'NO_EM_RESTART': '1', 19:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:52 INFO - 'PWD': '/builds/slave/test', 19:05:52 INFO - 'SHELL': '/bin/bash', 19:05:52 INFO - 'SHLVL': '1', 19:05:52 INFO - 'TERM': 'linux', 19:05:52 INFO - 'TMOUT': '86400', 19:05:52 INFO - 'USER': 'cltbld', 19:05:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:52 INFO - '_': '/tools/buildbot/bin/python'} 19:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:52 INFO - Running setup.py (path:/tmp/pip-zn6R4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:52 INFO - Running setup.py (path:/tmp/pip-Drv5IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:53 INFO - Running setup.py (path:/tmp/pip-VTekfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:53 INFO - Running setup.py (path:/tmp/pip-y5ejJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:53 INFO - Running setup.py (path:/tmp/pip-4K0muc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:53 INFO - Running setup.py (path:/tmp/pip-c8TTRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:53 INFO - Running setup.py (path:/tmp/pip-Tvx4vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:53 INFO - Running setup.py (path:/tmp/pip-k0jPap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:53 INFO - Running setup.py (path:/tmp/pip-ex8TNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:53 INFO - Running setup.py (path:/tmp/pip-4x0dnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:53 INFO - Running setup.py (path:/tmp/pip-M0G6Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:53 INFO - Running setup.py (path:/tmp/pip-q8CGyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:53 INFO - Running setup.py (path:/tmp/pip-AXrSSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:53 INFO - Running setup.py (path:/tmp/pip-WB6UJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:53 INFO - Running setup.py (path:/tmp/pip-oOtJTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:53 INFO - Running setup.py (path:/tmp/pip-nM0BQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:54 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)) 19:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:54 INFO - Running setup.py (path:/tmp/pip-EERAAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:54 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)) 19:05:54 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)) 19:05:54 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)) 19:05:54 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)) 19:05:54 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)) 19:05:54 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)) 19:05:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:54 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 19:05:54 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 19:05:54 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 19:05:54 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 19:05:54 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 19:05:54 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 19:05:56 INFO - Downloading blessings-1.6.tar.gz 19:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:56 INFO - Installing collected packages: blessings 19:05:56 INFO - Running setup.py install for blessings 19:05:56 INFO - Successfully installed blessings 19:05:56 INFO - Cleaning up... 19:05:56 INFO - Return code: 0 19:05:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:56 INFO - Reading from file tmpfile_stdout 19:05:56 INFO - Current package versions: 19:05:56 INFO - argparse == 1.2.1 19:05:56 INFO - blessings == 1.6 19:05:56 INFO - blobuploader == 1.2.4 19:05:56 INFO - docopt == 0.6.1 19:05:56 INFO - manifestparser == 1.1 19:05:56 INFO - mozInstall == 1.12 19:05:56 INFO - mozcrash == 0.17 19:05:56 INFO - mozdebug == 0.1 19:05:56 INFO - mozdevice == 0.48 19:05:56 INFO - mozfile == 1.2 19:05:56 INFO - mozhttpd == 0.7 19:05:56 INFO - mozinfo == 0.9 19:05:56 INFO - mozleak == 0.1 19:05:56 INFO - mozlog == 3.1 19:05:56 INFO - moznetwork == 0.27 19:05:56 INFO - mozprocess == 0.22 19:05:56 INFO - mozprofile == 0.28 19:05:56 INFO - mozrunner == 6.11 19:05:56 INFO - mozscreenshot == 0.1 19:05:56 INFO - mozsystemmonitor == 0.0 19:05:56 INFO - moztest == 0.7 19:05:56 INFO - mozversion == 1.4 19:05:56 INFO - psutil == 3.1.1 19:05:56 INFO - requests == 1.2.3 19:05:56 INFO - wsgiref == 0.1.2 19:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:56 INFO - Using env: {'DISPLAY': ':0', 19:05:56 INFO - 'HOME': '/home/cltbld', 19:05:56 INFO - 'LANG': 'en_US.UTF-8', 19:05:56 INFO - 'LANGUAGE': 'en_US:en', 19:05:56 INFO - 'LOGNAME': 'cltbld', 19:05:56 INFO - 'MAIL': '/var/mail/cltbld', 19:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:56 INFO - 'MOZ_NO_REMOTE': '1', 19:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:56 INFO - 'NO_EM_RESTART': '1', 19:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:56 INFO - 'PWD': '/builds/slave/test', 19:05:56 INFO - 'SHELL': '/bin/bash', 19:05:56 INFO - 'SHLVL': '1', 19:05:56 INFO - 'TERM': 'linux', 19:05:56 INFO - 'TMOUT': '86400', 19:05:56 INFO - 'USER': 'cltbld', 19:05:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:56 INFO - '_': '/tools/buildbot/bin/python'} 19:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:05:56 INFO - Cleaning up... 19:05:56 INFO - Return code: 0 19:05:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:05:56 INFO - Using env: {'DISPLAY': ':0', 19:05:56 INFO - 'HOME': '/home/cltbld', 19:05:56 INFO - 'LANG': 'en_US.UTF-8', 19:05:56 INFO - 'LANGUAGE': 'en_US:en', 19:05:56 INFO - 'LOGNAME': 'cltbld', 19:05:56 INFO - 'MAIL': '/var/mail/cltbld', 19:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:56 INFO - 'MOZ_NO_REMOTE': '1', 19:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:56 INFO - 'NO_EM_RESTART': '1', 19:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:56 INFO - 'PWD': '/builds/slave/test', 19:05:56 INFO - 'SHELL': '/bin/bash', 19:05:56 INFO - 'SHLVL': '1', 19:05:56 INFO - 'TERM': 'linux', 19:05:56 INFO - 'TMOUT': '86400', 19:05:56 INFO - 'USER': 'cltbld', 19:05:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:56 INFO - '_': '/tools/buildbot/bin/python'} 19:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:56 INFO - Downloading/unpacking jsonschema 19:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:59 INFO - Downloading/unpacking functools32 (from jsonschema) 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:59 INFO - warning: no files found matching '*.txt' 19:05:59 INFO - no previously-included directories found matching 'build' 19:05:59 INFO - no previously-included directories found matching 'dist' 19:05:59 INFO - no previously-included directories found matching '.git*' 19:05:59 INFO - Installing collected packages: jsonschema, functools32 19:05:59 INFO - Running setup.py install for functools32 19:05:59 INFO - warning: no files found matching '*.txt' 19:05:59 INFO - no previously-included directories found matching 'build' 19:05:59 INFO - no previously-included directories found matching 'dist' 19:05:59 INFO - no previously-included directories found matching '.git*' 19:05:59 INFO - Successfully installed jsonschema functools32 19:05:59 INFO - Cleaning up... 19:05:59 INFO - Return code: 0 19:05:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:05:59 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')]} 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:59 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')]} 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:59 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 0x7fc1da5bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, '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': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', '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 19:05:59 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 19:05:59 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 19:05:59 INFO - Using env: {'DISPLAY': ':0', 19:05:59 INFO - 'HOME': '/home/cltbld', 19:05:59 INFO - 'LANG': 'en_US.UTF-8', 19:05:59 INFO - 'LANGUAGE': 'en_US:en', 19:05:59 INFO - 'LOGNAME': 'cltbld', 19:05:59 INFO - 'MAIL': '/var/mail/cltbld', 19:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:59 INFO - 'MOZ_NO_REMOTE': '1', 19:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:59 INFO - 'NO_EM_RESTART': '1', 19:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:59 INFO - 'PWD': '/builds/slave/test', 19:05:59 INFO - 'SHELL': '/bin/bash', 19:05:59 INFO - 'SHLVL': '1', 19:05:59 INFO - 'TERM': 'linux', 19:05:59 INFO - 'TMOUT': '86400', 19:05:59 INFO - 'USER': 'cltbld', 19:05:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:59 INFO - '_': '/tools/buildbot/bin/python'} 19:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:59 INFO - Downloading/unpacking flake8 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:06:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:06:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:06:02 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 19:06:02 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 19:06:02 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 19:06:02 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 19:06:02 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 19:06:02 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 19:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:06:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:06:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:06:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:06:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:06:02 INFO - no previously-included directories found matching 'docs/_build' 19:06:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:06:02 INFO - Running setup.py install for pep8 19:06:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:06:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:06:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:06:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:06:02 INFO - no previously-included directories found matching 'docs/_build' 19:06:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:06:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:06:02 INFO - Cleaning up... 19:06:02 INFO - Return code: 0 19:06:02 INFO - Running post-action listener: _resource_record_post_action 19:06:02 INFO - Running post-action listener: _start_resource_monitoring 19:06:02 INFO - Starting resource monitoring. 19:06:02 INFO - ##### 19:06:02 INFO - ##### Running install step. 19:06:02 INFO - ##### 19:06:02 INFO - Running pre-action listener: _resource_record_pre_action 19:06:02 INFO - Running main action method: install 19:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:02 INFO - Reading from file tmpfile_stdout 19:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:02 INFO - Reading from file tmpfile_stdout 19:06:02 INFO - Output received: 19:06:02 INFO - Usage: mozinstall [options] installer 19:06:02 INFO - Options: 19:06:02 INFO - -h, --help show this help message and exit 19:06:02 INFO - -d DEST, --destination=DEST 19:06:02 INFO - Directory to install application into. [default: 19:06:02 INFO - "/builds/slave/test"] 19:06:02 INFO - --app=APP Application being installed. [default: firefox] 19:06:02 INFO - mkdir: /builds/slave/test/build/application 19:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:06:15 INFO - Reading from file tmpfile_stdout 19:06:15 INFO - Output received: 19:06:15 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:15 INFO - Running post-action listener: _resource_record_post_action 19:06:15 INFO - ##### 19:06:15 INFO - ##### Running run-tests step. 19:06:15 INFO - ##### 19:06:15 INFO - Running pre-action listener: _resource_record_pre_action 19:06:15 INFO - Running main action method: run_tests 19:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:15 INFO - Python 2.7.3 19:06:15 INFO - Return code: 0 19:06:15 INFO - grabbing minidump binary from tooltool 19:06: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')]} 19:06:15 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 0x1e1a160>, '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 0x1e1b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:15 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 19:06:15 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 19:06:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:15 INFO - Return code: 0 19:06:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:06:16 INFO - Return code: 0 19:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 19:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 19:06:16 INFO - Using env: {'DISPLAY': ':0', 19:06:16 INFO - 'HOME': '/home/cltbld', 19:06:16 INFO - 'LANG': 'en_US.UTF-8', 19:06:16 INFO - 'LANGUAGE': 'en_US:en', 19:06:16 INFO - 'LOGNAME': 'cltbld', 19:06:16 INFO - 'MAIL': '/var/mail/cltbld', 19:06:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:16 INFO - 'MOZ_NO_REMOTE': '1', 19:06:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:16 INFO - 'NO_EM_RESTART': '1', 19:06:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:16 INFO - 'PWD': '/builds/slave/test', 19:06:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:16 INFO - 'SHELL': '/bin/bash', 19:06:16 INFO - 'SHLVL': '1', 19:06:16 INFO - 'TERM': 'linux', 19:06:16 INFO - 'TMOUT': '86400', 19:06:16 INFO - 'USER': 'cltbld', 19:06:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907', 19:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:16 INFO - '_': '/tools/buildbot/bin/python'} 19:06:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 19:06:16 INFO - mozversion application_buildid: 20160517161854 19:06:16 INFO - mozversion application_changeset: 63933fe5bb3f0148c2c276a941f8baa92acf4987 19:06:16 INFO - mozversion application_display_name: Firefox 19:06:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:16 INFO - mozversion application_name: Firefox 19:06:16 INFO - mozversion application_remotingname: firefox 19:06:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:06:16 INFO - mozversion application_vendor: Mozilla 19:06:16 INFO - mozversion application_version: 47.0 19:06:16 INFO - mozversion platform_buildid: 20160517161854 19:06:16 INFO - mozversion platform_changeset: 63933fe5bb3f0148c2c276a941f8baa92acf4987 19:06:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:06:16 INFO - mozversion platform_version: 47.0 19:06:16 INFO - using testdate: 1463537176 19:06:16 INFO - actual date: 1463537176 19:06:16 INFO - starting webserver on 'localhost:56661' 19:06:16 INFO - SUITE-START | Running 2 tests 19:06:16 INFO - TEST-START | dromaeo_css 19:06:16 INFO - operating with platform_type : linux_ 19:06:16 INFO - Initialising browser for dromaeo_css test... 19:06:16 INFO - TEST-INFO | started process 19903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4A4Mnt/profile http://localhost:56661/getInfo.html) 19:06:20 INFO - PROCESS | 19903 | 19:06:20 INFO - PROCESS | 19903 | (process:19978): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:06:21 INFO - PROCESS | 19903 | __metrics Screen width/height:1600/1200 19:06:21 INFO - PROCESS | 19903 | colorDepth:24 19:06:21 INFO - PROCESS | 19903 | Browser inner width/height: 1024/697 19:06:21 INFO - PROCESS | 19903 | __metrics 19:06:21 ERROR - PROCESS | 19903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 19:06:22 INFO - TEST-INFO | 19903: exit 0 19:06:22 INFO - Browser initialized. 19:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:22 INFO - TEST-INFO | started process 20028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4A4Mnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:24 INFO - PROCESS | 20028 | 19:06:24 INFO - PROCESS | 20028 | (process:20095): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:06:34 INFO - PROCESS | 20028 | RSS: Main: 149172224 19:06:34 INFO - PROCESS | 20028 | 19:07:24 INFO - PROCESS | 20028 | 1463537244212 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] 19:09:32 INFO - PROCESS | 20028 | Cycle 1(1): loaded http://localhost:56661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56661/tests/dromaeo/cssquery-ext.html) 19:09:33 INFO - PROCESS | 20028 | RSS: Main: 154402816 19:09:33 INFO - PROCESS | 20028 | 19:12:34 INFO - PROCESS | 20028 | Cycle 1(1): loaded http://localhost:56661/tests/dromaeo/cssquery-ext.html (next: http://localhost:56661/tests/dromaeo/cssquery-jquery.html) 19:12:35 INFO - PROCESS | 20028 | RSS: Main: 152469504 19:12:35 INFO - PROCESS | 20028 | 19:15:37 INFO - PROCESS | 20028 | Cycle 1(1): loaded http://localhost:56661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56661/tests/dromaeo/cssquery-mootools.html) 19:15:37 INFO - PROCESS | 20028 | RSS: Main: 151777280 19:15:37 INFO - PROCESS | 20028 | 19:18:39 INFO - PROCESS | 20028 | Cycle 1(1): loaded http://localhost:56661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56661/tests/dromaeo/cssquery-prototype.html) 19:18:40 INFO - PROCESS | 20028 | RSS: Main: 152514560 19:18:40 INFO - PROCESS | 20028 | 19:21:42 INFO - PROCESS | 20028 | Cycle 1(1): loaded http://localhost:56661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56661/tests/dromaeo/cssquery-yui.html) 19:21:42 INFO - PROCESS | 20028 | RSS: Main: 151420928 19:21:42 INFO - PROCESS | 20028 | 19:24:44 INFO - PROCESS | 20028 | Cycle 1(1): loaded http://localhost:56661/tests/dromaeo/cssquery-yui.html (next: http://localhost:56661/tests/dromaeo/cssquery-dojo.html) 19:24:45 INFO - PROCESS | 20028 | RSS: Main: 155484160 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | __start_tp_report 19:24:45 INFO - PROCESS | 20028 | _x_x_mozilla_page_load 19:24:45 INFO - PROCESS | 20028 | _x_x_mozilla_page_load_details 19:24:45 INFO - PROCESS | 20028 | |i|pagename|runs| 19:24:45 INFO - PROCESS | 20028 | |0;dojo.html;3294.5717056782614;3388.762786604937;3394.575678040245;3420.931581368371;3438.277961628058;5520.861978450535;5521.558275337973;5536.141898005815;5537.501624853768;5571.108622620376;5531.834044978657;5559.916601250974;5572.136318870582;5576.832695019156;5582.078956972095;5087.033463641897;5095.566876815476;5147.7683504242395;5162.199859021839;5170.3795544534705;4993.825216117437;5109.872253193663;5128.076946149691;5191.844244672647;5214.243934629495;5059.822906198284;5073.543381095701;5105.081085404626;5166.302549155872;5199.272101905717;5135.204043373283;5169.508896654812;5177.818776342829;5178.0679477694;5182.740862956837;4920.360353154103;4942.654014219006;5153.613478989091;5163.586913046985;5176.7411629418375;5345.305110335631;5378.515933565998;5387.892242155174;5389.83830485086;5405.567554595623;5921.230240068763;5951.404859514014;5962.1951036609935;5963.850903727398;6015.639061656271;6021.759129634809;6025.367336429656;6074.271087469488;6108.816735497898;6122.785702500391;5595.580331475156;5628.352739435018;5645.802396916089;5648.943510564924;5656.377798442168;5935.050391937356;6131.202943617391;6153.876922461525;6155.692215389302;6159.384061593894;5799.5070419014855;5840.883182336414;5854.502367298742;5854.502367298827;5857.7949771757785;5858;5859.355470898197;5893.882122357529;5894.734736936763;5900.940990590125;5813.215215945877;5860.589758716934;5861.296644402699;5870.589058765845;5887.499562537147;5981.431763982415;5995.700214989233;5998.760049597967;5999.430054144849;6030.7889223876955;4557.1797076526545;4557.680962332671;4563.95436045642;4575.519570445122;4588.151192029485;4011.538673052636;4054.493188351456;4055.1889622075114;4109.465769450012;4143.7928103594695;5511;5581.888362232814;5665.461781130786;5687.772489100473;5697.259356283656;5831.358550559435;5901.911471327933;5970.432808883149;5993;6005.519558435315;5667.4615911488345;5667.801626943037;5669.291338582677;5672.97163514188;5676.914846277309;4949.356583644103;5049.192129259301;5069.03688299222;5087.287779710843;5139.665921715151;6135;6191.783287584913;6202.131701561785;6233.252009758858;6250.937490625036;5866.941330586639;6035.879282414415;6046.606970546901;6050.122732203894;6053.152558641706;6151.72317245716;6185.381461853779;6221.96889015552;6245.531585131042;6258.655773932295;5891.1752354671235;5894.351621321565;5895.086261629454;5925.259342582177;5967.522598192221;5928.347881733092;5955.255593050869;5965.642061476326;6002.33974262822;6009.939900600938;5804.1293805929445;5807.8548036299435;5811.099279611667;5841.1238314253205;5842.678652673973;5729.427057294237;5735.9139612905;5782.797602084075;5802.94197058024;5834.124881267844;5586.1062230043;5682.715864206691;5731.197632331394;5737.08206686928;5748.310202775694;5914.615549989237;5974.2830860297045;5990.251218597676;5994.3705910878725;6004.969975150097;5808.332041815245;5837.445442682938;5838.678872661874;5849.034909239927;5849.444302791228 19:24:45 INFO - PROCESS | 20028 | |1;ext.html;498.9376327959005;551.8824380629226;557.2087635557509;567.9517241034513;568.3833041150351;39145.60854391459;39658.40512392316;39703.80148099259;39789.403158952606;39874.20251594966;43110.353344699855;43645.345319820146;43737.343939840925;43912.121757564826;43949.12101757963;8837.95581022094;9014.45913245204;9055.728328150166;9064.320175986795;9073.047330030318;8805.20753132218;8945.239654629331;8954.417962832395;9153.405028673114;9155.816883662323;9137.223336016446;9153.771155721093;9155.404898681598;9163.175314221719;9203;9011.684591039315;9108.089191080871;9118.726438206897;9140.131687489678;9184.816303673955;9078.409903356262;9096.317776166814;9161.541922903829;9172.954135229347;9182.08179182083;43574.128517429475;43901.341479877825;44030.779846100566;44140.55859441397;44144.3378349325;3683.907902302437;3785;3974.5826688197612;4299.204647140289;4346.782660866944;32653.346933061443;33152.83423582867;33362.6663733362;33411.6658833411;33421.83289083539;4344.087741574242;4373.956260437387;4412.360207769888;4485.9102817943785;4511.503734589192;298060.99999999785;298377;301152.4942375296;301234;301487;46745.53254467412;47051;47213.29180062302;47319.76340118346;63963.36036639667;44530;44673.776631116634;44717;44870.775646122216;45031.77484112558;16101.67796644084;16234.918825405797;16308.510744677678;16336.264868080965;16357.509274721539;12907.741845163044;13009;13014.21914685122;13022.609321720363;13130.27783471899;15802.68394632124;15816.130112843904;15818.367265309489;15823.683526329409;15826.841731582766;5832.104566016062;5962.19510366095;5970.253718285215;6033.909491357633;6090.269167699816;1058.3914249306679;1063.2716589136467;1082.6427278997912;1110.5169251375678;1151.5221183208876;29672;30459;30507.847460762998;30817.38365232683;30956.535651965238;1104.9889501104885;1124.8875112488686;1138.8348689439986;1162.8255761635821;1252.6242127361754;16014.19929003545;16127;16140.515784526482;16310.836891631168;16337.83662163363;338381;561484;578275;583945;589486;56233.15650265249;56998.7150064247;57017.42982570204;57112;57135.428645713844;1431.1556181852757;1509.4037855047413;1513.2660659579874;1518.3395223077996;1532.2109113806175;30684.693153068183;31771.682283176873;32027;32035.059872319085;32299.838500807346;50284.49715502798;51169.232461512365;51351.48648513467;51389;51499.227511588106;306238;313128;314577;314728;315627;35149.824250878584;35384.64615353814;35531.82234088813;35578.46632300466;35813.28373432464;47368.52631473641;47675.761621191676;47874;48676.51323486862;48779;39130.6086939127;39255.80372098121;39482.80258598689;39544.01139971524;39744.403833941935;38169.618303816605;38824.07559941888;39387.60612393839;40190.397144042276;40368.19263614652;38615.2276954465;39645.207095858495;39827.40258896177;39908.40137397999;40203.798981006075;33874.32251355008;34246.828765856015;34433;35035.824820875736;35184.47223291704;26602.334941626614;27227;27342.863285683445;27410.588841167;27634.585481217397 19:24:45 INFO - PROCESS | 20028 | |2;jquery.html;342.9794212347259;354.5745105872953;358.9712822974162;361.1783193235391;367.1244082862374;17556.73664895026;17610.295588176472;18163.54591135219;18365.173567189475;18396.35612753554;11797.115216358765;12212.633620991362;12223.083268754834;12232.38838058098;16838.326466941337;5116.258142569334;5158.509941555565;5159.871003224912;5256.500632439912;5258.55302299305;5136.357955255593;5200.32395788547;5200.583953283728;5215.426303106655;5232.032074066291;5189.8183563575285;5199.506046925536;5204.42751297357;5238;5296.602754793386;5278.604104692164;5499.202615620733;5512.035393806108;5520.861978450531;5526.032944234763;5167.7932882684645;5259.447757985395;5315.920261196085;5352.090144675414;5388.461153884619;13313.86686133136;13638.386272617756;13731.519396821062;13892;13906.93046534771;2301.8849057547222;2310.6302991521275;2389.6057150570136;2430.5746494363593;2433.914812981537;9994.250431217688;10189.184865210766;10234.53944572496;10409;12833.973282137407;1900.88594684318;1946.1728765274843;1951.0732402109027;1984.9206031758713;2000.5098750806146;48377.51622483765;58110;59634.70182649102;64064;64806.67596661986;10132.189424846141;10477.42374169428;10479.633212837514;10567.365958042543;10653.84019239712;14474.565763027125;14503.92748036253;14596.41614335436;14615.26923653813;14618.85381146175;7828;7951.801204969922;7999.600019998977;8030.879536806952;8088.352931765445;7693.846123077619;7733.574653394117;7789.260020298176;7841.255080767318;7929.920700793034;4419.889502762392;4573.176828170895;4645.140648979949;4681.29780532916;4729.527047295243;1942.9222831086881;1948.1428171604448;1977.7428934238744;1989.651810933081;2041.4181958141858;965.4593427680521;969;993.7913038262046;994.5673631970116;1032.6850310655173;17237.655246894992;17284;17292.394766183123;17599.03205323694;17932.282708691768;1001.2540657210279;1035.5598870480017;1040.1003132290514;1040.6305761454726;1092.4919912240846;8237.382196335298;9978.513492629409;10189.337693049929;10217.438040907673;10337.844932326021;343738;350763;351503;434334;441539;69637;71701;75208;80273;80479.59760201279;1068.156156636264;1096.2928910852456;1113.554578168739;1115.1636272795404;1120.4117838134882;15867.444639437565;16109.355625774837;16287.837121628632;16454.917725411295;16657.3337066516;35043;35323.64676353204;35716.28567428689;35932.10169745777;36204.27591448209;49072.50927490679;49326.26010609916;49761.75119124381;49764.00471990612;50144.49855501398;8366.372522060992;8395.916040839513;8431.53626550521;8504;8585.313174945864;12750.171238869443;12782.552610658582;12856.807147892976;13103;13123.737525249251;7935.0874649416055;11246.887531124585;11257.71855703614;11289.943550282196;11530.423478825858;10020.549075291776;10477.266591338837;11013.174011949297;11139.10887129044;11340.489677964677;10376.429296388771;11253.88746112561;11326.37704926237;11410.087193024705;11449.42752862337;8422.32621390275;8426.03100643434;8461.703840365557;8574.27118694918;8789.296856251613;11358.148138889781;11446;11637.592684256011;11728.237664551776;11765.52937882475 19:24:45 INFO - PROCESS | 20028 | |3;mootools.html;1632.183908045977;1654.346533119418;1871.728599353093;1954.1890115602025;2004.7694515130765;8420.284275836553;8485.745427637174;8495.575221238929;8604.741857744262;8693.608787604557;8587.184217499327;8623.611937462814;8664.74005779826;8702.825943481126;8720.91279087209;2451.693538307716;2480.255923223035;2482.416632091457;2494.950100997979;2499.600063989762;2443.816713746467;2497.887595058227;2499.0378704198924;2505.361132911105;2508.535920854639;2471.7281099079087;2475.554400207971;2510.3975045989014;2514.3462699698025;2514.710808257046;2468.395243165418;2488.6515887775727;2504.5742223821903;2514.2959971208093;2515.308290220186;2524.394145405108;2538.111660918682;2549.349915771485;2570.832895861763;2573.8327008744373;8597.398182127254;8601.741947741577;8618.310535157236;8639.784005399852;8656.220940115358;5115.079285728568;5241.109011468059;5278.551323137538;5282.3925248596515;5308.814191503279;3276.1645780325866;3278.393497203001;3343.531905533203;3347.6150242722156;3385.5768028996376;1005.8073399988023;1012.5392946209531;1034.2243317511866;1072.0994364733583;1072.3083611070895;12170.452329645188;12244.326562039085;12272.631821045472;12272.815907761391;12296.323702196376;4438.312061630452;4450.443694538183;4482.641388688897;4535.115652447807;4553.817847286072;9719.076687714656;9739.074787895139;9741.220702343795;9789.755256118655;9832.557534910946;5026.824061157842;5042.924356134661;5068.315777370008;5071.137906555894;5081.8475445736685;4127.9587204128175;4539.319102134707;4684.273937539687;4735.739534325577;4748.121597504403;3748.1004558905665;3759.3045286622064;3779.3575092234387;3811.9047023824073;3825.5600605930117;1130.0225305111185;1130.4743294368159;1132.5469812075237;1136.2216881436243;1136.8181091025397;1480.3560451203762;1481.9851801481848;1483.4437086092714;1484.2282013352997;1519.7568389057699;8229.547374894319;8278.544680042656;8284.337253019745;8286.46138001028;8308.335333173332;513.9177731563007;518.0726499565735;522.605432898167;531.6030564691623;532.9813456529002;6225.159603453566;6239.96880015597;6263.561550691499;6271.05934109878;6303.338149494237;10408.323458975143;10711.410872401937;10833.02502774754;10893.509792059376;10896;10364.585416583403;10554.155667546578;10560.366378017343;10633.043026127685;10643.467826608794;8240.670373185125;8258.463199891989;8279.172082791672;8281.171882811792;8286.254237118568;7893.447458677838;7954.363650907798;7968.561729104955;7977.680892764457;7990.200979901963;9346.345755797029;9363.953180234055;9580;9613.327067105236;9691.224702023963;9602.135807777333;9672.322937394596;9716.417014979124;9745.902540974499;9795.412275263507;7235.2764723527225;7280;7344.485885988143;7441.069866266716;7496.550206987598;8005.8398832024195;8107.22981316774;8113.6754529818145;8114.878276825971;8154.592270386575;7279.636018198963;7377.225391334047;7450;7491.513051651626;7550.169481357156;7260.056192694916;7297.087864016998;7310.451716121419;7331.41348692114;7378.889316660362;7753.185915479019;7770.8834367483405;7825.334846538108;7830.412719046209;7896.7236146734585;6965;7004.964975175091;7038.577685338896;7054.611996340251;7139.714411423693;7214.206437291999;7244.818879528054;7263.273672632695;7272.563646181246;7284.963575182091 19:24:45 INFO - PROCESS | 20028 | |4;prototype.html;337.0898573850604;341.1437292396085;358.21908240036726;360.7492792509204;361.5209846952788;6334.809955701337;6339.841503962403;6359.65021923794;6380.3300653431415;6386.457151142153;6262;6267.655278959667;6273.529485288599;6276.560640755149;6285.842853928654;4671.976640116794;4815;4899.363082799231;4910.901781964359;4956.826511072113;4931.482194369575;4938.827141050064;4956.3804524434445;4966.106100901836;4983.053219888227;4915.066137433876;4920.286558449023;4923;4923.532264434873;4942.604591632678;4933.038057578791;4934.358533390654;4935.629827762897;4944.554990050912;4944.752762361885;4369.672274579388;4369.694121411502;4374.496932852699;4375.978120109411;4376.606105450524;5908.556858235649;6007.309159446676;6048.637081775064;6054;6068.271807383098;5762.9135562966585;5777.88444231113;5780.450857168562;5788.363280039192;5792.189093526909;6652.50106242029;6707.832304192434;6735.528513004092;6737.225219099817;6767.42476889465;4837.371141751585;4842.41890973082;4844.20070688336;4848.151573474628;4853.029394121155;6999.790006299819;7017.157941047056;7024.859502809966;7036.964815175891;7037.190723066861;4659.4175728034;4800.687955282895;4814.133455977888;4983.053219888209;4987.725675087832;4800.447948485899;4816.735079570587;4817.229243321051;4925.482824303468;4925.926111108336;5683.488486036276;5685.061964775766;5694.08894576874;5701.572382071361;5707.258056452634;6837.35045170708;6847.07564478789;6849.280825513349;6855.7600483983815;6862;1732.8440440360428;1754.9385771497937;1755.6049888774924;1757.7099778536399;1760.9559761006078;1096.7970925378831;1133.0708818768696;1138.1122724275078;1149.7642983188425;1154.1459320103063;6491.058796474485;6537.5750576212395;6539.8365040873405;6567.770128045496;6583.407493325623;6989.0564773755905;7009.754658586925;7022.719091236293;7030.261822508563;7038.5073044887395;6359.904601430982;6446.161998940202;6461.289258181596;6463.741450341934;6489.123968264318;3760.830762615689;3784.2242340320167;3791.431285307226;3799.1072098056934;3801.5248093988253;7159.319864612853;7245.963770181115;7277.927220727831;7305.050343455317;7309.5248808827255;7263.491555591164;7278.053852999076;7289.635518224068;7291.270872912666;7312.634368281671;7156.570605763671;7320.743773967992;7321.304476074764;7337.119545654556;7341.963290183515;7056.788296351117;7074.080369552131;7076.0447339610555;7080.468964827555;7089.680964356719;6993.545419547713;6995.0906382172025;6997.510174287751;7000;7001.264867189076;7202.783916482514;7296.7081316746735;7329.816754581178;7330.120385553768;7346.449016323691;4773.64197685182;4816.446108697404;4819.879503012313;4822.300766388924;4822.42130944289;7036.296370362923;7055.223925368308;7059.294070593105;7062.223155452793;7066.858662826612;6885.139357580302;6885.2770459101075;6887.552309099892;6894.620795856075;6895.379415852597;6867.141607299088;6870.553414028072;6881.311868813079;6884.036234927014;6890.10428644273;6510.316416776171;6756.898646520404;6765.323467653392;6773.93226067733;6774.762883299061;6862.245153033063;6871.896921546081;6898.655067246517;6910.170779506491;6925.065116209247;6704.932950670626;6769.966150169218;6801.591904485746;6826.897596535957;6828.975653651992 19:24:45 INFO - PROCESS | 20028 | |5;yui.html;757.7650928212255;762.0436352377765;863.128240477118;874.8469017921863;880.7886107334242;12743.362831858405;12984.156029858053;12984.156029858064;12987.67530811729;13002.804957925615;14016.439342426316;14725.779113313309;14797.186154761484;14814.629634259149;14904.254787260648;790.5888937752366;933.9673111441101;934.0612684252317;951.4909523404945;954.5370495309769;937.4000639590668;940.7601061729249;941.3833938770082;942.0908822985817;942.9292803039765;992.2508506077937;996.4768496539302;996.7308826616845;996.7458298133965;999.400359784131;985;988.7083310423442;991.3506653142167;993.7316924430436;993.8906720260766;728.9854202915965;729.9598522081336;733.7248531800575;734.0567370928385;734.2217249715319;15219.162946037963;15242.237888105661;15293.6176595586;15326.923365383213;15341.923290383476;14269.571912842632;14365.569032929028;14406.567802965928;14483.78274325886;14539;11551.306921584648;11577.76844463106;11600.535978560847;11718.589849355232;11763.176577639482;4000.899977500557;4023.959760402388;4030.1536677297804;4075.3071977763852;4078.3678529827625;52003.95992080175;52193.2171017435;52293;52570;52576;11067.335959842436;11242.943785281184;11393.715157121138;11461.598844040585;11512.251703639236;19779.20883164686;19841.107150178275;19885;19889.801101988796;19958.900205498878;8033.955585773812;8119.309858661962;8295.294899933453;8337.541435221;8501.277391421674;4664.883377915511;4674.041821426599;4683;4699.741514216683;4721.433427988663;3448.1207292140843;3450.861965521401;3453.223024819446;3473.4095203815414;3477.4088404971217;571.1832080125378;578.4822583787486;578.9305283366023;586.0593747036031;588.5321169670123;644.7717098926553;721.8772808622547;722.6134018300185;747.7457664394132;750.6584504050644;9885;9888.802223955481;9911.851322230172;9912.900870991341;9961.765935838495;649.746598826458;689.2005273882272;696.9616671083139;715.1239731329184;734.7391675955066;4336.588024137702;4361.433013708261;4403.515613282536;4415.955840441618;4460.420145381079;60503;60735.69632151899;61058.38941610527;61334.0799888002;61441.69279153576;52583.47416525862;53559;53713;53779.19331210035;54112;47092.293615595794;47116.7644161777;47563.28655070177;47639.643230853006;47902.5209747905;8410.831783364421;8578.742637720878;8614.138586141586;8621.741347759576;8629.741107766777;36785.81607092055;37495;37936.81031594824;38579.80710096432;38668.22663546657;47802.521974779804;48414.27378589253;48581.75709121432;48972.5102748968;49174.262386064955;11118.332900026024;11171.218014739216;11244.606438774603;11254.7749045017;11285.71785705331;11939.52241910314;11972.700682483008;12020.918117369478;12047.518099276282;12072.29601233888;11158.776824463628;11484.081273497934;11499.770004599693;11514.827277590675;11588.246763960316;10357.22320825926;10689.9465502672;11045.668629941114;11692.590759323723;11749.588764393206;11248.718782030188;11262.09903207725;11867.109966752701;12090.879091208975;12829.10196286251;10637.042666160083;10655.89344106549;10707.732306692395;10805.783884322427;10868;10324.535395907053;10420.68737937863;10585.735356616146;10637.680869573926;10778.946105269424 19:24:45 INFO - PROCESS | 20028 | __end_tp_report 19:24:45 INFO - PROCESS | 20028 | __start_cc_report 19:24:45 INFO - PROCESS | 20028 | _x_x_mozilla_cycle_collect,327 19:24:45 INFO - PROCESS | 20028 | __end_cc_report 19:24:45 INFO - PROCESS | 20028 | __startTimestamp1463538285047__endTimestamp 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | ------- Summary: start ------- 19:24:45 INFO - PROCESS | 20028 | Number of tests: 6 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | [#0] dojo.html Cycles:165 Average:5551.91 Median:5782.80 stddev:612.21 (10.6%) stddev-sans-first:587.92 19:24:45 INFO - PROCESS | 20028 | Values: 3294.6 3388.8 3394.6 3420.9 3438.3 5520.9 5521.6 5536.1 5537.5 5571.1 5531.8 5559.9 5572.1 5576.8 5582.1 5087.0 5095.6 5147.8 5162.2 5170.4 4993.8 5109.9 5128.1 5191.8 5214.2 5059.8 5073.5 5105.1 5166.3 5199.3 5135.2 5169.5 5177.8 5178.1 5182.7 4920.4 4942.7 5153.6 5163.6 5176.7 5345.3 5378.5 5387.9 5389.8 5405.6 5921.2 5951.4 5962.2 5963.9 6015.6 6021.8 6025.4 6074.3 6108.8 6122.8 5595.6 5628.4 5645.8 5648.9 5656.4 5935.1 6131.2 6153.9 6155.7 6159.4 5799.5 5840.9 5854.5 5854.5 5857.8 5858.0 5859.4 5893.9 5894.7 5900.9 5813.2 5860.6 5861.3 5870.6 5887.5 5981.4 5995.7 5998.8 5999.4 6030.8 4557.2 4557.7 4564.0 4575.5 4588.2 4011.5 4054.5 4055.2 4109.5 4143.8 5511.0 5581.9 5665.5 5687.8 5697.3 5831.4 5901.9 5970.4 5993.0 6005.5 5667.5 5667.8 5669.3 5673.0 5676.9 4949.4 5049.2 5069.0 5087.3 5139.7 6135.0 6191.8 6202.1 6233.3 6250.9 5866.9 6035.9 6046.6 6050.1 6053.2 6151.7 6185.4 6222.0 6245.5 6258.7 5891.2 5894.4 5895.1 5925.3 5967.5 5928.3 5955.3 5965.6 6002.3 6009.9 5804.1 5807.9 5811.1 5841.1 5842.7 5729.4 5735.9 5782.8 5802.9 5834.1 5586.1 5682.7 5731.2 5737.1 5748.3 5914.6 5974.3 5990.3 5994.4 6005.0 5808.3 5837.4 5838.7 5849.0 5849.4 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | [#1] ext.html Cycles:180 Average:54401.84 Median:21859.49 stddev:106025.34 (485.0%) stddev-sans-first:106245.53 19:24:45 INFO - PROCESS | 20028 | Values: 498.9 551.9 557.2 568.0 568.4 39145.6 39658.4 39703.8 39789.4 39874.2 43110.4 43645.3 43737.3 43912.1 43949.1 8838.0 9014.5 9055.7 9064.3 9073.0 8805.2 8945.2 8954.4 9153.4 9155.8 9137.2 9153.8 9155.4 9163.2 9203.0 9011.7 9108.1 9118.7 9140.1 9184.8 9078.4 9096.3 9161.5 9173.0 9182.1 43574.1 43901.3 44030.8 44140.6 44144.3 3683.9 3785.0 3974.6 4299.2 4346.8 32653.3 33152.8 33362.7 33411.7 33421.8 4344.1 4374.0 4412.4 4485.9 4511.5 298061.0 298377.0 301152.5 301234.0 301487.0 46745.5 47051.0 47213.3 47319.8 63963.4 44530.0 44673.8 44717.0 44870.8 45031.8 16101.7 16234.9 16308.5 16336.3 16357.5 12907.7 13009.0 13014.2 13022.6 13130.3 15802.7 15816.1 15818.4 15823.7 15826.8 5832.1 5962.2 5970.3 6033.9 6090.3 1058.4 1063.3 1082.6 1110.5 1151.5 29672.0 30459.0 30507.8 30817.4 30956.5 1105.0 1124.9 1138.8 1162.8 1252.6 16014.2 16127.0 16140.5 16310.8 16337.8 338381.0 561484.0 578275.0 583945.0 589486.0 56233.2 56998.7 57017.4 57112.0 57135.4 1431.2 1509.4 1513.3 1518.3 1532.2 30684.7 31771.7 32027.0 32035.1 32299.8 50284.5 51169.2 51351.5 51389.0 51499.2 306238.0 313128.0 314577.0 314728.0 315627.0 35149.8 35384.6 35531.8 35578.5 35813.3 47368.5 47675.8 47874.0 48676.5 48779.0 39130.6 39255.8 39482.8 39544.0 39744.4 38169.6 38824.1 39387.6 40190.4 40368.2 38615.2 39645.2 39827.4 39908.4 40203.8 33874.3 34246.8 34433.0 35035.8 35184.5 26602.3 27227.0 27342.9 27410.6 27634.6 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | [#2] jquery.html Cycles:180 Average:23856.70 Median:2432.24 stddev:63649.98 (2616.9%) stddev-sans-first:63804.05 19:24:45 INFO - PROCESS | 20028 | Values: 343.0 354.6 359.0 361.2 367.1 17556.7 17610.3 18163.5 18365.2 18396.4 11797.1 12212.6 12223.1 12232.4 16838.3 5116.3 5158.5 5159.9 5256.5 5258.6 5136.4 5200.3 5200.6 5215.4 5232.0 5189.8 5199.5 5204.4 5238.0 5296.6 5278.6 5499.2 5512.0 5520.9 5526.0 5167.8 5259.4 5315.9 5352.1 5388.5 13313.9 13638.4 13731.5 13892.0 13906.9 2301.9 2310.6 2389.6 2430.6 2433.9 9994.3 10189.2 10234.5 10409.0 12834.0 1900.9 1946.2 1951.1 1984.9 2000.5 48377.5 58110.0 59634.7 64064.0 64806.7 10132.2 10477.4 10479.6 10567.4 10653.8 14474.6 14503.9 14596.4 14615.3 14618.9 7828.0 7951.8 7999.6 8030.9 8088.4 7693.8 7733.6 7789.3 7841.3 7929.9 4419.9 4573.2 4645.1 4681.3 4729.5 1942.9 1948.1 1977.7 1989.7 2041.4 965.5 969.0 993.8 994.6 1032.7 17237.7 17284.0 17292.4 17599.0 17932.3 1001.3 1035.6 1040.1 1040.6 1092.5 8237.4 9978.5 10189.3 10217.4 10337.8 343738.0 350763.0 351503.0 434334.0 441539.0 69637.0 71701.0 75208.0 80273.0 80479.6 1068.2 1096.3 1113.6 1115.2 1120.4 15867.4 16109.4 16287.8 16454.9 16657.3 35043.0 35323.6 35716.3 35932.1 36204.3 49072.5 49326.3 49761.8 49764.0 50144.5 8366.4 8395.9 8431.5 8504.0 8585.3 12750.2 12782.6 12856.8 13103.0 13123.7 7935.1 11246.9 11257.7 11289.9 11530.4 10020.5 10477.3 11013.2 11139.1 11340.5 10376.4 11253.9 11326.4 11410.1 11449.4 8422.3 8426.0 8461.7 8574.3 8789.3 11358.1 11446.0 11637.6 11728.2 11765.5 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | [#3] mootools.html Cycles:180 Average:6012.39 Median:5280.47 stddev:3208.20 (60.8%) stddev-sans-first:3200.31 19:24:45 INFO - PROCESS | 20028 | Values: 1632.2 1654.3 1871.7 1954.2 2004.8 8420.3 8485.7 8495.6 8604.7 8693.6 8587.2 8623.6 8664.7 8702.8 8720.9 2451.7 2480.3 2482.4 2495.0 2499.6 2443.8 2497.9 2499.0 2505.4 2508.5 2471.7 2475.6 2510.4 2514.3 2514.7 2468.4 2488.7 2504.6 2514.3 2515.3 2524.4 2538.1 2549.3 2570.8 2573.8 8597.4 8601.7 8618.3 8639.8 8656.2 5115.1 5241.1 5278.6 5282.4 5308.8 3276.2 3278.4 3343.5 3347.6 3385.6 1005.8 1012.5 1034.2 1072.1 1072.3 12170.5 12244.3 12272.6 12272.8 12296.3 4438.3 4450.4 4482.6 4535.1 4553.8 9719.1 9739.1 9741.2 9789.8 9832.6 5026.8 5042.9 5068.3 5071.1 5081.8 4128.0 4539.3 4684.3 4735.7 4748.1 3748.1 3759.3 3779.4 3811.9 3825.6 1130.0 1130.5 1132.5 1136.2 1136.8 1480.4 1482.0 1483.4 1484.2 1519.8 8229.5 8278.5 8284.3 8286.5 8308.3 513.9 518.1 522.6 531.6 533.0 6225.2 6240.0 6263.6 6271.1 6303.3 10408.3 10711.4 10833.0 10893.5 10896.0 10364.6 10554.2 10560.4 10633.0 10643.5 8240.7 8258.5 8279.2 8281.2 8286.3 7893.4 7954.4 7968.6 7977.7 7990.2 9346.3 9364.0 9580.0 9613.3 9691.2 9602.1 9672.3 9716.4 9745.9 9795.4 7235.3 7280.0 7344.5 7441.1 7496.6 8005.8 8107.2 8113.7 8114.9 8154.6 7279.6 7377.2 7450.0 7491.5 7550.2 7260.1 7297.1 7310.5 7331.4 7378.9 7753.2 7770.9 7825.3 7830.4 7896.7 6965.0 7005.0 7038.6 7054.6 7139.7 7214.2 7244.8 7263.3 7272.6 7285.0 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | [#4] prototype.html Cycles:180 Average:5710.90 Median:6416.31 stddev:1719.33 (26.8%) stddev-sans-first:1676.17 19:24:45 INFO - PROCESS | 20028 | Values: 337.1 341.1 358.2 360.7 361.5 6334.8 6339.8 6359.7 6380.3 6386.5 6262.0 6267.7 6273.5 6276.6 6285.8 4672.0 4815.0 4899.4 4910.9 4956.8 4931.5 4938.8 4956.4 4966.1 4983.1 4915.1 4920.3 4923.0 4923.5 4942.6 4933.0 4934.4 4935.6 4944.6 4944.8 4369.7 4369.7 4374.5 4376.0 4376.6 5908.6 6007.3 6048.6 6054.0 6068.3 5762.9 5777.9 5780.5 5788.4 5792.2 6652.5 6707.8 6735.5 6737.2 6767.4 4837.4 4842.4 4844.2 4848.2 4853.0 6999.8 7017.2 7024.9 7037.0 7037.2 4659.4 4800.7 4814.1 4983.1 4987.7 4800.4 4816.7 4817.2 4925.5 4925.9 5683.5 5685.1 5694.1 5701.6 5707.3 6837.4 6847.1 6849.3 6855.8 6862.0 1732.8 1754.9 1755.6 1757.7 1761.0 1096.8 1133.1 1138.1 1149.8 1154.1 6491.1 6537.6 6539.8 6567.8 6583.4 6989.1 7009.8 7022.7 7030.3 7038.5 6359.9 6446.2 6461.3 6463.7 6489.1 3760.8 3784.2 3791.4 3799.1 3801.5 7159.3 7246.0 7277.9 7305.1 7309.5 7263.5 7278.1 7289.6 7291.3 7312.6 7156.6 7320.7 7321.3 7337.1 7342.0 7056.8 7074.1 7076.0 7080.5 7089.7 6993.5 6995.1 6997.5 7000.0 7001.3 7202.8 7296.7 7329.8 7330.1 7346.4 4773.6 4816.4 4819.9 4822.3 4822.4 7036.3 7055.2 7059.3 7062.2 7066.9 6885.1 6885.3 6887.6 6894.6 6895.4 6867.1 6870.6 6881.3 6884.0 6890.1 6510.3 6756.9 6765.3 6773.9 6774.8 6862.2 6871.9 6898.7 6910.2 6925.1 6704.9 6770.0 6801.6 6826.9 6829.0 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - PROCESS | 20028 | [#5] yui.html Cycles:180 Average:14739.54 Median:4669.46 stddev:16919.78 (362.3%) stddev-sans-first:16934.66 19:24:45 INFO - PROCESS | 20028 | Values: 757.8 762.0 863.1 874.8 880.8 12743.4 12984.2 12984.2 12987.7 13002.8 14016.4 14725.8 14797.2 14814.6 14904.3 790.6 934.0 934.1 951.5 954.5 937.4 940.8 941.4 942.1 942.9 992.3 996.5 996.7 996.7 999.4 985.0 988.7 991.4 993.7 993.9 729.0 730.0 733.7 734.1 734.2 15219.2 15242.2 15293.6 15326.9 15341.9 14269.6 14365.6 14406.6 14483.8 14539.0 11551.3 11577.8 11600.5 11718.6 11763.2 4000.9 4024.0 4030.2 4075.3 4078.4 52004.0 52193.2 52293.0 52570.0 52576.0 11067.3 11242.9 11393.7 11461.6 11512.3 19779.2 19841.1 19885.0 19889.8 19958.9 8034.0 8119.3 8295.3 8337.5 8501.3 4664.9 4674.0 4683.0 4699.7 4721.4 3448.1 3450.9 3453.2 3473.4 3477.4 571.2 578.5 578.9 586.1 588.5 644.8 721.9 722.6 747.7 750.7 9885.0 9888.8 9911.9 9912.9 9961.8 649.7 689.2 697.0 715.1 734.7 4336.6 4361.4 4403.5 4416.0 4460.4 60503.0 60735.7 61058.4 61334.1 61441.7 52583.5 53559.0 53713.0 53779.2 54112.0 47092.3 47116.8 47563.3 47639.6 47902.5 8410.8 8578.7 8614.1 8621.7 8629.7 36785.8 37495.0 37936.8 38579.8 38668.2 47802.5 48414.3 48581.8 48972.5 49174.3 11118.3 11171.2 11244.6 11254.8 11285.7 11939.5 11972.7 12020.9 12047.5 12072.3 11158.8 11484.1 11499.8 11514.8 11588.2 10357.2 10689.9 11045.7 11692.6 11749.6 11248.7 11262.1 11867.1 12090.9 12829.1 10637.0 10655.9 10707.7 10805.8 10868.0 10324.5 10420.7 10585.7 10637.7 10778.9 19:24:45 INFO - PROCESS | 20028 | -------- Summary: end -------- 19:24:45 INFO - PROCESS | 20028 | 19:24:45 INFO - TEST-INFO | 20028: exit 0 19:24:45 INFO - TEST-OK | dromaeo_css | took 1108927ms 19:24:45 INFO - TEST-START | kraken 19:24:45 INFO - operating with platform_type : linux_ 19:24:45 INFO - Initialising browser for kraken test... 19:24:45 INFO - TEST-INFO | started process 20276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpauJBV5/profile http://localhost:56661/getInfo.html) 19:24:49 INFO - PROCESS | 20276 | 19:24:49 INFO - PROCESS | 20276 | (process:20354): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:24:50 INFO - PROCESS | 20276 | __metrics Screen width/height:1600/1200 19:24:50 INFO - PROCESS | 20276 | colorDepth:24 19:24:50 INFO - PROCESS | 20276 | Browser inner width/height: 1024/697 19:24:50 INFO - PROCESS | 20276 | __metrics 19:24:50 ERROR - PROCESS | 20276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 19:24:51 INFO - TEST-INFO | 20276: exit 0 19:24:51 INFO - Browser initialized. 19:24:51 INFO - Running cycle 1/1 for kraken test... 19:24:51 INFO - TEST-INFO | started process 20404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpauJBV5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:53 INFO - PROCESS | 20404 | 19:24:53 INFO - PROCESS | 20404 | (process:20471): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:25:03 INFO - PROCESS | 20404 | RSS: Main: 149417984 19:25:03 INFO - PROCESS | 20404 | 19:25:06 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56661/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:06 INFO - PROCESS | 20404 | RSS: Main: 154509312 19:25:06 INFO - PROCESS | 20404 | 19:25:09 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56661/tests/kraken/driver.html?testName=audio-dft) 19:25:09 INFO - PROCESS | 20404 | RSS: Main: 154599424 19:25:09 INFO - PROCESS | 20404 | 19:25:12 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56661/tests/kraken/driver.html?testName=audio-fft) 19:25:13 INFO - PROCESS | 20404 | RSS: Main: 155049984 19:25:13 INFO - PROCESS | 20404 | 19:25:15 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56661/tests/kraken/driver.html?testName=audio-oscillator) 19:25:16 INFO - PROCESS | 20404 | RSS: Main: 154882048 19:25:16 INFO - PROCESS | 20404 | 19:25:18 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:18 INFO - PROCESS | 20404 | RSS: Main: 154898432 19:25:18 INFO - PROCESS | 20404 | 19:25:21 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56661/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:22 INFO - PROCESS | 20404 | RSS: Main: 154857472 19:25:22 INFO - PROCESS | 20404 | 19:25:25 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56661/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:26 INFO - PROCESS | 20404 | RSS: Main: 155017216 19:25:26 INFO - PROCESS | 20404 | 19:25:29 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56661/tests/kraken/driver.html?testName=json-parse-financial) 19:25:29 INFO - PROCESS | 20404 | RSS: Main: 155344896 19:25:29 INFO - PROCESS | 20404 | 19:25:31 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:32 INFO - PROCESS | 20404 | RSS: Main: 155467776 19:25:32 INFO - PROCESS | 20404 | 19:25:33 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:34 INFO - PROCESS | 20404 | RSS: Main: 155521024 19:25:34 INFO - PROCESS | 20404 | 19:25:36 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:37 INFO - PROCESS | 20404 | RSS: Main: 155762688 19:25:37 INFO - PROCESS | 20404 | 19:25:39 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:40 INFO - PROCESS | 20404 | RSS: Main: 155906048 19:25:40 INFO - PROCESS | 20404 | 19:25:42 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:43 INFO - PROCESS | 20404 | RSS: Main: 155656192 19:25:43 INFO - PROCESS | 20404 | 19:25:44 INFO - PROCESS | 20404 | Cycle 1(1): loaded http://localhost:56661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56661/tests/kraken/driver.html?testName=ai-astar) 19:25:45 INFO - PROCESS | 20404 | RSS: Main: 157282304 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | __start_tp_report 19:25:45 INFO - PROCESS | 20404 | _x_x_mozilla_page_load 19:25:45 INFO - PROCESS | 20404 | _x_x_mozilla_page_load_details 19:25:45 INFO - PROCESS | 20404 | |i|pagename|runs| 19:25:45 INFO - PROCESS | 20404 | |0;ai-astar;112;103;111;112;111;121;110;112;112;112 19:25:45 INFO - PROCESS | 20404 | |1;audio-beat-detection;160;128;154;173;128;156;156;129;171;129 19:25:45 INFO - PROCESS | 20404 | |2;audio-dft;163;164;162;175;163;162;165;164;166;163 19:25:45 INFO - PROCESS | 20404 | |3;audio-fft;73;77;77;172;77;77;73;74;188;76 19:25:45 INFO - PROCESS | 20404 | |4;audio-oscillator;93;92;142;93;93;92;147;94;105;140 19:25:45 INFO - PROCESS | 20404 | |5;imaging-gaussian-blur;117;118;118;117;116;117;117;118;118;118 19:25:45 INFO - PROCESS | 20404 | |6;imaging-darkroom;148;146;146;146;148;147;146;148;148;146 19:25:45 INFO - PROCESS | 20404 | |7;imaging-desaturate;95;101;101;96;104;96;95;96;96;95 19:25:45 INFO - PROCESS | 20404 | |8;json-parse-financial;55;57;56;54;55;55;57;57;56;60 19:25:45 INFO - PROCESS | 20404 | |9;json-stringify-tinderbox;65;64;64;64;65;64;64;63;65;65 19:25:45 INFO - PROCESS | 20404 | |10;stanford-crypto-aes;79;81;79;84;78;79;80;80;81;79 19:25:45 INFO - PROCESS | 20404 | |11;stanford-crypto-ccm;117;113;121;115;114;118;114;120;112;112 19:25:45 INFO - PROCESS | 20404 | |12;stanford-crypto-pbkdf2;145;150;145;143;149;155;137;153;147;134 19:25:45 INFO - PROCESS | 20404 | |13;stanford-crypto-sha256-iterative;68;66;69;66;68;68;65;66;65;70 19:25:45 INFO - PROCESS | 20404 | __end_tp_report 19:25:45 INFO - PROCESS | 20404 | __start_cc_report 19:25:45 INFO - PROCESS | 20404 | _x_x_mozilla_cycle_collect,826 19:25:45 INFO - PROCESS | 20404 | __end_cc_report 19:25:45 INFO - PROCESS | 20404 | __startTimestamp1463538345096__endTimestamp 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | ------- Summary: start ------- 19:25:45 INFO - PROCESS | 20404 | Number of tests: 14 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:4.30 (3.8%) stddev-sans-first:4.56 19:25:45 INFO - PROCESS | 20404 | Values: 112.0 103.0 111.0 112.0 111.0 121.0 110.0 112.0 112.0 112.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:156.00 stddev:18.20 (11.7%) stddev-sans-first:18.82 19:25:45 INFO - PROCESS | 20404 | Values: 160.0 128.0 154.0 173.0 128.0 156.0 156.0 129.0 171.0 129.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.83 (2.3%) stddev-sans-first:4.01 19:25:45 INFO - PROCESS | 20404 | Values: 163.0 164.0 162.0 175.0 163.0 162.0 165.0 164.0 166.0 163.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#3] audio-fft Cycles:10 Average:96.40 Median:76.50 stddev:44.25 (57.8%) stddev-sans-first:46.12 19:25:45 INFO - PROCESS | 20404 | Values: 73.0 77.0 77.0 172.0 77.0 77.0 73.0 74.0 188.0 76.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.50 stddev:23.76 (25.7%) stddev-sans-first:24.48 19:25:45 INFO - PROCESS | 20404 | Values: 93.0 92.0 142.0 93.0 93.0 92.0 147.0 94.0 105.0 140.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 19:25:45 INFO - PROCESS | 20404 | Values: 117.0 118.0 118.0 117.0 116.0 117.0 117.0 118.0 118.0 118.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.50 stddev:0.99 (0.7%) stddev-sans-first:0.97 19:25:45 INFO - PROCESS | 20404 | Values: 148.0 146.0 146.0 146.0 148.0 147.0 146.0 148.0 148.0 146.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:95.50 stddev:3.24 (3.4%) stddev-sans-first:3.31 19:25:45 INFO - PROCESS | 20404 | Values: 95.0 101.0 101.0 96.0 104.0 96.0 95.0 96.0 96.0 95.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.69 (3.0%) stddev-sans-first:1.73 19:25:45 INFO - PROCESS | 20404 | Values: 55.0 57.0 56.0 54.0 55.0 55.0 57.0 57.0 56.0 60.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 19:25:45 INFO - PROCESS | 20404 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 63.0 65.0 65.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.70 (2.1%) stddev-sans-first:1.76 19:25:45 INFO - PROCESS | 20404 | Values: 79.0 81.0 79.0 84.0 78.0 79.0 80.0 80.0 81.0 79.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:116.00 stddev:3.24 (2.8%) stddev-sans-first:3.40 19:25:45 INFO - PROCESS | 20404 | Values: 117.0 113.0 121.0 115.0 114.0 118.0 114.0 120.0 112.0 112.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.00 stddev:6.60 (4.5%) stddev-sans-first:6.99 19:25:45 INFO - PROCESS | 20404 | Values: 145.0 150.0 145.0 143.0 149.0 155.0 137.0 153.0 147.0 134.0 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - PROCESS | 20404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.73 (2.5%) stddev-sans-first:1.80 19:25:45 INFO - PROCESS | 20404 | Values: 68.0 66.0 69.0 66.0 68.0 68.0 65.0 66.0 65.0 70.0 19:25:45 INFO - PROCESS | 20404 | -------- Summary: end -------- 19:25:45 INFO - PROCESS | 20404 | 19:25:45 INFO - TEST-INFO | 20404: exit 0 19:25:45 INFO - TEST-OK | kraken | took 60166ms 19:25:45 INFO - SUITE-END | took 1169s 19:25:46 INFO - Completed test suite (00:19:29) 19:25:46 INFO - javascript benchmark 19:25:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3294.5717056782614, 3388.762786604937, 3394.575678040245, 3420.931581368371, 3438.277961628058, 5520.861978450535, 5521.558275337973, 5536.141898005815, 5537.501624853768, 5571.108622620376, 5531.834044978657, 5559.916601250974, 5572.136318870582, 5576.832695019156, 5582.078956972095, 5087.033463641897, 5095.566876815476, 5147.7683504242395, 5162.199859021839, 5170.3795544534705, 4993.825216117437, 5109.872253193663, 5128.076946149691, 5191.844244672647, 5214.243934629495, 5059.822906198284, 5073.543381095701, 5105.081085404626, 5166.302549155872, 5199.272101905717, 5135.204043373283, 5169.508896654812, 5177.818776342829, 5178.0679477694, 5182.740862956837, 4920.360353154103, 4942.654014219006, 5153.613478989091, 5163.586913046985, 5176.7411629418375, 5345.305110335631, 5378.515933565998, 5387.892242155174, 5389.83830485086, 5405.567554595623, 5921.230240068763, 5951.404859514014, 5962.1951036609935, 5963.850903727398, 6015.639061656271, 6021.759129634809, 6025.367336429656, 6074.271087469488, 6108.816735497898, 6122.785702500391, 5595.580331475156, 5628.352739435018, 5645.802396916089, 5648.943510564924, 5656.377798442168, 5935.050391937356, 6131.202943617391, 6153.876922461525, 6155.692215389302, 6159.384061593894, 5799.5070419014855, 5840.883182336414, 5854.502367298742, 5854.502367298827, 5857.7949771757785, 5858.0, 5859.355470898197, 5893.882122357529, 5894.734736936763, 5900.940990590125, 5813.215215945877, 5860.589758716934, 5861.296644402699, 5870.589058765845, 5887.499562537147, 5981.431763982415, 5995.700214989233, 5998.760049597967, 5999.430054144849, 6030.7889223876955, 4557.1797076526545, 4557.680962332671, 4563.95436045642, 4575.519570445122, 4588.151192029485, 4011.538673052636, 4054.493188351456, 4055.1889622075114, 4109.465769450012, 4143.7928103594695, 5511.0, 5581.888362232814, 5665.461781130786, 5687.772489100473, 5697.259356283656, 5831.358550559435, 5901.911471327933, 5970.432808883149, 5993.0, 6005.519558435315, 5667.4615911488345, 5667.801626943037, 5669.291338582677, 5672.97163514188, 5676.914846277309, 4949.356583644103, 5049.192129259301, 5069.03688299222, 5087.287779710843, 5139.665921715151, 6135.0, 6191.783287584913, 6202.131701561785, 6233.252009758858, 6250.937490625036, 5866.941330586639, 6035.879282414415, 6046.606970546901, 6050.122732203894, 6053.152558641706, 6151.72317245716, 6185.381461853779, 6221.96889015552, 6245.531585131042, 6258.655773932295, 5891.1752354671235, 5894.351621321565, 5895.086261629454, 5925.259342582177, 5967.522598192221, 5928.347881733092, 5955.255593050869, 5965.642061476326, 6002.33974262822, 6009.939900600938, 5804.1293805929445, 5807.8548036299435, 5811.099279611667, 5841.1238314253205, 5842.678652673973, 5729.427057294237, 5735.9139612905, 5782.797602084075, 5802.94197058024, 5834.124881267844, 5586.1062230043, 5682.715864206691, 5731.197632331394, 5737.08206686928, 5748.310202775694, 5914.615549989237, 5974.2830860297045, 5990.251218597676, 5994.3705910878725, 6004.969975150097, 5808.332041815245, 5837.445442682938, 5838.678872661874, 5849.034909239927, 5849.444302791228], "unit": "score", "name": "dojo.html", "value": 5512.560737470705}, {"lowerIsBetter": false, "replicates": [498.9376327959005, 551.8824380629226, 557.2087635557509, 567.9517241034513, 568.3833041150351, 39145.60854391459, 39658.40512392316, 39703.80148099259, 39789.403158952606, 39874.20251594966, 43110.353344699855, 43645.345319820146, 43737.343939840925, 43912.121757564826, 43949.12101757963, 8837.95581022094, 9014.45913245204, 9055.728328150166, 9064.320175986795, 9073.047330030318, 8805.20753132218, 8945.239654629331, 8954.417962832395, 9153.405028673114, 9155.816883662323, 9137.223336016446, 9153.771155721093, 9155.404898681598, 9163.175314221719, 9203.0, 9011.684591039315, 9108.089191080871, 9118.726438206897, 9140.131687489678, 9184.816303673955, 9078.409903356262, 9096.317776166814, 9161.541922903829, 9172.954135229347, 9182.08179182083, 43574.128517429475, 43901.341479877825, 44030.779846100566, 44140.55859441397, 44144.3378349325, 3683.907902302437, 3785.0, 3974.5826688197612, 4299.204647140289, 4346.782660866944, 32653.346933061443, 33152.83423582867, 33362.6663733362, 33411.6658833411, 33421.83289083539, 4344.087741574242, 4373.956260437387, 4412.360207769888, 4485.9102817943785, 4511.503734589192, 298060.99999999785, 298377.0, 301152.4942375296, 301234.0, 301487.0, 46745.53254467412, 47051.0, 47213.29180062302, 47319.76340118346, 63963.36036639667, 44530.0, 44673.776631116634, 44717.0, 44870.775646122216, 45031.77484112558, 16101.67796644084, 16234.918825405797, 16308.510744677678, 16336.264868080965, 16357.509274721539, 12907.741845163044, 13009.0, 13014.21914685122, 13022.609321720363, 13130.27783471899, 15802.68394632124, 15816.130112843904, 15818.367265309489, 15823.683526329409, 15826.841731582766, 5832.104566016062, 5962.19510366095, 5970.253718285215, 6033.909491357633, 6090.269167699816, 1058.3914249306679, 1063.2716589136467, 1082.6427278997912, 1110.5169251375678, 1151.5221183208876, 29672.0, 30459.0, 30507.847460762998, 30817.38365232683, 30956.535651965238, 1104.9889501104885, 1124.8875112488686, 1138.8348689439986, 1162.8255761635821, 1252.6242127361754, 16014.19929003545, 16127.0, 16140.515784526482, 16310.836891631168, 16337.83662163363, 338381.0, 561484.0, 578275.0, 583945.0, 589486.0, 56233.15650265249, 56998.7150064247, 57017.42982570204, 57112.0, 57135.428645713844, 1431.1556181852757, 1509.4037855047413, 1513.2660659579874, 1518.3395223077996, 1532.2109113806175, 30684.693153068183, 31771.682283176873, 32027.0, 32035.059872319085, 32299.838500807346, 50284.49715502798, 51169.232461512365, 51351.48648513467, 51389.0, 51499.227511588106, 306238.0, 313128.0, 314577.0, 314728.0, 315627.0, 35149.824250878584, 35384.64615353814, 35531.82234088813, 35578.46632300466, 35813.28373432464, 47368.52631473641, 47675.761621191676, 47874.0, 48676.51323486862, 48779.0, 39130.6086939127, 39255.80372098121, 39482.80258598689, 39544.01139971524, 39744.403833941935, 38169.618303816605, 38824.07559941888, 39387.60612393839, 40190.397144042276, 40368.19263614652, 38615.2276954465, 39645.207095858495, 39827.40258896177, 39908.40137397999, 40203.798981006075, 33874.32251355008, 34246.828765856015, 34433.0, 35035.824820875736, 35184.47223291704, 26602.334941626614, 27227.0, 27342.863285683445, 27410.588841167, 27634.585481217397], "unit": "score", "name": "ext.html", "value": 19536.268479475322}, {"lowerIsBetter": false, "replicates": [342.9794212347259, 354.5745105872953, 358.9712822974162, 361.1783193235391, 367.1244082862374, 17556.73664895026, 17610.295588176472, 18163.54591135219, 18365.173567189475, 18396.35612753554, 11797.115216358765, 12212.633620991362, 12223.083268754834, 12232.38838058098, 16838.326466941337, 5116.258142569334, 5158.509941555565, 5159.871003224912, 5256.500632439912, 5258.55302299305, 5136.357955255593, 5200.32395788547, 5200.583953283728, 5215.426303106655, 5232.032074066291, 5189.8183563575285, 5199.506046925536, 5204.42751297357, 5238.0, 5296.602754793386, 5278.604104692164, 5499.202615620733, 5512.035393806108, 5520.861978450531, 5526.032944234763, 5167.7932882684645, 5259.447757985395, 5315.920261196085, 5352.090144675414, 5388.461153884619, 13313.86686133136, 13638.386272617756, 13731.519396821062, 13892.0, 13906.93046534771, 2301.8849057547222, 2310.6302991521275, 2389.6057150570136, 2430.5746494363593, 2433.914812981537, 9994.250431217688, 10189.184865210766, 10234.53944572496, 10409.0, 12833.973282137407, 1900.88594684318, 1946.1728765274843, 1951.0732402109027, 1984.9206031758713, 2000.5098750806146, 48377.51622483765, 58110.0, 59634.70182649102, 64064.0, 64806.67596661986, 10132.189424846141, 10477.42374169428, 10479.633212837514, 10567.365958042543, 10653.84019239712, 14474.565763027125, 14503.92748036253, 14596.41614335436, 14615.26923653813, 14618.85381146175, 7828.0, 7951.801204969922, 7999.600019998977, 8030.879536806952, 8088.352931765445, 7693.846123077619, 7733.574653394117, 7789.260020298176, 7841.255080767318, 7929.920700793034, 4419.889502762392, 4573.176828170895, 4645.140648979949, 4681.29780532916, 4729.527047295243, 1942.9222831086881, 1948.1428171604448, 1977.7428934238744, 1989.651810933081, 2041.4181958141858, 965.4593427680521, 969.0, 993.7913038262046, 994.5673631970116, 1032.6850310655173, 17237.655246894992, 17284.0, 17292.394766183123, 17599.03205323694, 17932.282708691768, 1001.2540657210279, 1035.5598870480017, 1040.1003132290514, 1040.6305761454726, 1092.4919912240846, 8237.382196335298, 9978.513492629409, 10189.337693049929, 10217.438040907673, 10337.844932326021, 343738.0, 350763.0, 351503.0, 434334.0, 441539.0, 69637.0, 71701.0, 75208.0, 80273.0, 80479.59760201279, 1068.156156636264, 1096.2928910852456, 1113.554578168739, 1115.1636272795404, 1120.4117838134882, 15867.444639437565, 16109.355625774837, 16287.837121628632, 16454.917725411295, 16657.3337066516, 35043.0, 35323.64676353204, 35716.28567428689, 35932.10169745777, 36204.27591448209, 49072.50927490679, 49326.26010609916, 49761.75119124381, 49764.00471990612, 50144.49855501398, 8366.372522060992, 8395.916040839513, 8431.53626550521, 8504.0, 8585.313174945864, 12750.171238869443, 12782.552610658582, 12856.807147892976, 13103.0, 13123.737525249251, 7935.0874649416055, 11246.887531124585, 11257.71855703614, 11289.943550282196, 11530.423478825858, 10020.549075291776, 10477.266591338837, 11013.174011949297, 11139.10887129044, 11340.489677964677, 10376.429296388771, 11253.88746112561, 11326.37704926237, 11410.087193024705, 11449.42752862337, 8422.32621390275, 8426.03100643434, 8461.703840365557, 8574.27118694918, 8789.296856251613, 11358.148138889781, 11446.0, 11637.592684256011, 11728.237664551776, 11765.52937882475], "unit": "score", "name": "jquery.html", "value": 8485.980291445312}, {"lowerIsBetter": false, "replicates": [1632.183908045977, 1654.346533119418, 1871.728599353093, 1954.1890115602025, 2004.7694515130765, 8420.284275836553, 8485.745427637174, 8495.575221238929, 8604.741857744262, 8693.608787604557, 8587.184217499327, 8623.611937462814, 8664.74005779826, 8702.825943481126, 8720.91279087209, 2451.693538307716, 2480.255923223035, 2482.416632091457, 2494.950100997979, 2499.600063989762, 2443.816713746467, 2497.887595058227, 2499.0378704198924, 2505.361132911105, 2508.535920854639, 2471.7281099079087, 2475.554400207971, 2510.3975045989014, 2514.3462699698025, 2514.710808257046, 2468.395243165418, 2488.6515887775727, 2504.5742223821903, 2514.2959971208093, 2515.308290220186, 2524.394145405108, 2538.111660918682, 2549.349915771485, 2570.832895861763, 2573.8327008744373, 8597.398182127254, 8601.741947741577, 8618.310535157236, 8639.784005399852, 8656.220940115358, 5115.079285728568, 5241.109011468059, 5278.551323137538, 5282.3925248596515, 5308.814191503279, 3276.1645780325866, 3278.393497203001, 3343.531905533203, 3347.6150242722156, 3385.5768028996376, 1005.8073399988023, 1012.5392946209531, 1034.2243317511866, 1072.0994364733583, 1072.3083611070895, 12170.452329645188, 12244.326562039085, 12272.631821045472, 12272.815907761391, 12296.323702196376, 4438.312061630452, 4450.443694538183, 4482.641388688897, 4535.115652447807, 4553.817847286072, 9719.076687714656, 9739.074787895139, 9741.220702343795, 9789.755256118655, 9832.557534910946, 5026.824061157842, 5042.924356134661, 5068.315777370008, 5071.137906555894, 5081.8475445736685, 4127.9587204128175, 4539.319102134707, 4684.273937539687, 4735.739534325577, 4748.121597504403, 3748.1004558905665, 3759.3045286622064, 3779.3575092234387, 3811.9047023824073, 3825.5600605930117, 1130.0225305111185, 1130.4743294368159, 1132.5469812075237, 1136.2216881436243, 1136.8181091025397, 1480.3560451203762, 1481.9851801481848, 1483.4437086092714, 1484.2282013352997, 1519.7568389057699, 8229.547374894319, 8278.544680042656, 8284.337253019745, 8286.46138001028, 8308.335333173332, 513.9177731563007, 518.0726499565735, 522.605432898167, 531.6030564691623, 532.9813456529002, 6225.159603453566, 6239.96880015597, 6263.561550691499, 6271.05934109878, 6303.338149494237, 10408.323458975143, 10711.410872401937, 10833.02502774754, 10893.509792059376, 10896.0, 10364.585416583403, 10554.155667546578, 10560.366378017343, 10633.043026127685, 10643.467826608794, 8240.670373185125, 8258.463199891989, 8279.172082791672, 8281.171882811792, 8286.254237118568, 7893.447458677838, 7954.363650907798, 7968.561729104955, 7977.680892764457, 7990.200979901963, 9346.345755797029, 9363.953180234055, 9580.0, 9613.327067105236, 9691.224702023963, 9602.135807777333, 9672.322937394596, 9716.417014979124, 9745.902540974499, 9795.412275263507, 7235.2764723527225, 7280.0, 7344.485885988143, 7441.069866266716, 7496.550206987598, 8005.8398832024195, 8107.22981316774, 8113.6754529818145, 8114.878276825971, 8154.592270386575, 7279.636018198963, 7377.225391334047, 7450.0, 7491.513051651626, 7550.169481357156, 7260.056192694916, 7297.087864016998, 7310.451716121419, 7331.41348692114, 7378.889316660362, 7753.185915479019, 7770.8834367483405, 7825.334846538108, 7830.412719046209, 7896.7236146734585, 6965.0, 7004.964975175091, 7038.577685338896, 7054.611996340251, 7139.714411423693, 7214.206437291999, 7244.818879528054, 7263.273672632695, 7272.563646181246, 7284.963575182091], "unit": "score", "name": "mootools.html", "value": 4823.746166949544}, {"lowerIsBetter": false, "replicates": [337.0898573850604, 341.1437292396085, 358.21908240036726, 360.7492792509204, 361.5209846952788, 6334.809955701337, 6339.841503962403, 6359.65021923794, 6380.3300653431415, 6386.457151142153, 6262.0, 6267.655278959667, 6273.529485288599, 6276.560640755149, 6285.842853928654, 4671.976640116794, 4815.0, 4899.363082799231, 4910.901781964359, 4956.826511072113, 4931.482194369575, 4938.827141050064, 4956.3804524434445, 4966.106100901836, 4983.053219888227, 4915.066137433876, 4920.286558449023, 4923.0, 4923.532264434873, 4942.604591632678, 4933.038057578791, 4934.358533390654, 4935.629827762897, 4944.554990050912, 4944.752762361885, 4369.672274579388, 4369.694121411502, 4374.496932852699, 4375.978120109411, 4376.606105450524, 5908.556858235649, 6007.309159446676, 6048.637081775064, 6054.0, 6068.271807383098, 5762.9135562966585, 5777.88444231113, 5780.450857168562, 5788.363280039192, 5792.189093526909, 6652.50106242029, 6707.832304192434, 6735.528513004092, 6737.225219099817, 6767.42476889465, 4837.371141751585, 4842.41890973082, 4844.20070688336, 4848.151573474628, 4853.029394121155, 6999.790006299819, 7017.157941047056, 7024.859502809966, 7036.964815175891, 7037.190723066861, 4659.4175728034, 4800.687955282895, 4814.133455977888, 4983.053219888209, 4987.725675087832, 4800.447948485899, 4816.735079570587, 4817.229243321051, 4925.482824303468, 4925.926111108336, 5683.488486036276, 5685.061964775766, 5694.08894576874, 5701.572382071361, 5707.258056452634, 6837.35045170708, 6847.07564478789, 6849.280825513349, 6855.7600483983815, 6862.0, 1732.8440440360428, 1754.9385771497937, 1755.6049888774924, 1757.7099778536399, 1760.9559761006078, 1096.7970925378831, 1133.0708818768696, 1138.1122724275078, 1149.7642983188425, 1154.1459320103063, 6491.058796474485, 6537.5750576212395, 6539.8365040873405, 6567.770128045496, 6583.407493325623, 6989.0564773755905, 7009.754658586925, 7022.719091236293, 7030.261822508563, 7038.5073044887395, 6359.904601430982, 6446.161998940202, 6461.289258181596, 6463.741450341934, 6489.123968264318, 3760.830762615689, 3784.2242340320167, 3791.431285307226, 3799.1072098056934, 3801.5248093988253, 7159.319864612853, 7245.963770181115, 7277.927220727831, 7305.050343455317, 7309.5248808827255, 7263.491555591164, 7278.053852999076, 7289.635518224068, 7291.270872912666, 7312.634368281671, 7156.570605763671, 7320.743773967992, 7321.304476074764, 7337.119545654556, 7341.963290183515, 7056.788296351117, 7074.080369552131, 7076.0447339610555, 7080.468964827555, 7089.680964356719, 6993.545419547713, 6995.0906382172025, 6997.510174287751, 7000.0, 7001.264867189076, 7202.783916482514, 7296.7081316746735, 7329.816754581178, 7330.120385553768, 7346.449016323691, 4773.64197685182, 4816.446108697404, 4819.879503012313, 4822.300766388924, 4822.42130944289, 7036.296370362923, 7055.223925368308, 7059.294070593105, 7062.223155452793, 7066.858662826612, 6885.139357580302, 6885.2770459101075, 6887.552309099892, 6894.620795856075, 6895.379415852597, 6867.141607299088, 6870.553414028072, 6881.311868813079, 6884.036234927014, 6890.10428644273, 6510.316416776171, 6756.898646520404, 6765.323467653392, 6773.93226067733, 6774.762883299061, 6862.245153033063, 6871.896921546081, 6898.655067246517, 6910.170779506491, 6925.065116209247, 6704.932950670626, 6769.966150169218, 6801.591904485746, 6826.897596535957, 6828.975653651992], "unit": "score", "name": "prototype.html", "value": 5147.049722387656}, {"lowerIsBetter": false, "replicates": [757.7650928212255, 762.0436352377765, 863.128240477118, 874.8469017921863, 880.7886107334242, 12743.362831858405, 12984.156029858053, 12984.156029858064, 12987.67530811729, 13002.804957925615, 14016.439342426316, 14725.779113313309, 14797.186154761484, 14814.629634259149, 14904.254787260648, 790.5888937752366, 933.9673111441101, 934.0612684252317, 951.4909523404945, 954.5370495309769, 937.4000639590668, 940.7601061729249, 941.3833938770082, 942.0908822985817, 942.9292803039765, 992.2508506077937, 996.4768496539302, 996.7308826616845, 996.7458298133965, 999.400359784131, 985.0, 988.7083310423442, 991.3506653142167, 993.7316924430436, 993.8906720260766, 728.9854202915965, 729.9598522081336, 733.7248531800575, 734.0567370928385, 734.2217249715319, 15219.162946037963, 15242.237888105661, 15293.6176595586, 15326.923365383213, 15341.923290383476, 14269.571912842632, 14365.569032929028, 14406.567802965928, 14483.78274325886, 14539.0, 11551.306921584648, 11577.76844463106, 11600.535978560847, 11718.589849355232, 11763.176577639482, 4000.899977500557, 4023.959760402388, 4030.1536677297804, 4075.3071977763852, 4078.3678529827625, 52003.95992080175, 52193.2171017435, 52293.0, 52570.0, 52576.0, 11067.335959842436, 11242.943785281184, 11393.715157121138, 11461.598844040585, 11512.251703639236, 19779.20883164686, 19841.107150178275, 19885.0, 19889.801101988796, 19958.900205498878, 8033.955585773812, 8119.309858661962, 8295.294899933453, 8337.541435221, 8501.277391421674, 4664.883377915511, 4674.041821426599, 4683.0, 4699.741514216683, 4721.433427988663, 3448.1207292140843, 3450.861965521401, 3453.223024819446, 3473.4095203815414, 3477.4088404971217, 571.1832080125378, 578.4822583787486, 578.9305283366023, 586.0593747036031, 588.5321169670123, 644.7717098926553, 721.8772808622547, 722.6134018300185, 747.7457664394132, 750.6584504050644, 9885.0, 9888.802223955481, 9911.851322230172, 9912.900870991341, 9961.765935838495, 649.746598826458, 689.2005273882272, 696.9616671083139, 715.1239731329184, 734.7391675955066, 4336.588024137702, 4361.433013708261, 4403.515613282536, 4415.955840441618, 4460.420145381079, 60503.0, 60735.69632151899, 61058.38941610527, 61334.0799888002, 61441.69279153576, 52583.47416525862, 53559.0, 53713.0, 53779.19331210035, 54112.0, 47092.293615595794, 47116.7644161777, 47563.28655070177, 47639.643230853006, 47902.5209747905, 8410.831783364421, 8578.742637720878, 8614.138586141586, 8621.741347759576, 8629.741107766777, 36785.81607092055, 37495.0, 37936.81031594824, 38579.80710096432, 38668.22663546657, 47802.521974779804, 48414.27378589253, 48581.75709121432, 48972.5102748968, 49174.262386064955, 11118.332900026024, 11171.218014739216, 11244.606438774603, 11254.7749045017, 11285.71785705331, 11939.52241910314, 11972.700682483008, 12020.918117369478, 12047.518099276282, 12072.29601233888, 11158.776824463628, 11484.081273497934, 11499.770004599693, 11514.827277590675, 11588.246763960316, 10357.22320825926, 10689.9465502672, 11045.668629941114, 11692.590759323723, 11749.588764393206, 11248.718782030188, 11262.09903207725, 11867.109966752701, 12090.879091208975, 12829.10196286251, 10637.042666160083, 10655.89344106549, 10707.732306692395, 10805.783884322427, 10868.0, 10324.535395907053, 10420.68737937863, 10585.735356616146, 10637.680869573926, 10778.946105269424], "unit": "score", "name": "yui.html", "value": 6838.737949974631}], "name": "dromaeo_css", "value": 7330.637397710608}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 103.0, 111.0, 112.0, 111.0, 121.0, 110.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 154.0, 173.0, 128.0, 156.0, 156.0, 129.0, 171.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 175.0, 163.0, 162.0, 165.0, 164.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 77.0, 172.0, 77.0, 77.0, 73.0, 74.0, 188.0, 76.0], "unit": "score", "name": "audio-fft", "value": 96.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 142.0, 93.0, 93.0, 92.0, 147.0, 94.0, 105.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 148.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 101.0, 101.0, 96.0, 104.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 97.5}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 54.0, 55.0, 55.0, 57.0, 57.0, 56.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 79.0, 84.0, 78.0, 79.0, 80.0, 80.0, 81.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 121.0, 115.0, 114.0, 118.0, 114.0, 120.0, 112.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.6}, {"lowerIsBetter": true, "replicates": [145.0, 150.0, 145.0, 143.0, 149.0, 155.0, 137.0, 153.0, 147.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 69.0, 66.0, 68.0, 68.0, 65.0, 66.0, 65.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1520.9999999999998}]} 19:25:46 INFO - Return code: 0 19:25:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:25:46 ERROR - # TBPL SUCCESS # 19:25:46 INFO - Running post-action listener: _resource_record_post_action 19:25:46 INFO - Running post-run listener: _resource_record_post_run 19:25:47 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 459886592; Read time: 0; Write time: 306304 19:25:47 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237326336; Read time: 0; Write time: 204400 19:25:47 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 222179328; Read time: 0; Write time: 101876 19:25:47 INFO - Running post-run listener: _upload_blobber_files 19:25:47 INFO - Blob upload gear active. 19:25:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25:47 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 19:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:25:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:25:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:25:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:48 INFO - (blobuploader) - INFO - Done attempting. 19:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:49 INFO - (blobuploader) - INFO - Done attempting. 19:25:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:49 INFO - Return code: 0 19:25:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35edcd6f955751a8aaad4125b6e0ef6bf23860d01e2cdb2714bfea954472950a40b818c1acb5b0e179241201ba8f57ecb62a93b81e08906e9c8a25630c62a145", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c82ee6b14b2c148d7b6c9e7ad57facacdf60c3a222043ff86e655999475649379acb7ceb4efef48850dee9a42fa6bb68b9ed02935e3d7d970d6fa56d4c6e896d"} 19:25:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:49 INFO - Contents: 19:25:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35edcd6f955751a8aaad4125b6e0ef6bf23860d01e2cdb2714bfea954472950a40b818c1acb5b0e179241201ba8f57ecb62a93b81e08906e9c8a25630c62a145", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c82ee6b14b2c148d7b6c9e7ad57facacdf60c3a222043ff86e655999475649379acb7ceb4efef48850dee9a42fa6bb68b9ed02935e3d7d970d6fa56d4c6e896d"} 19:25:49 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:49 INFO - Copying logs to upload dir... 19:25:49 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.608880 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-17 19:25:49.514265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 19:25:49.517915) ========= 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=32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907 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-Beta/sha512/35edcd6f955751a8aaad4125b6e0ef6bf23860d01e2cdb2714bfea954472950a40b818c1acb5b0e179241201ba8f57ecb62a93b81e08906e9c8a25630c62a145", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c82ee6b14b2c148d7b6c9e7ad57facacdf60c3a222043ff86e655999475649379acb7ceb4efef48850dee9a42fa6bb68b9ed02935e3d7d970d6fa56d4c6e896d"} build_url:https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/O6u_CSLZR9-KZRtaKVo-Uw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35edcd6f955751a8aaad4125b6e0ef6bf23860d01e2cdb2714bfea954472950a40b818c1acb5b0e179241201ba8f57ecb62a93b81e08906e9c8a25630c62a145", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c82ee6b14b2c148d7b6c9e7ad57facacdf60c3a222043ff86e655999475649379acb7ceb4efef48850dee9a42fa6bb68b9ed02935e3d7d970d6fa56d4c6e896d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 19:25:49.547749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:25:49.548489) ========= 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=32c5991c409366f7fec8a718000001d2-1463536525.968776-1020260907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 19:25:49.634238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 19:25:49.634916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 19:25:49.635578) ========= ========= Total master_lag: 0.20 =========