builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1461971372.77 results: success (0) buildid: 20160429133634 builduid: 978fae549a734e23b520b62985c9b2c1 revision: 259d41769207bbf0a55afe7475fc3a71f8a5d724 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.773980) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.774478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.774762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.867911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.868211) ========= 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=cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 16:09:32-- 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% 43.0M=0s 2016-04-29 16:09:33 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.431173 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.327534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.327863) ========= 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=cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.064639 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.403598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.403946) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 259d41769207bbf0a55afe7475fc3a71f8a5d724 --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 259d41769207bbf0a55afe7475fc3a71f8a5d724 --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=cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 16:09:33,474 truncating revision to first 12 chars 2016-04-29 16:09:33,475 Setting DEBUG logging. 2016-04-29 16:09:33,475 attempt 1/10 2016-04-29 16:09:33,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/259d41769207?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 16:09:34,113 unpacking tar archive at: mozilla-beta-259d41769207/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:34.316672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:34.316987) ========= script_repo_revision: 259d41769207bbf0a55afe7475fc3a71f8a5d724 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:34.317373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:34.317637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:34.325941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 27 secs) (at 2016-04-29 16:09:34.326279) ========= /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=cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:09:34 INFO - MultiFileLogger online at 20160429 16:09:34 in /builds/slave/test 16:09:34 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 16:09:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:34 INFO - {'append_to_log': False, 16:09:34 INFO - 'base_work_dir': '/builds/slave/test', 16:09:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:09:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:34 INFO - 'branch': 'Mozilla-Beta', 16:09:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:34 INFO - 'config_files': ('talos/linux_config.py',), 16:09:34 INFO - 'default_actions': ('clobber', 16:09:34 INFO - 'read-buildbot-config', 16:09:34 INFO - 'download-and-extract', 16:09:34 INFO - 'populate-webroot', 16:09:34 INFO - 'create-virtualenv', 16:09:34 INFO - 'install', 16:09:34 INFO - 'run-tests'), 16:09:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:34 INFO - 'download_minidump_stackwalk': True, 16:09:34 INFO - 'download_symbols': 'ondemand', 16:09:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:34 INFO - 'installer_path': 'installer.exe', 16:09:34 INFO - 'log_level': 'info', 16:09:34 INFO - 'log_name': 'talos', 16:09:34 INFO - 'log_to_console': True, 16:09:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:09:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:09:34 INFO - 'opt_config_files': (), 16:09:34 INFO - 'pip_index': False, 16:09:34 INFO - 'sps_profile': False, 16:09:34 INFO - 'sps_profile_interval': 0, 16:09:34 INFO - 'suite': 'dromaeojs-e10s', 16:09:34 INFO - 'system_bits': '32', 16:09:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:34 INFO - 'title': 'talos-linux64-ix-054', 16:09:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:34 INFO - 'use_talos_json': True, 16:09:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:34 INFO - 'work_dir': 'build'} 16:09:34 INFO - ##### 16:09:34 INFO - ##### Running clobber step. 16:09:34 INFO - ##### 16:09:34 INFO - Running pre-action listener: _resource_record_pre_action 16:09:34 INFO - Running main action method: clobber 16:09:34 INFO - rmtree: /builds/slave/test/build 16:09:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:36 INFO - Running post-action listener: _resource_record_post_action 16:09:36 INFO - ##### 16:09:36 INFO - ##### Running read-buildbot-config step. 16:09:36 INFO - ##### 16:09:36 INFO - Running pre-action listener: _resource_record_pre_action 16:09:36 INFO - Running main action method: read_buildbot_config 16:09:36 INFO - Using buildbot properties: 16:09:36 INFO - { 16:09:36 INFO - "project": "", 16:09:36 INFO - "product": "firefox", 16:09:36 INFO - "script_repo_revision": "production", 16:09:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:09:36 INFO - "repository": "", 16:09:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:09:36 INFO - "buildid": "20160429133634", 16:09:36 INFO - "pgo_build": "True", 16:09:36 INFO - "basedir": "/builds/slave/test", 16:09:36 INFO - "buildnumber": 69, 16:09:36 INFO - "slavename": "talos-linux64-ix-054", 16:09:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:09:36 INFO - "platform": "ubuntu64_hw", 16:09:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:09:36 INFO - "branch": "mozilla-beta", 16:09:36 INFO - "repo_path": "releases/mozilla-beta", 16:09:36 INFO - "revision": "259d41769207bbf0a55afe7475fc3a71f8a5d724", 16:09:36 INFO - "stage_platform": "linux64-pgo", 16:09:36 INFO - "builduid": "978fae549a734e23b520b62985c9b2c1", 16:09:36 INFO - "slavebuilddir": "test" 16:09:36 INFO - } 16:09:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:09:36 INFO - Running post-action listener: _resource_record_post_action 16:09:36 INFO - ##### 16:09:36 INFO - ##### Running download-and-extract step. 16:09:36 INFO - ##### 16:09:36 INFO - Running pre-action listener: _resource_record_pre_action 16:09:36 INFO - Running main action method: download_and_extract 16:09:36 INFO - mkdir: /builds/slave/test/build/tests 16:09: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')]} 16:09:36 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:09:39 INFO - Downloaded 1412 bytes. 16:09:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:39 INFO - Using the following test package requirements: 16:09:39 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:09:39 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:09:39 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:09:39 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'jsshell-linux-x86_64.zip'], 16:09:39 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:09:39 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:09:39 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:09:39 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:09:39 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:09:39 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:09:39 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:39 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:09:39 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:39 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:29 INFO - Downloaded 23363475 bytes. 16:12:29 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'] 16:12:29 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 16:12:30 INFO - Return code: 0 16:12:30 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 16:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:30 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:12:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:12:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:12:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:31 INFO - Downloaded 23363475 bytes. 16:12:31 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'] 16:12:31 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 16:12:33 INFO - Return code: 0 16:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:33 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:12:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:12:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:12:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:35 INFO - Downloaded 10845194 bytes. 16:12:35 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'] 16:12:35 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 16:12:36 INFO - Return code: 0 16:12: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')]} 16:12:36 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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 16:12:42 INFO - Downloaded 53781846 bytes. 16:12:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:12:42 INFO - mkdir: /builds/slave/test/properties 16:12:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:42 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:42 INFO - Contents: 16:12:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:12:43 INFO - Running post-action listener: _resource_record_post_action 16:12:43 INFO - Running post-action listener: set_extra_try_arguments 16:12:43 INFO - ##### 16:12:43 INFO - ##### Running populate-webroot step. 16:12:43 INFO - ##### 16:12:43 INFO - Running pre-action listener: _resource_record_pre_action 16:12:43 INFO - Running main action method: populate_webroot 16:12:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:43 INFO - '--tppagecycles', 16:12:43 INFO - '7'], 16:12:43 INFO - 'tests': ['tsvgm']}}, 16:12:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:12:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:12:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'tests': ['damp', 'tps']}, 16:12:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['damp', 'tps']}, 16:12:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:12:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:43 INFO - 'other': {'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other_l64': {'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other_nol64': {'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'svgr': {'tests': ['tsvgx', 16:12:43 INFO - 'tsvgr_opacity', 16:12:43 INFO - 'tart', 16:12:43 INFO - 'tscrollx', 16:12:43 INFO - 'cart']}, 16:12:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['tsvgx', 16:12:43 INFO - 'tsvgr_opacity', 16:12:43 INFO - 'tart', 16:12:43 INFO - 'tscrollx', 16:12:43 INFO - 'cart']}, 16:12:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'tests': ['tp5o']}, 16:12:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--e10s'], 16:12:43 INFO - 'tests': ['tp5o']}, 16:12:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--xperf_path', 16:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:43 INFO - 'tests': ['tp5n']}, 16:12:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--e10s', 16:12:43 INFO - '--xperf_path', 16:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:43 INFO - 'tests': ['tp5n']}}, 16:12:43 INFO - 'talos.zip': {'path': '', 16:12:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:43 INFO - Running post-action listener: _resource_record_post_action 16:12:43 INFO - ##### 16:12:43 INFO - ##### Running create-virtualenv step. 16:12:43 INFO - ##### 16:12:43 INFO - Running pre-action listener: _resource_record_pre_action 16:12:43 INFO - Running main action method: create_virtualenv 16:12:43 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:43 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 16:12:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:43 INFO - Using real prefix '/usr' 16:12:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:46 INFO - Installing pip.................done. 16:12:46 INFO - Return code: 0 16:12:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:12: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', 'pip>=1.5'] in /builds/slave/test/build 16:12: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 pip>=1.5 16:12:46 INFO - Using env: {'DISPLAY': ':0', 16:12:46 INFO - 'HOME': '/home/cltbld', 16:12:46 INFO - 'LANG': 'en_US.UTF-8', 16:12:46 INFO - 'LANGUAGE': 'en_US:en', 16:12:46 INFO - 'LOGNAME': 'cltbld', 16:12:46 INFO - 'MAIL': '/var/mail/cltbld', 16:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:46 INFO - 'MOZ_NO_REMOTE': '1', 16:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:46 INFO - 'NO_EM_RESTART': '1', 16:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:46 INFO - 'PWD': '/builds/slave/test', 16:12:46 INFO - 'SHELL': '/bin/bash', 16:12:46 INFO - 'SHLVL': '1', 16:12:46 INFO - 'TERM': 'linux', 16:12:46 INFO - 'TMOUT': '86400', 16:12:46 INFO - 'USER': 'cltbld', 16:12:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:46 INFO - '_': '/tools/buildbot/bin/python'} 16:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:46 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 16:12:46 INFO - Cleaning up... 16:12:46 INFO - Return code: 0 16:12:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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', '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 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:12:47 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 16:12:47 INFO - Using env: {'DISPLAY': ':0', 16:12:47 INFO - 'HOME': '/home/cltbld', 16:12:47 INFO - 'LANG': 'en_US.UTF-8', 16:12:47 INFO - 'LANGUAGE': 'en_US:en', 16:12:47 INFO - 'LOGNAME': 'cltbld', 16:12:47 INFO - 'MAIL': '/var/mail/cltbld', 16:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:47 INFO - 'MOZ_NO_REMOTE': '1', 16:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:47 INFO - 'NO_EM_RESTART': '1', 16:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:47 INFO - 'PWD': '/builds/slave/test', 16:12:47 INFO - 'SHELL': '/bin/bash', 16:12:47 INFO - 'SHLVL': '1', 16:12:47 INFO - 'TERM': 'linux', 16:12:47 INFO - 'TMOUT': '86400', 16:12:47 INFO - 'USER': 'cltbld', 16:12:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:47 INFO - '_': '/tools/buildbot/bin/python'} 16:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:47 INFO - Downloading/unpacking psutil>=0.7.1 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:49 INFO - Installing collected packages: psutil 16:12:49 INFO - Running setup.py install for psutil 16:12:49 INFO - building 'psutil._psutil_linux' extension 16:12:49 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 16:12:50 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 16:12:50 INFO - building 'psutil._psutil_posix' extension 16:12:50 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 16:12:50 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 16:12:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:50 INFO - Successfully installed psutil 16:12:50 INFO - Cleaning up... 16:12:50 INFO - Return code: 0 16:12:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 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 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:12:50 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 16:12:50 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 16:12:50 INFO - Using env: {'DISPLAY': ':0', 16:12:50 INFO - 'HOME': '/home/cltbld', 16:12:50 INFO - 'LANG': 'en_US.UTF-8', 16:12:50 INFO - 'LANGUAGE': 'en_US:en', 16:12:50 INFO - 'LOGNAME': 'cltbld', 16:12:50 INFO - 'MAIL': '/var/mail/cltbld', 16:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:50 INFO - 'MOZ_NO_REMOTE': '1', 16:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:50 INFO - 'NO_EM_RESTART': '1', 16:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:50 INFO - 'PWD': '/builds/slave/test', 16:12:50 INFO - 'SHELL': '/bin/bash', 16:12:50 INFO - 'SHLVL': '1', 16:12:50 INFO - 'TERM': 'linux', 16:12:50 INFO - 'TMOUT': '86400', 16:12:50 INFO - 'USER': 'cltbld', 16:12:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:50 INFO - '_': '/tools/buildbot/bin/python'} 16:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:12:51 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 16:12:51 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 16:12:51 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 16:12:51 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 16:12:51 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 16:12:51 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 16:12:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:12:53 INFO - Installing collected packages: mozsystemmonitor 16:12:53 INFO - Running setup.py install for mozsystemmonitor 16:12:53 INFO - Successfully installed mozsystemmonitor 16:12:53 INFO - Cleaning up... 16:12:53 INFO - Return code: 0 16:12:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:53 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')]} 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:53 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')]} 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:53 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 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:12:53 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 16:12:53 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 16:12:53 INFO - Using env: {'DISPLAY': ':0', 16:12:53 INFO - 'HOME': '/home/cltbld', 16:12:53 INFO - 'LANG': 'en_US.UTF-8', 16:12:53 INFO - 'LANGUAGE': 'en_US:en', 16:12:53 INFO - 'LOGNAME': 'cltbld', 16:12:53 INFO - 'MAIL': '/var/mail/cltbld', 16:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:53 INFO - 'MOZ_NO_REMOTE': '1', 16:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:53 INFO - 'NO_EM_RESTART': '1', 16:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:53 INFO - 'PWD': '/builds/slave/test', 16:12:53 INFO - 'SHELL': '/bin/bash', 16:12:53 INFO - 'SHLVL': '1', 16:12:53 INFO - 'TERM': 'linux', 16:12:53 INFO - 'TMOUT': '86400', 16:12:53 INFO - 'USER': 'cltbld', 16:12:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:53 INFO - '_': '/tools/buildbot/bin/python'} 16:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:53 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:55 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 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 16:12:55 INFO - Downloading docopt-0.6.1.tar.gz 16:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:56 INFO - Running setup.py install for blobuploader 16:12:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:56 INFO - Running setup.py install for requests 16:12:56 INFO - Running setup.py install for docopt 16:12:56 INFO - Successfully installed blobuploader requests docopt 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:12:56 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 16:12:56 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 16:12:56 INFO - Using env: {'DISPLAY': ':0', 16:12:56 INFO - 'HOME': '/home/cltbld', 16:12:56 INFO - 'LANG': 'en_US.UTF-8', 16:12:56 INFO - 'LANGUAGE': 'en_US:en', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MAIL': '/var/mail/cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SHLVL': '1', 16:12:56 INFO - 'TERM': 'linux', 16:12:56 INFO - 'TMOUT': '86400', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - '_': '/tools/buildbot/bin/python'} 16:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:56 INFO - Running setup.py (path:/tmp/pip-Quo3nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:56 INFO - Running setup.py (path:/tmp/pip-JPR9OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:56 INFO - Running setup.py (path:/tmp/pip-KG_P5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:57 INFO - Running setup.py (path:/tmp/pip-6iFGro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:57 INFO - Running setup.py (path:/tmp/pip-q_MeCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:57 INFO - Running setup.py (path:/tmp/pip-eVBcH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:57 INFO - Running setup.py (path:/tmp/pip-gwzaZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:57 INFO - Running setup.py (path:/tmp/pip-yqNewu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:57 INFO - Running setup.py (path:/tmp/pip-spZLfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:57 INFO - Running setup.py (path:/tmp/pip-t5FPRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:57 INFO - Running setup.py (path:/tmp/pip-Hn8UjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:57 INFO - Running setup.py (path:/tmp/pip-kp6mmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:57 INFO - Running setup.py (path:/tmp/pip-zogCBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:57 INFO - Running setup.py (path:/tmp/pip-mdJnOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:57 INFO - Running setup.py (path:/tmp/pip-oEkUXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:57 INFO - Running setup.py (path:/tmp/pip-147ipi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:57 INFO - Running setup.py (path:/tmp/pip-XxqVmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:58 INFO - Running setup.py install for manifestparser 16:12:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Running setup.py install for mozcrash 16:12:58 INFO - Running setup.py install for mozdebug 16:12:58 INFO - Running setup.py install for mozdevice 16:12:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Running setup.py install for mozfile 16:12:58 INFO - Running setup.py install for mozhttpd 16:12:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Running setup.py install for mozinfo 16:12:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Running setup.py install for mozInstall 16:12:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:58 INFO - Running setup.py install for mozleak 16:12:58 INFO - Running setup.py install for mozlog 16:12:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Running setup.py install for moznetwork 16:12:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Running setup.py install for mozprocess 16:12:59 INFO - Running setup.py install for mozprofile 16:12:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Running setup.py install for mozrunner 16:12:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Running setup.py install for mozscreenshot 16:12:59 INFO - Running setup.py install for moztest 16:12:59 INFO - Running setup.py install for mozversion 16:12:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:59 INFO - Cleaning up... 16:12:59 INFO - Return code: 0 16:12:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:59 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 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:12:59 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 16:12:59 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 16:12:59 INFO - Using env: {'DISPLAY': ':0', 16:12:59 INFO - 'HOME': '/home/cltbld', 16:12:59 INFO - 'LANG': 'en_US.UTF-8', 16:12:59 INFO - 'LANGUAGE': 'en_US:en', 16:12:59 INFO - 'LOGNAME': 'cltbld', 16:12:59 INFO - 'MAIL': '/var/mail/cltbld', 16:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:59 INFO - 'MOZ_NO_REMOTE': '1', 16:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:59 INFO - 'NO_EM_RESTART': '1', 16:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:59 INFO - 'PWD': '/builds/slave/test', 16:12:59 INFO - 'SHELL': '/bin/bash', 16:12:59 INFO - 'SHLVL': '1', 16:12:59 INFO - 'TERM': 'linux', 16:12:59 INFO - 'TMOUT': '86400', 16:12:59 INFO - 'USER': 'cltbld', 16:12:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:59 INFO - '_': '/tools/buildbot/bin/python'} 16:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:00 INFO - Running setup.py (path:/tmp/pip-qv_m4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:00 INFO - Running setup.py (path:/tmp/pip-YsiicY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:00 INFO - Running setup.py (path:/tmp/pip-BwZxuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:00 INFO - Running setup.py (path:/tmp/pip-N7f_xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:00 INFO - Running setup.py (path:/tmp/pip-bCcrDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:00 INFO - Running setup.py (path:/tmp/pip-9jr41c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:00 INFO - Running setup.py (path:/tmp/pip-5TxEje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:00 INFO - Running setup.py (path:/tmp/pip-U3Xy4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:00 INFO - Running setup.py (path:/tmp/pip-FMDGJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:00 INFO - Running setup.py (path:/tmp/pip-eYo6eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:00 INFO - Running setup.py (path:/tmp/pip-MaN0Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:00 INFO - Running setup.py (path:/tmp/pip-N_FiSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:00 INFO - Running setup.py (path:/tmp/pip-uycJWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:00 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)) 16:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:00 INFO - Running setup.py (path:/tmp/pip-Q0XLIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:01 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)) 16:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:01 INFO - Running setup.py (path:/tmp/pip-_bPdjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:01 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)) 16:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:01 INFO - Running setup.py (path:/tmp/pip-DlBLwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:01 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)) 16:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:01 INFO - Running setup.py (path:/tmp/pip-zRgvhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:01 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)) 16:13:01 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)) 16:13:01 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)) 16:13:01 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)) 16:13:01 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)) 16:13:01 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)) 16:13:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:03 INFO - Downloading blessings-1.6.tar.gz 16:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:03 INFO - Installing collected packages: blessings 16:13:03 INFO - Running setup.py install for blessings 16:13:03 INFO - Successfully installed blessings 16:13:03 INFO - Cleaning up... 16:13:03 INFO - Return code: 0 16:13:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:03 INFO - Reading from file tmpfile_stdout 16:13:03 INFO - Current package versions: 16:13:03 INFO - argparse == 1.2.1 16:13:03 INFO - blessings == 1.6 16:13:03 INFO - blobuploader == 1.2.4 16:13:03 INFO - docopt == 0.6.1 16:13:03 INFO - manifestparser == 1.1 16:13:03 INFO - mozInstall == 1.12 16:13:03 INFO - mozcrash == 0.17 16:13:03 INFO - mozdebug == 0.1 16:13:03 INFO - mozdevice == 0.48 16:13:03 INFO - mozfile == 1.2 16:13:03 INFO - mozhttpd == 0.7 16:13:03 INFO - mozinfo == 0.9 16:13:03 INFO - mozleak == 0.1 16:13:03 INFO - mozlog == 3.1 16:13:03 INFO - moznetwork == 0.27 16:13:03 INFO - mozprocess == 0.22 16:13:03 INFO - mozprofile == 0.28 16:13:03 INFO - mozrunner == 6.11 16:13:03 INFO - mozscreenshot == 0.1 16:13:03 INFO - mozsystemmonitor == 0.0 16:13:03 INFO - moztest == 0.7 16:13:03 INFO - mozversion == 1.4 16:13:03 INFO - psutil == 3.1.1 16:13:03 INFO - requests == 1.2.3 16:13:03 INFO - wsgiref == 0.1.2 16:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:03 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 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:13:03 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 16:13:03 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 16:13:03 INFO - Using env: {'DISPLAY': ':0', 16:13:03 INFO - 'HOME': '/home/cltbld', 16:13:03 INFO - 'LANG': 'en_US.UTF-8', 16:13:03 INFO - 'LANGUAGE': 'en_US:en', 16:13:03 INFO - 'LOGNAME': 'cltbld', 16:13:03 INFO - 'MAIL': '/var/mail/cltbld', 16:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:03 INFO - 'MOZ_NO_REMOTE': '1', 16:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:03 INFO - 'NO_EM_RESTART': '1', 16:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:03 INFO - 'PWD': '/builds/slave/test', 16:13:03 INFO - 'SHELL': '/bin/bash', 16:13:03 INFO - 'SHLVL': '1', 16:13:03 INFO - 'TERM': 'linux', 16:13:03 INFO - 'TMOUT': '86400', 16:13:03 INFO - 'USER': 'cltbld', 16:13:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:03 INFO - '_': '/tools/buildbot/bin/python'} 16:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 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)) 16:13:03 INFO - Cleaning up... 16:13:03 INFO - Return code: 0 16:13:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:13:03 INFO - Using env: {'DISPLAY': ':0', 16:13:03 INFO - 'HOME': '/home/cltbld', 16:13:03 INFO - 'LANG': 'en_US.UTF-8', 16:13:03 INFO - 'LANGUAGE': 'en_US:en', 16:13:03 INFO - 'LOGNAME': 'cltbld', 16:13:03 INFO - 'MAIL': '/var/mail/cltbld', 16:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:03 INFO - 'MOZ_NO_REMOTE': '1', 16:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:03 INFO - 'NO_EM_RESTART': '1', 16:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:03 INFO - 'PWD': '/builds/slave/test', 16:13:03 INFO - 'SHELL': '/bin/bash', 16:13:03 INFO - 'SHLVL': '1', 16:13:03 INFO - 'TERM': 'linux', 16:13:03 INFO - 'TMOUT': '86400', 16:13:03 INFO - 'USER': 'cltbld', 16:13:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:03 INFO - '_': '/tools/buildbot/bin/python'} 16:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:04 INFO - Downloading/unpacking jsonschema 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:08 INFO - Downloading/unpacking functools32 (from jsonschema) 16:13:08 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 16:13:08 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 16:13:08 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 16:13:08 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 16:13:08 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 16:13:08 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 16:13:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:09 INFO - warning: no files found matching '*.txt' 16:13:09 INFO - no previously-included directories found matching 'build' 16:13:09 INFO - no previously-included directories found matching 'dist' 16:13:09 INFO - no previously-included directories found matching '.git*' 16:13:09 INFO - Installing collected packages: jsonschema, functools32 16:13:09 INFO - Running setup.py install for functools32 16:13:09 INFO - warning: no files found matching '*.txt' 16:13:09 INFO - no previously-included directories found matching 'build' 16:13:09 INFO - no previously-included directories found matching 'dist' 16:13:09 INFO - no previously-included directories found matching '.git*' 16:13:09 INFO - Successfully installed jsonschema functools32 16:13:09 INFO - Cleaning up... 16:13:09 INFO - Return code: 0 16:13:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f020c461f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', '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 16:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:13:09 INFO - Using env: {'DISPLAY': ':0', 16:13:09 INFO - 'HOME': '/home/cltbld', 16:13:09 INFO - 'LANG': 'en_US.UTF-8', 16:13:09 INFO - 'LANGUAGE': 'en_US:en', 16:13:09 INFO - 'LOGNAME': 'cltbld', 16:13:09 INFO - 'MAIL': '/var/mail/cltbld', 16:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:09 INFO - 'MOZ_NO_REMOTE': '1', 16:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:09 INFO - 'NO_EM_RESTART': '1', 16:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:09 INFO - 'PWD': '/builds/slave/test', 16:13:09 INFO - 'SHELL': '/bin/bash', 16:13:09 INFO - 'SHLVL': '1', 16:13:09 INFO - 'TERM': 'linux', 16:13:09 INFO - 'TMOUT': '86400', 16:13:09 INFO - 'USER': 'cltbld', 16:13:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:09 INFO - '_': '/tools/buildbot/bin/python'} 16:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:09 INFO - Downloading/unpacking flake8 16:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:13:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:13:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:13:12 INFO - no previously-included directories found matching 'docs/_build' 16:13:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:13:12 INFO - Running setup.py install for pep8 16:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:13:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:13:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:13:12 INFO - no previously-included directories found matching 'docs/_build' 16:13:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:13:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:13:12 INFO - Cleaning up... 16:13:12 INFO - Return code: 0 16:13:12 INFO - Running post-action listener: _resource_record_post_action 16:13:12 INFO - Running post-action listener: _start_resource_monitoring 16:13:12 INFO - Starting resource monitoring. 16:13:12 INFO - ##### 16:13:12 INFO - ##### Running install step. 16:13:12 INFO - ##### 16:13:12 INFO - Running pre-action listener: _resource_record_pre_action 16:13:12 INFO - Running main action method: install 16:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:12 INFO - Reading from file tmpfile_stdout 16:13:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:12 INFO - Reading from file tmpfile_stdout 16:13:12 INFO - Output received: 16:13:12 INFO - Usage: mozinstall [options] installer 16:13:12 INFO - Options: 16:13:12 INFO - -h, --help show this help message and exit 16:13:12 INFO - -d DEST, --destination=DEST 16:13:12 INFO - Directory to install application into. [default: 16:13:12 INFO - "/builds/slave/test"] 16:13:12 INFO - --app=APP Application being installed. [default: firefox] 16:13:12 INFO - mkdir: /builds/slave/test/build/application 16:13:12 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'] 16:13:12 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 16:13:25 INFO - Reading from file tmpfile_stdout 16:13:25 INFO - Output received: 16:13:25 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:25 INFO - Running post-action listener: _resource_record_post_action 16:13:25 INFO - ##### 16:13:25 INFO - ##### Running run-tests step. 16:13:25 INFO - ##### 16:13:25 INFO - Running pre-action listener: _resource_record_pre_action 16:13:25 INFO - Running main action method: run_tests 16:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:25 INFO - Python 2.7.3 16:13:25 INFO - Return code: 0 16:13:25 INFO - grabbing minidump binary from tooltool 16:13: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')]} 16:13:25 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 0x2007160>, '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 0x2008060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20084f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:25 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 16:13:25 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 16:13:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:25 INFO - Return code: 0 16:13:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:13:26 INFO - Return code: 0 16:13:26 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/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:13:26 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/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 16:13:26 INFO - Using env: {'DISPLAY': ':0', 16:13:26 INFO - 'HOME': '/home/cltbld', 16:13:26 INFO - 'LANG': 'en_US.UTF-8', 16:13:26 INFO - 'LANGUAGE': 'en_US:en', 16:13:26 INFO - 'LOGNAME': 'cltbld', 16:13:26 INFO - 'MAIL': '/var/mail/cltbld', 16:13:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:26 INFO - 'MOZ_NO_REMOTE': '1', 16:13:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:26 INFO - 'NO_EM_RESTART': '1', 16:13:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:26 INFO - 'PWD': '/builds/slave/test', 16:13:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:26 INFO - 'SHELL': '/bin/bash', 16:13:26 INFO - 'SHLVL': '1', 16:13:26 INFO - 'TERM': 'linux', 16:13:26 INFO - 'TMOUT': '86400', 16:13:26 INFO - 'USER': 'cltbld', 16:13:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547', 16:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:26 INFO - '_': '/tools/buildbot/bin/python'} 16:13:26 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/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:13:26 INFO - mozversion application_buildid: 20160429133634 16:13:26 INFO - mozversion application_changeset: 259d41769207bbf0a55afe7475fc3a71f8a5d724 16:13:26 INFO - mozversion application_display_name: Firefox 16:13:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:26 INFO - mozversion application_name: Firefox 16:13:26 INFO - mozversion application_remotingname: firefox 16:13:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:13:26 INFO - mozversion application_vendor: Mozilla 16:13:26 INFO - mozversion application_version: 47.0 16:13:26 INFO - mozversion platform_buildid: 20160429133634 16:13:26 INFO - mozversion platform_changeset: 259d41769207bbf0a55afe7475fc3a71f8a5d724 16:13:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:13:26 INFO - mozversion platform_version: 47.0 16:13:26 INFO - using testdate: 1461971606 16:13:26 INFO - actual date: 1461971606 16:13:26 INFO - starting webserver on 'localhost:54996' 16:13:26 INFO - SUITE-START | Running 2 tests 16:13:26 INFO - TEST-START | dromaeo_css 16:13:26 INFO - operating with platform_type : linux_ 16:13:26 INFO - Initialising browser for dromaeo_css test... 16:13:26 INFO - TEST-INFO | started process 3308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIDlERf/profile http://localhost:54996/getInfo.html) 16:13:31 INFO - PROCESS | 3308 | 16:13:31 INFO - PROCESS | 3308 | (process:3387): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:13:32 INFO - PROCESS | 3308 | __metrics Screen width/height:1600/1200 16:13:32 INFO - PROCESS | 3308 | colorDepth:24 16:13:32 INFO - PROCESS | 3308 | Browser inner width/height: 1024/697 16:13:32 INFO - PROCESS | 3308 | __metrics 16:13:33 ERROR - PROCESS | 3308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:13:34 INFO - TEST-INFO | 3308: exit 0 16:13:34 INFO - Browser initialized. 16:13:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:34 INFO - TEST-INFO | started process 3437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIDlERf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:36 INFO - PROCESS | 3437 | 16:13:36 INFO - PROCESS | 3437 | (process:3504): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:13:46 INFO - PROCESS | 3437 | RSS: Main: 149872640 16:13:46 INFO - PROCESS | 3437 | 16:14:35 INFO - PROCESS | 3437 | 1461971675599 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] 16:16:43 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:54996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54996/tests/dromaeo/cssquery-ext.html) 16:16:44 INFO - PROCESS | 3437 | RSS: Main: 153292800 16:16:44 INFO - PROCESS | 3437 | 16:19:46 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:54996/tests/dromaeo/cssquery-ext.html (next: http://localhost:54996/tests/dromaeo/cssquery-jquery.html) 16:19:46 INFO - PROCESS | 3437 | RSS: Main: 152457216 16:19:46 INFO - PROCESS | 3437 | 16:22:48 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:54996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54996/tests/dromaeo/cssquery-mootools.html) 16:22:49 INFO - PROCESS | 3437 | RSS: Main: 151400448 16:22:49 INFO - PROCESS | 3437 | 16:25:50 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:54996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54996/tests/dromaeo/cssquery-prototype.html) 16:25:51 INFO - PROCESS | 3437 | RSS: Main: 152563712 16:25:51 INFO - PROCESS | 3437 | 16:28:53 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:54996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54996/tests/dromaeo/cssquery-yui.html) 16:28:54 INFO - PROCESS | 3437 | RSS: Main: 151490560 16:28:54 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:54996/tests/dromaeo/cssquery-yui.html (next: http://localhost:54996/tests/dromaeo/cssquery-dojo.html) 16:31:56 INFO - PROCESS | 3437 | RSS: Main: 155545600 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | __start_tp_report 16:31:56 INFO - PROCESS | 3437 | _x_x_mozilla_page_load 16:31:56 INFO - PROCESS | 3437 | _x_x_mozilla_page_load_details 16:31:56 INFO - PROCESS | 3437 | |i|pagename|runs| 16:31:56 INFO - PROCESS | 3437 | |0;dojo.html;3345.882894098707;3363.075154332558;3368.4947257911294;3381;3388.390089783838;5399.325084364455;5401.513863752271;5407.837764867056;5414.620976531634;5415;5416.729163541827;5422.783088676458;5423.538999185074;5425;5426.565874730022;4918.090153321629;4959.900801983958;4987.1521841286885;5016.924746128811;5048.5203905628905;4863.076015557051;5017.322661440713;5050.090983622947;5112.156494178456;5162.045021670984;5073.2643766654;5097.770600322976;5124.231365295198;5127.359080114986;5128.948710512885;4555.954440455619;4919.1391506486225;5075.822346217883;5084.516970887741;5096.108181068335;4982.950170498321;4985.102681517325;4989.501049895018;4990.82532111378;4998.10034193845;5294.92057619136;5305;5305.0450918834595;5311;5340.866478338034;5758.3665796762325;5759.798407055733;5888.175655408247;5892.410758924116;5897.970510147465;5913.852153696149;5915.142304365886;5925.822225333204;5926.4666180044005;5939.1388248704125;5485.862853428656;5504.587155963319;5506.531944784698;5512.421195774426;5514.972425137848;5901.114832775118;5961.880762384815;6059.697015149225;6066.787662431793;6106.297775755756;5789.768409263666;5790.739416726173;5812.912806307824;5817.767289308465;5846.41535846412;5701.600887937804;5920.348761636216;5930.970345148246;5940.079287710412;5949.702514874239;5747.36778954323;5793.217915581343;5829.795957141565;5832.387599302097;5849.064149736022;5831.241938547962;5847.649141051551;5859.2382990211;5881.882362352729;5888.823335299948;4318.352247162888;4366.476022877211;4394.934075988863;4441.977790111029;4472.731636101845;4030.0730831908827;4050.25070361984;4056.9797151014054;4068.4710987571425;4087.305158123126;5621.550275977912;5645.5483561314995;5649.858753531113;5653.23681303027;5674.177244299636;5859.091840764689;5925.437083477149;5951.434613711691;5986.940130598726;5995.46040856325;5609.382967873531;5630.915536266959;5643.661380317194;5645.858853528694;5652.689102099342;5045.949540504622;5051.949480505222;5071.239314102841;5071.898562028812;5087.160618497906;5908.822735317947;6072.36240194782;6136.9079463808075;6139.495823523265;6147.508199344042;5779.942200577941;5888.676122813286;5950.226470558973;5953.077273022688;5994.700264986646;6064.696765161812;6104.20645316106;6111.297200821962;6119.4798442132915;6129.233845769279;5704.229928959703;5767.538596912321;5855.3559108497175;5875.588708790344;5890.941090589211;5874.559408044328;5899.46904778572;5900.970495147497;5929.318128415115;5929.673867937305;5574.9163762542785;5753.3958934311295;5753.568482363923;5768.682722450306;5796.768129274782;5754.165645981393;5846.56150788684;5855.912161317498;5858.794942177004;5881.029630110984;5660.7169641518585;5663.433656634304;5689.345725241485;5696.088625819849;5721.542276617944;5674.631148975469;5792.044312688359;5846.912296315473;5851.093080572518;5852.590318677651;5719.199312096393;5729.684867332337;5744.253247077853;5750.712464376848;5774.624649397776 16:31:56 INFO - PROCESS | 3437 | |1;ext.html;569.5585920911293;572.2189211725995;575.7267115197943;609.3875654966757;614.5943677173067;38232;38822;38957.22085558287;38961.80519097404;39118.41322380167;41398.379024314585;41780;41829;41977.58022419775;42061.78969105158;8753.95623021884;8919.509426981513;8955.104489551026;8955.925288965333;8962.73111806647;8717.607707653171;8903.154200350957;8920.955395223014;8924.509151996637;8929;8722.084181160983;8906.73279801607;8940.910590894106;8950.552472376356;8964.372493925428;8776.254018408412;8859.778505537348;8866.645334186625;8874.245689116433;8885.200331970122;8825;8938.46369217849;9177.908220917772;9197.264218862541;9216.631334746602;43003.35494967578;43660.345094823606;43689.34465983013;43704.12591748179;43780.56219437797;3716.888493345204;3839.558450778168;3859.8649047283493;3902.828353369587;4422.358757980075;32721.509177362357;32825.83587082049;32841.34317313664;32873.34253314944;34324.6567534324;3861.2470568239205;3899.7270191086636;3929.9214015719526;3942.4874766280486;3960.841566337343;283799;286639;287177.5641121802;287358;287840;67007.32992670109;68032;68269.3173068263;68480;68619.65690171518;73696.26303737001;73709.26290737132;75654.62172689212;75667.62166189133;75748.62125689337;18883.905580472285;19322.516937076405;19372.903135484234;19385.321513746952;19472.80527194738;13862.65343366424;14052.156870587592;14075.929620351833;14132.717345653235;14156.221407822668;23035.769642303363;23213.651795223086;23347;23393;23426.414339641644;8178.223068808454;8514.318854491627;8563.400561960603;8637;8716.91283087161;1035.8860525342357;1070.7751372211767;1105.1435137768133;1129.3449799116493;1157.6989982604416;30170;30766.692333076382;30909.536356954664;30919.072427827203;31031.224219394244;1108.7837871615118;1113.6937342230951;1131.8641762988493;1155.7457359380924;1215.228330010432;15670.686586268439;15681.451149209723;16069.758953615705;17324.133793310284;18344.54138646518;397122;512231;519159;530205;532357;57624.42375576274;58547.70726146342;58600.41399586035;58775.11837322444;59116.704416477645;1509.8414666459864;1526.1072272720583;1536.1320853717614;1542;1548.6438119232414;30978.53532196974;32108.19729506781;32186.19534511656;32312.83843580767;32555.18612034718;50068;50155.49844501508;50250.2462463056;50814.237786432495;50870;311236;314092;315644;316157;319132;34794.82602586971;35186.648133518334;35193.82403087968;35350.82324588361;35419.82290088533;45604.315935261664;45782.08435831331;46278.537214627424;46713.19720816762;47102.76448617735;39297.60702392939;39393.2121357577;39475.60524394719;39642.2071558573;39869.800650996556;38097;38316.61683383131;39012.80493597514;39490;40065.39901901532;38769;38968;39083.413748793224;39921;39931.60068399279;33656.83171584126;34364.65635343615;34858.47712284369;34959.12602184864;35373.82313088521;26965.865170674806;27167.320816979733;27224.863875680494;27451.450970980866;27700.722992769814 16:31:56 INFO - PROCESS | 3437 | |2;jquery.html;372.11436780462503;385.2641454821292;393.37846202999265;394.8973266950593;400.02593684378525;17439.196860745367;19647.607047859034;20002.29991950282;20239.696404553943;20304.086316115754;18398.080095995214;18772.155253013614;19019.2392304308;19164.90417547914;19248.326308579166;5629.437056294369;5832.125181222808;5835.795747148851;5858.677772722499;5858.941410585882;5044.142495775727;5185.740712964355;5186.5591424728755;5196.038732834438;5223.973880130613;5191.039657663326;5208;5234.6335756497065;5756.769729210827;6038.909416358758;5714.657120572738;5965.61223520472;5987.9401205987815;6011.308699499548;6021.337652858182;5620.971895140498;5625.803096891589;5630;5661.150827375926;5675.801346952878;13748.450061997508;13916.791248131287;14123.152610843383;14852.925735371362;14905.254737263094;2296.2422400607925;2382.814433499972;2443.9022439102414;2502.986290552329;2927.34134819666;9394.67118650844;9688.031196880325;10002.89997100027;10611.41637209961;10841.13270938323;1980.6731889238258;1988.741463609736;2055.290924631;2065.2255404223415;2093.9162433502643;66638.3336166637;68078.31921680819;68467.65766171138;69230.65384673094;69380.65309673469;10608.257421980386;11133.441318215457;11343.829842552368;11560.76878462426;11617;15305.31126099306;15312.468753124822;15553.844461555465;15583.298751556207;15624.531264062096;8494.830103397897;8580.914190858137;8625.223729864343;8645.135486451305;8758.781030474289;8407.327413806881;8479.491230526188;8491.320694344438;8499.872501912476;8570.700025499078;4671.416072990876;4793.592544633675;4844.685095468783;4863.294822250825;4872.1473742094995;1986.483514286296;1988.0001795484368;1993.0931426201043;1995.348512222629;2059.4645392198136;931.9161275485103;997.5062344139698;1052.7947050325113;1055.1295181475314;1110.1174566219875;17455.56361090983;17591.856529325552;17877.821221787617;18470.81529184718;18667.71998420025;1028.4138041316378;1032.4785983078498;1052.4579841381694;1066.7759770448138;1080.0819303591884;10332.638357657446;10456.843147352796;10499.422531760674;10552.15582753378;10584.417857017785;440026;445397;446434;447869;451339;78688.60655696684;79082;82183.5890820554;83160.58419707863;84898;1025.9435731034864;1041.614602597044;1048.9318194317498;1079.8704155501232;1086.9619563315089;16179.919100404893;16188.433404830774;16284.10437425953;16449.83550164531;16637;34358.65641343554;34983.825080874434;35464;35874.820625896704;36479.635203647624;50228.748856255486;52237;52614;52669.73665131803;53028.46971530235;8749.825003500022;8750.124987501198;8769.254613357936;8883.955580222058;8963.148500892405;9192.126747958933;9666.903330966601;9990.500474976367;10215.94892025535;10334.844977325196;8798.34012449056;8887.244584210415;9273.72178834636;9454.243660507005;9687.079727425884;9262.95368523153;9270.165685088374;9422.246220302222;9531.189848862647;9642.566084526354;9473.857892131486;9486.573104210465;9559.139677428786;9580.712578622653;9823.410595364301;12115.636530903734;12214.145009849226;12571.93714031424;12722.745545089232;12927.28899910514;12605.43275552584;12750.61748147557;12840;12889.548865789653;12898.290594017419 16:31:56 INFO - PROCESS | 3437 | |3;mootools.html;1604.5266646339328;1622.7403615421536;1915.3296346278805;1932.719755635432;1992.9003549822496;7354.926450735491;7814.257645523666;8246.134155913625;8437.915620843789;8442.451240669352;8124.5937703114905;8163.877541836862;8194;8202.91797082029;8225.670973161066;2331.9300420987397;2362.7164740231196;2367.3134790910617;2368.111958015744;2372.074890792592;2377.346229786805;2417.758224177586;2459.483508463225;2479.5536803375385;2484.5155194736944;2426.0295881647307;2431.5380077785253;2433.5862903306393;2479.590867506859;2481.9751802481924;2454.1901172612993;2458.1519375815315;2460.1758410932357;2465.654808326836;2507.3230227838562;2393.3418309964727;2396.59257926153;2404.0504000919714;2421.4309637235237;2433.634954756783;8343.207395297437;8445.408821382505;8451.53516556589;8464.703735369232;8479.491230526188;5057.772400241998;5193.195054766479;5193.2989046479;5201.219817027476;5207.739613019372;3198.424283628946;3226;3238.481842905124;3282.556854824616;3286.7370610351113;1085.3069212029181;1086.2483151711706;1089.3333200203701;1142.5658249865082;1151.2804497189256;11619.07047436203;11736.061115110771;11736.53053877844;11739.295642261492;11739.882601173964;4702.6473014524045;4756.595689366373;4774.236122220428;4787.736674482867;4809.254565542346;9999.700008999742;10012.349197302152;10034.046765557261;10036.347637403545;10067.496625168713;5305.389880163753;5316.149416093406;5320.308359913187;5320.52115309624;5363;4693.460252071056;4815.7351345676325;4817.759112044454;4833.4199896012;4844.0554091951735;3733.831977560962;3787.791671458096;3795.6014618465215;3803.8858834235016;3817.1220619257724;1161.9419029048513;1166.1603645375317;1173.978638584437;1175.4299164905015;1179.9174057815871;1096.1231015187977;1107.5569772091228;1115.0243536905207;1388.4376827384926;1499.4077339450855;8035.517868927883;8073.515589064675;8133.918660813316;8163.346932245406;8235.423520353637;551.178743671926;553.9612227144062;554.9223108764776;557.4704031170323;560.5879678436346;6154.446099851035;6173.41352571505;6177.7837775677635;6184.350643182491;6234.594751341239;10032.69901902944;10368.911264317137;10410.843837342445;10516;10535.420551869567;9603.327767056378;10233.283670143019;10261.486925653688;10294.691159265234;10332.070113689804;7769.689212431439;7878.842423151505;7908.485948413335;7943.960280198562;7975.1626079262005;7676;7696.769096927102;7728.26581474759;7856.84286314282;7862.371010319275;8403.117672644285;8430.114837941928;9096.590653420479;9277.536123193679;9292.25661947029;8525.317974562144;8560.400771946153;8586.957065214634;8641.179087986631;8686.39195256326;7128.643567821692;7322.414206863545;7351.044364232829;7389.926100738924;7488.026556547614;7981.2018798119725;7992.320652744582;7997.320227780704;8014.078380986261;8072;7054.717811287491;7089.220185779664;7150.67821948024;7277.235890231661;7308.5614863108385;7194.676239569337;7200.567965922061;7212.531185472927;7302.160251570925;7303.014093097577;7519.73680921187;7587.62061896914;7597.3162415382885;7607.809804754704;7629.351505122127;6955.443564514725;7004.334588214111;7020.227774944854;7022.332878376546;7031.718731250693;6864;7014.824629384306;7087.574745515286;7092;7108.431325494052 16:31:56 INFO - PROCESS | 3437 | |4;prototype.html;351.70456816274327;353.7099578345756;357.57448636122996;360.5133070355021;363.88355726167634;6396.648184349859;6443.259025212102;6461.224653041636;6489.8377540561505;6498.317676643944;6374.776882809103;6383.968080159592;6386.074019267215;6398.744050237997;6420.261669907962;4757.524247575249;4912.115819152551;4915.139850526161;4931.876703082416;4952.182889823175;4917.582005529534;4925.802967881281;4927.728974906397;4938.654294199408;4938.703677779326;4849.806007759686;4872.098661747588;4873.7319447430555;4919.212925931852;4932.827351042714;4917.704937703731;4925.014997000596;4931.482194369575;4936.901261974776;4938.061768264036;4324.589164029412;4334.479862416499;4334.566543345672;4336.414584031147;4338.197433474786;5881.029630111027;6103.084537319393;6106.542009349317;6109.3890610939;6114;5678.034734095214;5704.942950570524;5720.399358067426;5724.742386592613;5738.741756620921;6825.1127353444235;6832.795016149524;6849.554778939353;6859.07402500661;6861.279565645636;4672.5327467253;4673.135469938073;4678.134545109166;4686.179918514281;4696.03731235096;7041.049458323112;7086.185088714812;7094.503384763068;7108.4668649851465;7123.679434425463;4661.487236403993;4711.340412342275;4733.41430620739;4738.786754596052;4745.857624271277;4804.6876952997945;4821.325014497973;4824.324594556765;4830.565249127595;4835.879103022382;5530.446955304437;5571.916421253684;5582;5592.608517403824;5652.6325788824415;6866;6866.176058872968;6867;6884.139482564679;6906.136732908387;1649.4062137630444;1693.1872701103293;1699.4816580942932;1711.7261238201827;1735.947921562355;1102.1843835561626;1110.228391268077;1110.2949626986922;1111.4387234446554;1115.2639258089785;6475.6438395887735;6523.869522609616;6574.276829548746;6581.703823327962;6632.801015969529;6985.301469852974;7010.263922288188;7013.92986070143;7017.333353331425;7030.824229394306;6576.342365763481;6586.934130658728;6588.439982601437;6593.835154121185;6604.768833090819;3743.6256374362893;3783.754055986352;3790.1282704977457;3794.29805485986;3810.980945095312;7168.892466613005;7225.710971561079;7236.96381518089;7249.238829922888;7306.671199796022;7285.854282914312;7295.489315747846;7309.086364204474;7332.5967071811565;7333.596652184181;7325.670344834602;7401.48189626721;7402.111746590336;7414.592197429085;7415.703371865173;6962.268961759145;7113.82215444618;7132.072830531998;7137.357637812622;7172.462065345225;6978.371946524837;6991.335823096798;6995.090638217;7008.929910700827;7015.36861682451;7275.781726548212;7284.635768211462;7291.161516425467;7293.927060729537;7305.050343455317;4868.391451068616;4913.582345500529;4915.901681966269;4926.359573255597;4952.653314267966;6917.515773895981;7029.789106326818;7106.538075025107;7118.28817118284;7124.430045596444;6888.380045795902;6888.793336199922;6901.137357830271;6920.169579650475;6930.445564354739;6890;6890.173179218526;6891.3797758202;6902.620355880274;6912.723491060301;6743.9325606743305;6750.1562304711915;6750.628715420699;6758.121444212417;6760.08738820253;6744.69648865812;6950.6177160256675;6953.965230173817;6958.617276049663;6964.442844572523;6737.3599508046655;6786.321367863372;6788.321167883172;6795.830104247433;6796.456283497408 16:31:56 INFO - PROCESS | 3437 | |5;yui.html;806.7741032510899;812.5043723328765;830.9335253179743;863.7149740585606;871.4248595926686;15020.624484387896;15374.385024599003;15386.307616157272;15411.07533547988;15431.382744690227;14653.194074325907;14676.119432834037;14677;14829.629259268524;14863.554093377188;915.2952226785371;945.6264775413707;953.6090203016764;956.8899576548716;961.024560071528;948.6158105967095;953.5661274120293;954.6992697300328;956.0964888180672;957.7844984878382;978.0268632710463;984.2962281968391;985.0248254228298;985.3792110970114;986.0977205856633;975.7560609847538;979.0601023017912;980.6371642492323;982.6953644370268;984.4487087231173;723.6815801047522;730.5361095704266;731.2102928836844;731.7182884589419;734.8640501507185;14098.647533811736;14106.858931410658;14127.646808829759;14152.433902643881;14183.71632567343;13719.314034298344;13792.241426721526;13809.447622095104;13872.237026963512;14045.367958441895;11738.23701459411;11840.88159118415;11863.406829658568;11937.761244775056;11959.701007474796;3877.1664092220026;3911.6479516843337;3921.784301863396;3932.8230229639735;3937.7637341759587;56396.718016410065;56482;56520.717396413165;56610.43389566134;56699;10685.358878467161;10764.300320479144;10836.945815270874;10879.456027198608;11009.83485247722;20149.697754533692;20183.39449816508;20244.392668219978;20247.59504809925;20256.392308230777;8040.0705129165435;8110.878336824952;8131.349492040741;8132.634031468599;8242.381821363422;4330.437043184366;4464.799084041226;4535.297028960516;4539.591436770706;4741.668083234141;3363.899083027513;3373.4602463605706;3425.36630723312;3426.588809342845;3432.1591210153674;617.2315467243221;618.13769791142;622.0668996505242;628.1174949196386;629.3706293706293;620.2804746494045;629.9622022678562;646.3342756960338;659.1036190780535;659.7427003468651;7971.441999060126;8284.668613255522;8343.8331233375;8565.828683426296;9247.907520924704;556.1962963517759;614.9576467886978;626.3485974586379;638.2149955554694;641.4131070070833;4029.0531725044593;4125.5874412558505;4179.832806687698;4318.417013703172;4399.956000440018;63943.680281598296;64190.67904660447;67282;69817.65091174614;70084;51751;54805.1779223312;55691;56691.14963275554;58008.999999999156;50674.49325506771;50889.745551272004;51267.48732512702;52094.739526302124;52434.21348679773;8677.739667809976;8764.649414023623;8880.200781929658;9025.142611451902;9082.228010618906;37149.442758358105;38458;38481.615183848924;39260.411093834184;39285.60714392934;49950.750246248535;50992.23511647254;51393.229101562756;51802;51927.2210916829;12549.811752823898;12730.17253878495;12759.80860287115;12794.87205127974;12924.547640832525;13016.609501714964;13147.211167329991;13720;13914.373853176834;14411.351489182802;11638.35989020612;11857.110716696456;12239.938800306298;12625.368731563569;12656.493740250655;12647.430865610886;12828.807567886302;12895.16181448203;13008.414621341873;13143.408546615616;10117.59529618807;10457.63398281087;10540.789184216426;10820.458977051274;10996.505157268102;10105.44420056904;10135.594576216869;10701.143908487147;10709.08972737326;10794.676159715222;10218.744531386776;10401.21990850674;10534.209934254808;10536.578536858746;10570.630027948984 16:31:56 INFO - PROCESS | 3437 | __end_tp_report 16:31:56 INFO - PROCESS | 3437 | __start_cc_report 16:31:56 INFO - PROCESS | 3437 | _x_x_mozilla_cycle_collect,337 16:31:56 INFO - PROCESS | 3437 | __end_cc_report 16:31:56 INFO - PROCESS | 3437 | __startTimestamp1461972716558__endTimestamp 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | ------- Summary: start ------- 16:31:56 INFO - PROCESS | 3437 | Number of tests: 6 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | [#0] dojo.html Cycles:165 Average:5473.45 Median:5704.23 stddev:608.12 (10.7%) stddev-sans-first:586.64 16:31:56 INFO - PROCESS | 3437 | Values: 3345.9 3363.1 3368.5 3381.0 3388.4 5399.3 5401.5 5407.8 5414.6 5415.0 5416.7 5422.8 5423.5 5425.0 5426.6 4918.1 4959.9 4987.2 5016.9 5048.5 4863.1 5017.3 5050.1 5112.2 5162.0 5073.3 5097.8 5124.2 5127.4 5128.9 4556.0 4919.1 5075.8 5084.5 5096.1 4983.0 4985.1 4989.5 4990.8 4998.1 5294.9 5305.0 5305.0 5311.0 5340.9 5758.4 5759.8 5888.2 5892.4 5898.0 5913.9 5915.1 5925.8 5926.5 5939.1 5485.9 5504.6 5506.5 5512.4 5515.0 5901.1 5961.9 6059.7 6066.8 6106.3 5789.8 5790.7 5812.9 5817.8 5846.4 5701.6 5920.3 5931.0 5940.1 5949.7 5747.4 5793.2 5829.8 5832.4 5849.1 5831.2 5847.6 5859.2 5881.9 5888.8 4318.4 4366.5 4394.9 4442.0 4472.7 4030.1 4050.3 4057.0 4068.5 4087.3 5621.6 5645.5 5649.9 5653.2 5674.2 5859.1 5925.4 5951.4 5986.9 5995.5 5609.4 5630.9 5643.7 5645.9 5652.7 5045.9 5051.9 5071.2 5071.9 5087.2 5908.8 6072.4 6136.9 6139.5 6147.5 5779.9 5888.7 5950.2 5953.1 5994.7 6064.7 6104.2 6111.3 6119.5 6129.2 5704.2 5767.5 5855.4 5875.6 5890.9 5874.6 5899.5 5901.0 5929.3 5929.7 5574.9 5753.4 5753.6 5768.7 5796.8 5754.2 5846.6 5855.9 5858.8 5881.0 5660.7 5663.4 5689.3 5696.1 5721.5 5674.6 5792.0 5846.9 5851.1 5852.6 5719.2 5729.7 5744.3 5750.7 5774.6 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | [#1] ext.html Cycles:180 Average:54777.12 Median:39100.91 stddev:100364.20 (256.7%) stddev-sans-first:100563.22 16:31:56 INFO - PROCESS | 3437 | Values: 569.6 572.2 575.7 609.4 614.6 38232.0 38822.0 38957.2 38961.8 39118.4 41398.4 41780.0 41829.0 41977.6 42061.8 8754.0 8919.5 8955.1 8955.9 8962.7 8717.6 8903.2 8921.0 8924.5 8929.0 8722.1 8906.7 8940.9 8950.6 8964.4 8776.3 8859.8 8866.6 8874.2 8885.2 8825.0 8938.5 9177.9 9197.3 9216.6 43003.4 43660.3 43689.3 43704.1 43780.6 3716.9 3839.6 3859.9 3902.8 4422.4 32721.5 32825.8 32841.3 32873.3 34324.7 3861.2 3899.7 3929.9 3942.5 3960.8 283799.0 286639.0 287177.6 287358.0 287840.0 67007.3 68032.0 68269.3 68480.0 68619.7 73696.3 73709.3 75654.6 75667.6 75748.6 18883.9 19322.5 19372.9 19385.3 19472.8 13862.7 14052.2 14075.9 14132.7 14156.2 23035.8 23213.7 23347.0 23393.0 23426.4 8178.2 8514.3 8563.4 8637.0 8716.9 1035.9 1070.8 1105.1 1129.3 1157.7 30170.0 30766.7 30909.5 30919.1 31031.2 1108.8 1113.7 1131.9 1155.7 1215.2 15670.7 15681.5 16069.8 17324.1 18344.5 397122.0 512231.0 519159.0 530205.0 532357.0 57624.4 58547.7 58600.4 58775.1 59116.7 1509.8 1526.1 1536.1 1542.0 1548.6 30978.5 32108.2 32186.2 32312.8 32555.2 50068.0 50155.5 50250.2 50814.2 50870.0 311236.0 314092.0 315644.0 316157.0 319132.0 34794.8 35186.6 35193.8 35350.8 35419.8 45604.3 45782.1 46278.5 46713.2 47102.8 39297.6 39393.2 39475.6 39642.2 39869.8 38097.0 38316.6 39012.8 39490.0 40065.4 38769.0 38968.0 39083.4 39921.0 39931.6 33656.8 34364.7 34858.5 34959.1 35373.8 26965.9 27167.3 27224.9 27451.5 27700.7 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | [#2] jquery.html Cycles:180 Average:26402.22 Median:394.14 stddev:73340.85 (18607.9%) stddev-sans-first:73520.55 16:31:56 INFO - PROCESS | 3437 | Values: 372.1 385.3 393.4 394.9 400.0 17439.2 19647.6 20002.3 20239.7 20304.1 18398.1 18772.2 19019.2 19164.9 19248.3 5629.4 5832.1 5835.8 5858.7 5858.9 5044.1 5185.7 5186.6 5196.0 5224.0 5191.0 5208.0 5234.6 5756.8 6038.9 5714.7 5965.6 5987.9 6011.3 6021.3 5621.0 5625.8 5630.0 5661.2 5675.8 13748.5 13916.8 14123.2 14852.9 14905.3 2296.2 2382.8 2443.9 2503.0 2927.3 9394.7 9688.0 10002.9 10611.4 10841.1 1980.7 1988.7 2055.3 2065.2 2093.9 66638.3 68078.3 68467.7 69230.7 69380.7 10608.3 11133.4 11343.8 11560.8 11617.0 15305.3 15312.5 15553.8 15583.3 15624.5 8494.8 8580.9 8625.2 8645.1 8758.8 8407.3 8479.5 8491.3 8499.9 8570.7 4671.4 4793.6 4844.7 4863.3 4872.1 1986.5 1988.0 1993.1 1995.3 2059.5 931.9 997.5 1052.8 1055.1 1110.1 17455.6 17591.9 17877.8 18470.8 18667.7 1028.4 1032.5 1052.5 1066.8 1080.1 10332.6 10456.8 10499.4 10552.2 10584.4 440026.0 445397.0 446434.0 447869.0 451339.0 78688.6 79082.0 82183.6 83160.6 84898.0 1025.9 1041.6 1048.9 1079.9 1087.0 16179.9 16188.4 16284.1 16449.8 16637.0 34358.7 34983.8 35464.0 35874.8 36479.6 50228.7 52237.0 52614.0 52669.7 53028.5 8749.8 8750.1 8769.3 8884.0 8963.1 9192.1 9666.9 9990.5 10215.9 10334.8 8798.3 8887.2 9273.7 9454.2 9687.1 9263.0 9270.2 9422.2 9531.2 9642.6 9473.9 9486.6 9559.1 9580.7 9823.4 12115.6 12214.1 12571.9 12722.7 12927.3 12605.4 12750.6 12840.0 12889.5 12898.3 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | [#3] mootools.html Cycles:180 Average:5859.18 Median:5320.41 stddev:3069.30 (57.7%) stddev-sans-first:3061.25 16:31:56 INFO - PROCESS | 3437 | Values: 1604.5 1622.7 1915.3 1932.7 1992.9 7354.9 7814.3 8246.1 8437.9 8442.5 8124.6 8163.9 8194.0 8202.9 8225.7 2331.9 2362.7 2367.3 2368.1 2372.1 2377.3 2417.8 2459.5 2479.6 2484.5 2426.0 2431.5 2433.6 2479.6 2482.0 2454.2 2458.2 2460.2 2465.7 2507.3 2393.3 2396.6 2404.1 2421.4 2433.6 8343.2 8445.4 8451.5 8464.7 8479.5 5057.8 5193.2 5193.3 5201.2 5207.7 3198.4 3226.0 3238.5 3282.6 3286.7 1085.3 1086.2 1089.3 1142.6 1151.3 11619.1 11736.1 11736.5 11739.3 11739.9 4702.6 4756.6 4774.2 4787.7 4809.3 9999.7 10012.3 10034.0 10036.3 10067.5 5305.4 5316.1 5320.3 5320.5 5363.0 4693.5 4815.7 4817.8 4833.4 4844.1 3733.8 3787.8 3795.6 3803.9 3817.1 1161.9 1166.2 1174.0 1175.4 1179.9 1096.1 1107.6 1115.0 1388.4 1499.4 8035.5 8073.5 8133.9 8163.3 8235.4 551.2 554.0 554.9 557.5 560.6 6154.4 6173.4 6177.8 6184.4 6234.6 10032.7 10368.9 10410.8 10516.0 10535.4 9603.3 10233.3 10261.5 10294.7 10332.1 7769.7 7878.8 7908.5 7944.0 7975.2 7676.0 7696.8 7728.3 7856.8 7862.4 8403.1 8430.1 9096.6 9277.5 9292.3 8525.3 8560.4 8587.0 8641.2 8686.4 7128.6 7322.4 7351.0 7389.9 7488.0 7981.2 7992.3 7997.3 8014.1 8072.0 7054.7 7089.2 7150.7 7277.2 7308.6 7194.7 7200.6 7212.5 7302.2 7303.0 7519.7 7587.6 7597.3 7607.8 7629.4 6955.4 7004.3 7020.2 7022.3 7031.7 6864.0 7014.8 7087.6 7092.0 7108.4 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | [#4] prototype.html Cycles:180 Average:5719.26 Median:6511.09 stddev:1742.12 (26.8%) stddev-sans-first:1699.78 16:31:56 INFO - PROCESS | 3437 | Values: 351.7 353.7 357.6 360.5 363.9 6396.6 6443.3 6461.2 6489.8 6498.3 6374.8 6384.0 6386.1 6398.7 6420.3 4757.5 4912.1 4915.1 4931.9 4952.2 4917.6 4925.8 4927.7 4938.7 4938.7 4849.8 4872.1 4873.7 4919.2 4932.8 4917.7 4925.0 4931.5 4936.9 4938.1 4324.6 4334.5 4334.6 4336.4 4338.2 5881.0 6103.1 6106.5 6109.4 6114.0 5678.0 5704.9 5720.4 5724.7 5738.7 6825.1 6832.8 6849.6 6859.1 6861.3 4672.5 4673.1 4678.1 4686.2 4696.0 7041.0 7086.2 7094.5 7108.5 7123.7 4661.5 4711.3 4733.4 4738.8 4745.9 4804.7 4821.3 4824.3 4830.6 4835.9 5530.4 5571.9 5582.0 5592.6 5652.6 6866.0 6866.2 6867.0 6884.1 6906.1 1649.4 1693.2 1699.5 1711.7 1735.9 1102.2 1110.2 1110.3 1111.4 1115.3 6475.6 6523.9 6574.3 6581.7 6632.8 6985.3 7010.3 7013.9 7017.3 7030.8 6576.3 6586.9 6588.4 6593.8 6604.8 3743.6 3783.8 3790.1 3794.3 3811.0 7168.9 7225.7 7237.0 7249.2 7306.7 7285.9 7295.5 7309.1 7332.6 7333.6 7325.7 7401.5 7402.1 7414.6 7415.7 6962.3 7113.8 7132.1 7137.4 7172.5 6978.4 6991.3 6995.1 7008.9 7015.4 7275.8 7284.6 7291.2 7293.9 7305.1 4868.4 4913.6 4915.9 4926.4 4952.7 6917.5 7029.8 7106.5 7118.3 7124.4 6888.4 6888.8 6901.1 6920.2 6930.4 6890.0 6890.2 6891.4 6902.6 6912.7 6743.9 6750.2 6750.6 6758.1 6760.1 6744.7 6950.6 6954.0 6958.6 6964.4 6737.4 6786.3 6788.3 6795.8 6796.5 16:31:56 INFO - PROCESS | 3437 | 16:31:56 INFO - PROCESS | 3437 | [#5] yui.html Cycles:180 Average:15363.06 Median:4432.38 stddev:18178.58 (410.1%) stddev-sans-first:18196.71 16:31:56 INFO - PROCESS | 3437 | Values: 806.8 812.5 830.9 863.7 871.4 15020.6 15374.4 15386.3 15411.1 15431.4 14653.2 14676.1 14677.0 14829.6 14863.6 915.3 945.6 953.6 956.9 961.0 948.6 953.6 954.7 956.1 957.8 978.0 984.3 985.0 985.4 986.1 975.8 979.1 980.6 982.7 984.4 723.7 730.5 731.2 731.7 734.9 14098.6 14106.9 14127.6 14152.4 14183.7 13719.3 13792.2 13809.4 13872.2 14045.4 11738.2 11840.9 11863.4 11937.8 11959.7 3877.2 3911.6 3921.8 3932.8 3937.8 56396.7 56482.0 56520.7 56610.4 56699.0 10685.4 10764.3 10836.9 10879.5 11009.8 20149.7 20183.4 20244.4 20247.6 20256.4 8040.1 8110.9 8131.3 8132.6 8242.4 4330.4 4464.8 4535.3 4539.6 4741.7 3363.9 3373.5 3425.4 3426.6 3432.2 617.2 618.1 622.1 628.1 629.4 620.3 630.0 646.3 659.1 659.7 7971.4 8284.7 8343.8 8565.8 9247.9 556.2 615.0 626.3 638.2 641.4 4029.1 4125.6 4179.8 4318.4 4400.0 63943.7 64190.7 67282.0 69817.7 70084.0 51751.0 54805.2 55691.0 56691.1 58009.0 50674.5 50889.7 51267.5 52094.7 52434.2 8677.7 8764.6 8880.2 9025.1 9082.2 37149.4 38458.0 38481.6 39260.4 39285.6 49950.8 50992.2 51393.2 51802.0 51927.2 12549.8 12730.2 12759.8 12794.9 12924.5 13016.6 13147.2 13720.0 13914.4 14411.4 11638.4 11857.1 12239.9 12625.4 12656.5 12647.4 12828.8 12895.2 13008.4 13143.4 10117.6 10457.6 10540.8 10820.5 10996.5 10105.4 10135.6 10701.1 10709.1 10794.7 10218.7 10401.2 10534.2 10536.6 10570.6 16:31:56 INFO - PROCESS | 3437 | -------- Summary: end -------- 16:31:56 INFO - PROCESS | 3437 | 16:31:57 INFO - TEST-INFO | 3437: exit 0 16:31:57 INFO - TEST-OK | dromaeo_css | took 1110315ms 16:31:57 INFO - TEST-START | kraken 16:31:57 INFO - operating with platform_type : linux_ 16:31:57 INFO - Initialising browser for kraken test... 16:31:57 INFO - TEST-INFO | started process 3681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMQkv0/profile http://localhost:54996/getInfo.html) 16:32:01 INFO - PROCESS | 3681 | 16:32:01 INFO - PROCESS | 3681 | (process:3756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:32:02 INFO - PROCESS | 3681 | __metrics Screen width/height:1600/1200 16:32:02 INFO - PROCESS | 3681 | colorDepth:24 16:32:02 INFO - PROCESS | 3681 | Browser inner width/height: 1024/697 16:32:02 INFO - PROCESS | 3681 | __metrics 16:32:02 ERROR - PROCESS | 3681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:32:03 INFO - TEST-INFO | 3681: exit 0 16:32:03 INFO - Browser initialized. 16:32:03 INFO - Running cycle 1/1 for kraken test... 16:32:03 INFO - TEST-INFO | started process 3806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMQkv0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:05 INFO - PROCESS | 3806 | 16:32:05 INFO - PROCESS | 3806 | (process:3871): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:32:15 INFO - PROCESS | 3806 | RSS: Main: 150462464 16:32:15 INFO - PROCESS | 3806 | 16:32:18 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54996/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:18 INFO - PROCESS | 3806 | RSS: Main: 154513408 16:32:18 INFO - PROCESS | 3806 | 16:32:21 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54996/tests/kraken/driver.html?testName=audio-dft) 16:32:22 INFO - PROCESS | 3806 | RSS: Main: 154824704 16:32:22 INFO - PROCESS | 3806 | 16:32:24 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54996/tests/kraken/driver.html?testName=audio-fft) 16:32:25 INFO - PROCESS | 3806 | RSS: Main: 155189248 16:32:25 INFO - PROCESS | 3806 | 16:32:27 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54996/tests/kraken/driver.html?testName=audio-oscillator) 16:32:28 INFO - PROCESS | 3806 | RSS: Main: 154914816 16:32:28 INFO - PROCESS | 3806 | 16:32:30 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:30 INFO - PROCESS | 3806 | RSS: Main: 154947584 16:32:30 INFO - PROCESS | 3806 | 16:32:33 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54996/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:34 INFO - PROCESS | 3806 | RSS: Main: 155299840 16:32:34 INFO - PROCESS | 3806 | 16:32:37 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54996/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:38 INFO - PROCESS | 3806 | RSS: Main: 155332608 16:32:38 INFO - PROCESS | 3806 | 16:32:41 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54996/tests/kraken/driver.html?testName=json-parse-financial) 16:32:41 INFO - PROCESS | 3806 | RSS: Main: 155025408 16:32:41 INFO - PROCESS | 3806 | 16:32:43 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:44 INFO - PROCESS | 3806 | RSS: Main: 155140096 16:32:44 INFO - PROCESS | 3806 | 16:32:45 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:46 INFO - PROCESS | 3806 | RSS: Main: 154972160 16:32:46 INFO - PROCESS | 3806 | 16:32:48 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:49 INFO - PROCESS | 3806 | RSS: Main: 155254784 16:32:49 INFO - PROCESS | 3806 | 16:32:51 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:52 INFO - PROCESS | 3806 | RSS: Main: 156225536 16:32:52 INFO - PROCESS | 3806 | 16:32:54 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:55 INFO - PROCESS | 3806 | RSS: Main: 155881472 16:32:55 INFO - PROCESS | 3806 | 16:32:56 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:54996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54996/tests/kraken/driver.html?testName=ai-astar) 16:32:57 INFO - PROCESS | 3806 | RSS: Main: 157048832 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | __start_tp_report 16:32:57 INFO - PROCESS | 3806 | _x_x_mozilla_page_load 16:32:57 INFO - PROCESS | 3806 | _x_x_mozilla_page_load_details 16:32:57 INFO - PROCESS | 3806 | |i|pagename|runs| 16:32:57 INFO - PROCESS | 3806 | |0;ai-astar;116;107;112;111;112;125;111;112;115;114 16:32:57 INFO - PROCESS | 3806 | |1;audio-beat-detection;155;126;156;161;127;158;157;128;168;126 16:32:57 INFO - PROCESS | 3806 | |2;audio-dft;163;161;162;162;161;161;162;166;167;162 16:32:57 INFO - PROCESS | 3806 | |3;audio-fft;76;75;75;169;77;75;84;74;162;76 16:32:57 INFO - PROCESS | 3806 | |4;audio-oscillator;92;94;137;100;93;93;145;94;92;142 16:32:57 INFO - PROCESS | 3806 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;119;117;117 16:32:57 INFO - PROCESS | 3806 | |6;imaging-darkroom;147;146;146;147;148;147;146;147;146;147 16:32:57 INFO - PROCESS | 3806 | |7;imaging-desaturate;96;95;96;96;98;96;96;109;97;96 16:32:57 INFO - PROCESS | 3806 | |8;json-parse-financial;56;57;56;57;56;58;58;57;59;56 16:32:57 INFO - PROCESS | 3806 | |9;json-stringify-tinderbox;65;66;65;64;65;65;65;65;66;65 16:32:57 INFO - PROCESS | 3806 | |10;stanford-crypto-aes;77;79;86;81;78;79;87;78;78;78 16:32:57 INFO - PROCESS | 3806 | |11;stanford-crypto-ccm;113;112;114;122;114;116;114;120;114;113 16:32:57 INFO - PROCESS | 3806 | |12;stanford-crypto-pbkdf2;151;149;151;153;140;139;144;149;142;174 16:32:57 INFO - PROCESS | 3806 | |13;stanford-crypto-sha256-iterative;72;71;70;68;72;69;67;68;69;68 16:32:57 INFO - PROCESS | 3806 | __end_tp_report 16:32:57 INFO - PROCESS | 3806 | __start_cc_report 16:32:57 INFO - PROCESS | 3806 | _x_x_mozilla_cycle_collect,806 16:32:57 INFO - PROCESS | 3806 | __end_cc_report 16:32:57 INFO - PROCESS | 3806 | __startTimestamp1461972777181__endTimestamp 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | ------- Summary: start ------- 16:32:57 INFO - PROCESS | 3806 | Number of tests: 14 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.74 (4.2%) stddev-sans-first:4.94 16:32:57 INFO - PROCESS | 3806 | Values: 116.0 107.0 112.0 111.0 112.0 125.0 111.0 112.0 115.0 114.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:156.50 stddev:17.13 (10.9%) stddev-sans-first:17.87 16:32:57 INFO - PROCESS | 3806 | Values: 155.0 126.0 156.0 161.0 127.0 158.0 157.0 128.0 168.0 126.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.11 (1.3%) stddev-sans-first:2.24 16:32:57 INFO - PROCESS | 3806 | Values: 163.0 161.0 162.0 162.0 161.0 161.0 162.0 166.0 167.0 162.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:37.67 (49.9%) stddev-sans-first:39.36 16:32:57 INFO - PROCESS | 3806 | Values: 76.0 75.0 75.0 169.0 77.0 75.0 84.0 74.0 162.0 76.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.50 stddev:23.05 (24.9%) stddev-sans-first:23.70 16:32:57 INFO - PROCESS | 3806 | Values: 92.0 94.0 137.0 100.0 93.0 93.0 145.0 94.0 92.0 142.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:32:57 INFO - PROCESS | 3806 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 119.0 117.0 117.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:32:57 INFO - PROCESS | 3806 | Values: 147.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:96.00 stddev:4.12 (4.3%) stddev-sans-first:4.33 16:32:57 INFO - PROCESS | 3806 | Values: 96.0 95.0 96.0 96.0 98.0 96.0 96.0 109.0 97.0 96.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.05 (1.8%) stddev-sans-first:1.05 16:32:57 INFO - PROCESS | 3806 | Values: 56.0 57.0 56.0 57.0 56.0 58.0 58.0 57.0 59.0 56.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:32:57 INFO - PROCESS | 3806 | Values: 65.0 66.0 65.0 64.0 65.0 65.0 65.0 65.0 66.0 65.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:3.54 (4.5%) stddev-sans-first:3.57 16:32:57 INFO - PROCESS | 3806 | Values: 77.0 79.0 86.0 81.0 78.0 79.0 87.0 78.0 78.0 78.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:114.00 stddev:3.26 (2.9%) stddev-sans-first:3.36 16:32:57 INFO - PROCESS | 3806 | Values: 113.0 112.0 114.0 122.0 114.0 116.0 114.0 120.0 114.0 113.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:150.00 stddev:10.02 (6.7%) stddev-sans-first:10.61 16:32:57 INFO - PROCESS | 3806 | Values: 151.0 149.0 151.0 153.0 140.0 139.0 144.0 149.0 142.0 174.0 16:32:57 INFO - PROCESS | 3806 | 16:32:57 INFO - PROCESS | 3806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.78 (2.6%) stddev-sans-first:1.62 16:32:57 INFO - PROCESS | 3806 | Values: 72.0 71.0 70.0 68.0 72.0 69.0 67.0 68.0 69.0 68.0 16:32:57 INFO - PROCESS | 3806 | -------- Summary: end -------- 16:32:57 INFO - PROCESS | 3806 | 16:32:58 INFO - TEST-INFO | 3806: exit 0 16:32:58 INFO - TEST-OK | kraken | took 60838ms 16:32:58 INFO - SUITE-END | took 1171s 16:32:58 INFO - Completed test suite (00:19:31) 16:32:58 INFO - javascript benchmark 16:32:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3345.882894098707, 3363.075154332558, 3368.4947257911294, 3381.0, 3388.390089783838, 5399.325084364455, 5401.513863752271, 5407.837764867056, 5414.620976531634, 5415.0, 5416.729163541827, 5422.783088676458, 5423.538999185074, 5425.0, 5426.565874730022, 4918.090153321629, 4959.900801983958, 4987.1521841286885, 5016.924746128811, 5048.5203905628905, 4863.076015557051, 5017.322661440713, 5050.090983622947, 5112.156494178456, 5162.045021670984, 5073.2643766654, 5097.770600322976, 5124.231365295198, 5127.359080114986, 5128.948710512885, 4555.954440455619, 4919.1391506486225, 5075.822346217883, 5084.516970887741, 5096.108181068335, 4982.950170498321, 4985.102681517325, 4989.501049895018, 4990.82532111378, 4998.10034193845, 5294.92057619136, 5305.0, 5305.0450918834595, 5311.0, 5340.866478338034, 5758.3665796762325, 5759.798407055733, 5888.175655408247, 5892.410758924116, 5897.970510147465, 5913.852153696149, 5915.142304365886, 5925.822225333204, 5926.4666180044005, 5939.1388248704125, 5485.862853428656, 5504.587155963319, 5506.531944784698, 5512.421195774426, 5514.972425137848, 5901.114832775118, 5961.880762384815, 6059.697015149225, 6066.787662431793, 6106.297775755756, 5789.768409263666, 5790.739416726173, 5812.912806307824, 5817.767289308465, 5846.41535846412, 5701.600887937804, 5920.348761636216, 5930.970345148246, 5940.079287710412, 5949.702514874239, 5747.36778954323, 5793.217915581343, 5829.795957141565, 5832.387599302097, 5849.064149736022, 5831.241938547962, 5847.649141051551, 5859.2382990211, 5881.882362352729, 5888.823335299948, 4318.352247162888, 4366.476022877211, 4394.934075988863, 4441.977790111029, 4472.731636101845, 4030.0730831908827, 4050.25070361984, 4056.9797151014054, 4068.4710987571425, 4087.305158123126, 5621.550275977912, 5645.5483561314995, 5649.858753531113, 5653.23681303027, 5674.177244299636, 5859.091840764689, 5925.437083477149, 5951.434613711691, 5986.940130598726, 5995.46040856325, 5609.382967873531, 5630.915536266959, 5643.661380317194, 5645.858853528694, 5652.689102099342, 5045.949540504622, 5051.949480505222, 5071.239314102841, 5071.898562028812, 5087.160618497906, 5908.822735317947, 6072.36240194782, 6136.9079463808075, 6139.495823523265, 6147.508199344042, 5779.942200577941, 5888.676122813286, 5950.226470558973, 5953.077273022688, 5994.700264986646, 6064.696765161812, 6104.20645316106, 6111.297200821962, 6119.4798442132915, 6129.233845769279, 5704.229928959703, 5767.538596912321, 5855.3559108497175, 5875.588708790344, 5890.941090589211, 5874.559408044328, 5899.46904778572, 5900.970495147497, 5929.318128415115, 5929.673867937305, 5574.9163762542785, 5753.3958934311295, 5753.568482363923, 5768.682722450306, 5796.768129274782, 5754.165645981393, 5846.56150788684, 5855.912161317498, 5858.794942177004, 5881.029630110984, 5660.7169641518585, 5663.433656634304, 5689.345725241485, 5696.088625819849, 5721.542276617944, 5674.631148975469, 5792.044312688359, 5846.912296315473, 5851.093080572518, 5852.590318677651, 5719.199312096393, 5729.684867332337, 5744.253247077853, 5750.712464376848, 5774.624649397776], "unit": "score", "name": "dojo.html", "value": 5434.455258447225}, {"lowerIsBetter": false, "replicates": [569.5585920911293, 572.2189211725995, 575.7267115197943, 609.3875654966757, 614.5943677173067, 38232.0, 38822.0, 38957.22085558287, 38961.80519097404, 39118.41322380167, 41398.379024314585, 41780.0, 41829.0, 41977.58022419775, 42061.78969105158, 8753.95623021884, 8919.509426981513, 8955.104489551026, 8955.925288965333, 8962.73111806647, 8717.607707653171, 8903.154200350957, 8920.955395223014, 8924.509151996637, 8929.0, 8722.084181160983, 8906.73279801607, 8940.910590894106, 8950.552472376356, 8964.372493925428, 8776.254018408412, 8859.778505537348, 8866.645334186625, 8874.245689116433, 8885.200331970122, 8825.0, 8938.46369217849, 9177.908220917772, 9197.264218862541, 9216.631334746602, 43003.35494967578, 43660.345094823606, 43689.34465983013, 43704.12591748179, 43780.56219437797, 3716.888493345204, 3839.558450778168, 3859.8649047283493, 3902.828353369587, 4422.358757980075, 32721.509177362357, 32825.83587082049, 32841.34317313664, 32873.34253314944, 34324.6567534324, 3861.2470568239205, 3899.7270191086636, 3929.9214015719526, 3942.4874766280486, 3960.841566337343, 283799.0, 286639.0, 287177.5641121802, 287358.0, 287840.0, 67007.32992670109, 68032.0, 68269.3173068263, 68480.0, 68619.65690171518, 73696.26303737001, 73709.26290737132, 75654.62172689212, 75667.62166189133, 75748.62125689337, 18883.905580472285, 19322.516937076405, 19372.903135484234, 19385.321513746952, 19472.80527194738, 13862.65343366424, 14052.156870587592, 14075.929620351833, 14132.717345653235, 14156.221407822668, 23035.769642303363, 23213.651795223086, 23347.0, 23393.0, 23426.414339641644, 8178.223068808454, 8514.318854491627, 8563.400561960603, 8637.0, 8716.91283087161, 1035.8860525342357, 1070.7751372211767, 1105.1435137768133, 1129.3449799116493, 1157.6989982604416, 30170.0, 30766.692333076382, 30909.536356954664, 30919.072427827203, 31031.224219394244, 1108.7837871615118, 1113.6937342230951, 1131.8641762988493, 1155.7457359380924, 1215.228330010432, 15670.686586268439, 15681.451149209723, 16069.758953615705, 17324.133793310284, 18344.54138646518, 397122.0, 512231.0, 519159.0, 530205.0, 532357.0, 57624.42375576274, 58547.70726146342, 58600.41399586035, 58775.11837322444, 59116.704416477645, 1509.8414666459864, 1526.1072272720583, 1536.1320853717614, 1542.0, 1548.6438119232414, 30978.53532196974, 32108.19729506781, 32186.19534511656, 32312.83843580767, 32555.18612034718, 50068.0, 50155.49844501508, 50250.2462463056, 50814.237786432495, 50870.0, 311236.0, 314092.0, 315644.0, 316157.0, 319132.0, 34794.82602586971, 35186.648133518334, 35193.82403087968, 35350.82324588361, 35419.82290088533, 45604.315935261664, 45782.08435831331, 46278.537214627424, 46713.19720816762, 47102.76448617735, 39297.60702392939, 39393.2121357577, 39475.60524394719, 39642.2071558573, 39869.800650996556, 38097.0, 38316.61683383131, 39012.80493597514, 39490.0, 40065.39901901532, 38769.0, 38968.0, 39083.413748793224, 39921.0, 39931.60068399279, 33656.83171584126, 34364.65635343615, 34858.47712284369, 34959.12602184864, 35373.82313088521, 26965.865170674806, 27167.320816979733, 27224.863875680494, 27451.450970980866, 27700.722992769814], "unit": "score", "name": "ext.html", "value": 20358.02143058702}, {"lowerIsBetter": false, "replicates": [372.11436780462503, 385.2641454821292, 393.37846202999265, 394.8973266950593, 400.02593684378525, 17439.196860745367, 19647.607047859034, 20002.29991950282, 20239.696404553943, 20304.086316115754, 18398.080095995214, 18772.155253013614, 19019.2392304308, 19164.90417547914, 19248.326308579166, 5629.437056294369, 5832.125181222808, 5835.795747148851, 5858.677772722499, 5858.941410585882, 5044.142495775727, 5185.740712964355, 5186.5591424728755, 5196.038732834438, 5223.973880130613, 5191.039657663326, 5208.0, 5234.6335756497065, 5756.769729210827, 6038.909416358758, 5714.657120572738, 5965.61223520472, 5987.9401205987815, 6011.308699499548, 6021.337652858182, 5620.971895140498, 5625.803096891589, 5630.0, 5661.150827375926, 5675.801346952878, 13748.450061997508, 13916.791248131287, 14123.152610843383, 14852.925735371362, 14905.254737263094, 2296.2422400607925, 2382.814433499972, 2443.9022439102414, 2502.986290552329, 2927.34134819666, 9394.67118650844, 9688.031196880325, 10002.89997100027, 10611.41637209961, 10841.13270938323, 1980.6731889238258, 1988.741463609736, 2055.290924631, 2065.2255404223415, 2093.9162433502643, 66638.3336166637, 68078.31921680819, 68467.65766171138, 69230.65384673094, 69380.65309673469, 10608.257421980386, 11133.441318215457, 11343.829842552368, 11560.76878462426, 11617.0, 15305.31126099306, 15312.468753124822, 15553.844461555465, 15583.298751556207, 15624.531264062096, 8494.830103397897, 8580.914190858137, 8625.223729864343, 8645.135486451305, 8758.781030474289, 8407.327413806881, 8479.491230526188, 8491.320694344438, 8499.872501912476, 8570.700025499078, 4671.416072990876, 4793.592544633675, 4844.685095468783, 4863.294822250825, 4872.1473742094995, 1986.483514286296, 1988.0001795484368, 1993.0931426201043, 1995.348512222629, 2059.4645392198136, 931.9161275485103, 997.5062344139698, 1052.7947050325113, 1055.1295181475314, 1110.1174566219875, 17455.56361090983, 17591.856529325552, 17877.821221787617, 18470.81529184718, 18667.71998420025, 1028.4138041316378, 1032.4785983078498, 1052.4579841381694, 1066.7759770448138, 1080.0819303591884, 10332.638357657446, 10456.843147352796, 10499.422531760674, 10552.15582753378, 10584.417857017785, 440026.0, 445397.0, 446434.0, 447869.0, 451339.0, 78688.60655696684, 79082.0, 82183.5890820554, 83160.58419707863, 84898.0, 1025.9435731034864, 1041.614602597044, 1048.9318194317498, 1079.8704155501232, 1086.9619563315089, 16179.919100404893, 16188.433404830774, 16284.10437425953, 16449.83550164531, 16637.0, 34358.65641343554, 34983.825080874434, 35464.0, 35874.820625896704, 36479.635203647624, 50228.748856255486, 52237.0, 52614.0, 52669.73665131803, 53028.46971530235, 8749.825003500022, 8750.124987501198, 8769.254613357936, 8883.955580222058, 8963.148500892405, 9192.126747958933, 9666.903330966601, 9990.500474976367, 10215.94892025535, 10334.844977325196, 8798.34012449056, 8887.244584210415, 9273.72178834636, 9454.243660507005, 9687.079727425884, 9262.95368523153, 9270.165685088374, 9422.246220302222, 9531.189848862647, 9642.566084526354, 9473.857892131486, 9486.573104210465, 9559.139677428786, 9580.712578622653, 9823.410595364301, 12115.636530903734, 12214.145009849226, 12571.93714031424, 12722.745545089232, 12927.28899910514, 12605.43275552584, 12750.61748147557, 12840.0, 12889.548865789653, 12898.290594017419], "unit": "score", "name": "jquery.html", "value": 8876.250933338886}, {"lowerIsBetter": false, "replicates": [1604.5266646339328, 1622.7403615421536, 1915.3296346278805, 1932.719755635432, 1992.9003549822496, 7354.926450735491, 7814.257645523666, 8246.134155913625, 8437.915620843789, 8442.451240669352, 8124.5937703114905, 8163.877541836862, 8194.0, 8202.91797082029, 8225.670973161066, 2331.9300420987397, 2362.7164740231196, 2367.3134790910617, 2368.111958015744, 2372.074890792592, 2377.346229786805, 2417.758224177586, 2459.483508463225, 2479.5536803375385, 2484.5155194736944, 2426.0295881647307, 2431.5380077785253, 2433.5862903306393, 2479.590867506859, 2481.9751802481924, 2454.1901172612993, 2458.1519375815315, 2460.1758410932357, 2465.654808326836, 2507.3230227838562, 2393.3418309964727, 2396.59257926153, 2404.0504000919714, 2421.4309637235237, 2433.634954756783, 8343.207395297437, 8445.408821382505, 8451.53516556589, 8464.703735369232, 8479.491230526188, 5057.772400241998, 5193.195054766479, 5193.2989046479, 5201.219817027476, 5207.739613019372, 3198.424283628946, 3226.0, 3238.481842905124, 3282.556854824616, 3286.7370610351113, 1085.3069212029181, 1086.2483151711706, 1089.3333200203701, 1142.5658249865082, 1151.2804497189256, 11619.07047436203, 11736.061115110771, 11736.53053877844, 11739.295642261492, 11739.882601173964, 4702.6473014524045, 4756.595689366373, 4774.236122220428, 4787.736674482867, 4809.254565542346, 9999.700008999742, 10012.349197302152, 10034.046765557261, 10036.347637403545, 10067.496625168713, 5305.389880163753, 5316.149416093406, 5320.308359913187, 5320.52115309624, 5363.0, 4693.460252071056, 4815.7351345676325, 4817.759112044454, 4833.4199896012, 4844.0554091951735, 3733.831977560962, 3787.791671458096, 3795.6014618465215, 3803.8858834235016, 3817.1220619257724, 1161.9419029048513, 1166.1603645375317, 1173.978638584437, 1175.4299164905015, 1179.9174057815871, 1096.1231015187977, 1107.5569772091228, 1115.0243536905207, 1388.4376827384926, 1499.4077339450855, 8035.517868927883, 8073.515589064675, 8133.918660813316, 8163.346932245406, 8235.423520353637, 551.178743671926, 553.9612227144062, 554.9223108764776, 557.4704031170323, 560.5879678436346, 6154.446099851035, 6173.41352571505, 6177.7837775677635, 6184.350643182491, 6234.594751341239, 10032.69901902944, 10368.911264317137, 10410.843837342445, 10516.0, 10535.420551869567, 9603.327767056378, 10233.283670143019, 10261.486925653688, 10294.691159265234, 10332.070113689804, 7769.689212431439, 7878.842423151505, 7908.485948413335, 7943.960280198562, 7975.1626079262005, 7676.0, 7696.769096927102, 7728.26581474759, 7856.84286314282, 7862.371010319275, 8403.117672644285, 8430.114837941928, 9096.590653420479, 9277.536123193679, 9292.25661947029, 8525.317974562144, 8560.400771946153, 8586.957065214634, 8641.179087986631, 8686.39195256326, 7128.643567821692, 7322.414206863545, 7351.044364232829, 7389.926100738924, 7488.026556547614, 7981.2018798119725, 7992.320652744582, 7997.320227780704, 8014.078380986261, 8072.0, 7054.717811287491, 7089.220185779664, 7150.67821948024, 7277.235890231661, 7308.5614863108385, 7194.676239569337, 7200.567965922061, 7212.531185472927, 7302.160251570925, 7303.014093097577, 7519.73680921187, 7587.62061896914, 7597.3162415382885, 7607.809804754704, 7629.351505122127, 6955.443564514725, 7004.334588214111, 7020.227774944854, 7022.332878376546, 7031.718731250693, 6864.0, 7014.824629384306, 7087.574745515286, 7092.0, 7108.431325494052], "unit": "score", "name": "mootools.html", "value": 4729.98371095776}, {"lowerIsBetter": false, "replicates": [351.70456816274327, 353.7099578345756, 357.57448636122996, 360.5133070355021, 363.88355726167634, 6396.648184349859, 6443.259025212102, 6461.224653041636, 6489.8377540561505, 6498.317676643944, 6374.776882809103, 6383.968080159592, 6386.074019267215, 6398.744050237997, 6420.261669907962, 4757.524247575249, 4912.115819152551, 4915.139850526161, 4931.876703082416, 4952.182889823175, 4917.582005529534, 4925.802967881281, 4927.728974906397, 4938.654294199408, 4938.703677779326, 4849.806007759686, 4872.098661747588, 4873.7319447430555, 4919.212925931852, 4932.827351042714, 4917.704937703731, 4925.014997000596, 4931.482194369575, 4936.901261974776, 4938.061768264036, 4324.589164029412, 4334.479862416499, 4334.566543345672, 4336.414584031147, 4338.197433474786, 5881.029630111027, 6103.084537319393, 6106.542009349317, 6109.3890610939, 6114.0, 5678.034734095214, 5704.942950570524, 5720.399358067426, 5724.742386592613, 5738.741756620921, 6825.1127353444235, 6832.795016149524, 6849.554778939353, 6859.07402500661, 6861.279565645636, 4672.5327467253, 4673.135469938073, 4678.134545109166, 4686.179918514281, 4696.03731235096, 7041.049458323112, 7086.185088714812, 7094.503384763068, 7108.4668649851465, 7123.679434425463, 4661.487236403993, 4711.340412342275, 4733.41430620739, 4738.786754596052, 4745.857624271277, 4804.6876952997945, 4821.325014497973, 4824.324594556765, 4830.565249127595, 4835.879103022382, 5530.446955304437, 5571.916421253684, 5582.0, 5592.608517403824, 5652.6325788824415, 6866.0, 6866.176058872968, 6867.0, 6884.139482564679, 6906.136732908387, 1649.4062137630444, 1693.1872701103293, 1699.4816580942932, 1711.7261238201827, 1735.947921562355, 1102.1843835561626, 1110.228391268077, 1110.2949626986922, 1111.4387234446554, 1115.2639258089785, 6475.6438395887735, 6523.869522609616, 6574.276829548746, 6581.703823327962, 6632.801015969529, 6985.301469852974, 7010.263922288188, 7013.92986070143, 7017.333353331425, 7030.824229394306, 6576.342365763481, 6586.934130658728, 6588.439982601437, 6593.835154121185, 6604.768833090819, 3743.6256374362893, 3783.754055986352, 3790.1282704977457, 3794.29805485986, 3810.980945095312, 7168.892466613005, 7225.710971561079, 7236.96381518089, 7249.238829922888, 7306.671199796022, 7285.854282914312, 7295.489315747846, 7309.086364204474, 7332.5967071811565, 7333.596652184181, 7325.670344834602, 7401.48189626721, 7402.111746590336, 7414.592197429085, 7415.703371865173, 6962.268961759145, 7113.82215444618, 7132.072830531998, 7137.357637812622, 7172.462065345225, 6978.371946524837, 6991.335823096798, 6995.090638217, 7008.929910700827, 7015.36861682451, 7275.781726548212, 7284.635768211462, 7291.161516425467, 7293.927060729537, 7305.050343455317, 4868.391451068616, 4913.582345500529, 4915.901681966269, 4926.359573255597, 4952.653314267966, 6917.515773895981, 7029.789106326818, 7106.538075025107, 7118.28817118284, 7124.430045596444, 6888.380045795902, 6888.793336199922, 6901.137357830271, 6920.169579650475, 6930.445564354739, 6890.0, 6890.173179218526, 6891.3797758202, 6902.620355880274, 6912.723491060301, 6743.9325606743305, 6750.1562304711915, 6750.628715420699, 6758.121444212417, 6760.08738820253, 6744.69648865812, 6950.6177160256675, 6953.965230173817, 6958.617276049663, 6964.442844572523, 6737.3599508046655, 6786.321367863372, 6788.321167883172, 6795.830104247433, 6796.456283497408], "unit": "score", "name": "prototype.html", "value": 5146.454684777417}, {"lowerIsBetter": false, "replicates": [806.7741032510899, 812.5043723328765, 830.9335253179743, 863.7149740585606, 871.4248595926686, 15020.624484387896, 15374.385024599003, 15386.307616157272, 15411.07533547988, 15431.382744690227, 14653.194074325907, 14676.119432834037, 14677.0, 14829.629259268524, 14863.554093377188, 915.2952226785371, 945.6264775413707, 953.6090203016764, 956.8899576548716, 961.024560071528, 948.6158105967095, 953.5661274120293, 954.6992697300328, 956.0964888180672, 957.7844984878382, 978.0268632710463, 984.2962281968391, 985.0248254228298, 985.3792110970114, 986.0977205856633, 975.7560609847538, 979.0601023017912, 980.6371642492323, 982.6953644370268, 984.4487087231173, 723.6815801047522, 730.5361095704266, 731.2102928836844, 731.7182884589419, 734.8640501507185, 14098.647533811736, 14106.858931410658, 14127.646808829759, 14152.433902643881, 14183.71632567343, 13719.314034298344, 13792.241426721526, 13809.447622095104, 13872.237026963512, 14045.367958441895, 11738.23701459411, 11840.88159118415, 11863.406829658568, 11937.761244775056, 11959.701007474796, 3877.1664092220026, 3911.6479516843337, 3921.784301863396, 3932.8230229639735, 3937.7637341759587, 56396.718016410065, 56482.0, 56520.717396413165, 56610.43389566134, 56699.0, 10685.358878467161, 10764.300320479144, 10836.945815270874, 10879.456027198608, 11009.83485247722, 20149.697754533692, 20183.39449816508, 20244.392668219978, 20247.59504809925, 20256.392308230777, 8040.0705129165435, 8110.878336824952, 8131.349492040741, 8132.634031468599, 8242.381821363422, 4330.437043184366, 4464.799084041226, 4535.297028960516, 4539.591436770706, 4741.668083234141, 3363.899083027513, 3373.4602463605706, 3425.36630723312, 3426.588809342845, 3432.1591210153674, 617.2315467243221, 618.13769791142, 622.0668996505242, 628.1174949196386, 629.3706293706293, 620.2804746494045, 629.9622022678562, 646.3342756960338, 659.1036190780535, 659.7427003468651, 7971.441999060126, 8284.668613255522, 8343.8331233375, 8565.828683426296, 9247.907520924704, 556.1962963517759, 614.9576467886978, 626.3485974586379, 638.2149955554694, 641.4131070070833, 4029.0531725044593, 4125.5874412558505, 4179.832806687698, 4318.417013703172, 4399.956000440018, 63943.680281598296, 64190.67904660447, 67282.0, 69817.65091174614, 70084.0, 51751.0, 54805.1779223312, 55691.0, 56691.14963275554, 58008.999999999156, 50674.49325506771, 50889.745551272004, 51267.48732512702, 52094.739526302124, 52434.21348679773, 8677.739667809976, 8764.649414023623, 8880.200781929658, 9025.142611451902, 9082.228010618906, 37149.442758358105, 38458.0, 38481.615183848924, 39260.411093834184, 39285.60714392934, 49950.750246248535, 50992.23511647254, 51393.229101562756, 51802.0, 51927.2210916829, 12549.811752823898, 12730.17253878495, 12759.80860287115, 12794.87205127974, 12924.547640832525, 13016.609501714964, 13147.211167329991, 13720.0, 13914.373853176834, 14411.351489182802, 11638.35989020612, 11857.110716696456, 12239.938800306298, 12625.368731563569, 12656.493740250655, 12647.430865610886, 12828.807567886302, 12895.16181448203, 13008.414621341873, 13143.408546615616, 10117.59529618807, 10457.63398281087, 10540.789184216426, 10820.458977051274, 10996.505157268102, 10105.44420056904, 10135.594576216869, 10701.143908487147, 10709.08972737326, 10794.676159715222, 10218.744531386776, 10401.21990850674, 10534.209934254808, 10536.578536858746, 10570.630027948984], "unit": "score", "name": "yui.html", "value": 6903.285364549577}], "name": "dromaeo_css", "value": 7406.227324385943}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 107.0, 112.0, 111.0, 112.0, 125.0, 111.0, 112.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 156.0, 161.0, 127.0, 158.0, 157.0, 128.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 166.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 169.0, 77.0, 75.0, 84.0, 74.0, 162.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.3}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 137.0, 100.0, 93.0, 93.0, 145.0, 94.0, 92.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 98.0, 96.0, 96.0, 109.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 57.0, 56.0, 58.0, 58.0, 57.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 86.0, 81.0, 78.0, 79.0, 87.0, 78.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 114.0, 122.0, 114.0, 116.0, 114.0, 120.0, 114.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.2}, {"lowerIsBetter": true, "replicates": [151.0, 149.0, 151.0, 153.0, 140.0, 139.0, 144.0, 149.0, 142.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 70.0, 68.0, 72.0, 69.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1522.5}]} 16:32:58 INFO - Return code: 0 16:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:32:58 ERROR - # TBPL SUCCESS # 16:32:58 INFO - Running post-action listener: _resource_record_post_action 16:32:58 INFO - Running post-run listener: _resource_record_post_run 16:32:59 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 7585792; Write bytes: 346050560; Read time: 1408; Write time: 271452 16:32:59 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 1277952; Read time: 0; Write time: 64 16:32:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 7585792; Write bytes: 344772608; Read time: 1408; Write time: 271388 16:32:59 INFO - Running post-run listener: _upload_blobber_files 16:32:59 INFO - Blob upload gear active. 16:32:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:59 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 16:32:59 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'] 16:32:59 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 16:32:59 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:00 INFO - (blobuploader) - INFO - Done attempting. 16:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:01 INFO - (blobuploader) - INFO - Done attempting. 16:33:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:01 INFO - Return code: 0 16:33:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eff7bd44b18e5db9ef8b9686a4298e6524b4532c37e51322b08ebdaeb6939fe4c210c75314d158f810363520c962d63a68b3d67e0fbe5dbb63f7ff6ade972f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0c068dc2e9822101ac93e36f78b5e13dc810915af02788dcb0c3770d67c88c107176d16de230c9159323eabdfaf3ff97e36557825817f1257a994220ec92cd7"} 16:33:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:01 INFO - Contents: 16:33:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eff7bd44b18e5db9ef8b9686a4298e6524b4532c37e51322b08ebdaeb6939fe4c210c75314d158f810363520c962d63a68b3d67e0fbe5dbb63f7ff6ade972f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0c068dc2e9822101ac93e36f78b5e13dc810915af02788dcb0c3770d67c88c107176d16de230c9159323eabdfaf3ff97e36557825817f1257a994220ec92cd7"} 16:33:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:01 INFO - Copying logs to upload dir... 16:33:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1407.165238 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 27 secs) (at 2016-04-29 16:33:01.499168) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 16:33:01.502597) ========= 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=cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547 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/eff7bd44b18e5db9ef8b9686a4298e6524b4532c37e51322b08ebdaeb6939fe4c210c75314d158f810363520c962d63a68b3d67e0fbe5dbb63f7ff6ade972f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0c068dc2e9822101ac93e36f78b5e13dc810915af02788dcb0c3770d67c88c107176d16de230c9159323eabdfaf3ff97e36557825817f1257a994220ec92cd7"} build_url:https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/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/eff7bd44b18e5db9ef8b9686a4298e6524b4532c37e51322b08ebdaeb6939fe4c210c75314d158f810363520c962d63a68b3d67e0fbe5dbb63f7ff6ade972f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0c068dc2e9822101ac93e36f78b5e13dc810915af02788dcb0c3770d67c88c107176d16de230c9159323eabdfaf3ff97e36557825817f1257a994220ec92cd7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 16:33:01.527550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:33:01.527892) ========= 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=cbe409c6de289db6ac707de3000001d4-1461971349.751556-1082483547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004362 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:33:01.612482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 16:33:01.612804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 16:33:01.613151) ========= ========= Total master_lag: 0.15 =========