builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1467543558.03 results: success (0) buildid: 20160703011523 builduid: d5f10c7169954150ac34f80025790374 revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.033850) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.034331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.034611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.053735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.054018) ========= 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=eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 03:59:18-- 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% 220M=0s 2016-07-03 03:59:19 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.229601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.229908) ========= 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=eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020974 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.286872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.287186) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --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 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --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=eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 03:59:19,189 truncating revision to first 12 chars 2016-07-03 03:59:19,189 Setting DEBUG logging. 2016-07-03 03:59:19,189 attempt 1/10 2016-07-03 03:59:19,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13ce99eb20be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 03:59:19,500 unpacking tar archive at: mozilla-beta-13ce99eb20be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.929495) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.930064) ========= script_repo_revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.930846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.931472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:59:18.942357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-03 03:59:18.942665) ========= /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=eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:19 INFO - MultiFileLogger online at 20160703 03:59:19 in /builds/slave/test 03:59:19 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 03:59:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:19 INFO - {'append_to_log': False, 03:59:19 INFO - 'base_work_dir': '/builds/slave/test', 03:59:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:59:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:19 INFO - 'branch': 'Mozilla-Beta', 03:59:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:19 INFO - 'config_files': ('talos/linux_config.py',), 03:59:19 INFO - 'default_actions': ('clobber', 03:59:19 INFO - 'read-buildbot-config', 03:59:19 INFO - 'download-and-extract', 03:59:19 INFO - 'populate-webroot', 03:59:19 INFO - 'create-virtualenv', 03:59:19 INFO - 'install', 03:59:19 INFO - 'run-tests'), 03:59:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:19 INFO - 'download_minidump_stackwalk': True, 03:59:19 INFO - 'download_symbols': 'ondemand', 03:59:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:19 INFO - 'installer_path': 'installer.exe', 03:59:19 INFO - 'log_level': 'info', 03:59:19 INFO - 'log_name': 'talos', 03:59:19 INFO - 'log_to_console': True, 03:59:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:19 INFO - 'opt_config_files': (), 03:59:19 INFO - 'pip_index': False, 03:59:19 INFO - 'sps_profile': False, 03:59:19 INFO - 'sps_profile_interval': 0, 03:59:19 INFO - 'suite': 'dromaeojs-e10s', 03:59:19 INFO - 'system_bits': '32', 03:59:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:19 INFO - 'title': 'talos-linux64-ix-010', 03:59:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:19 INFO - 'use_talos_json': True, 03:59:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:19 INFO - 'work_dir': 'build'} 03:59:19 INFO - ##### 03:59:19 INFO - ##### Running clobber step. 03:59:19 INFO - ##### 03:59:19 INFO - Running pre-action listener: _resource_record_pre_action 03:59:19 INFO - Running main action method: clobber 03:59:19 INFO - rmtree: /builds/slave/test/build 03:59:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:20 INFO - Running post-action listener: _resource_record_post_action 03:59:20 INFO - ##### 03:59:20 INFO - ##### Running read-buildbot-config step. 03:59:20 INFO - ##### 03:59:20 INFO - Running pre-action listener: _resource_record_pre_action 03:59:20 INFO - Running main action method: read_buildbot_config 03:59:20 INFO - Using buildbot properties: 03:59:20 INFO - { 03:59:20 INFO - "project": "", 03:59:20 INFO - "product": "firefox", 03:59:20 INFO - "script_repo_revision": "production", 03:59:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:59:20 INFO - "repository": "", 03:59:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 03:59:20 INFO - "buildid": "20160703011523", 03:59:20 INFO - "pgo_build": "True", 03:59:20 INFO - "basedir": "/builds/slave/test", 03:59:20 INFO - "buildnumber": 28, 03:59:20 INFO - "slavename": "talos-linux64-ix-010", 03:59:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:59:20 INFO - "platform": "ubuntu64_hw", 03:59:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:59:20 INFO - "branch": "mozilla-beta", 03:59:20 INFO - "repo_path": "releases/mozilla-beta", 03:59:20 INFO - "revision": "13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67", 03:59:20 INFO - "stage_platform": "linux64-pgo", 03:59:20 INFO - "builduid": "d5f10c7169954150ac34f80025790374", 03:59:20 INFO - "slavebuilddir": "test" 03:59:20 INFO - } 03:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:59:20 INFO - Running post-action listener: _resource_record_post_action 03:59:20 INFO - ##### 03:59:20 INFO - ##### Running download-and-extract step. 03:59:20 INFO - ##### 03:59:20 INFO - Running pre-action listener: _resource_record_pre_action 03:59:20 INFO - Running main action method: download_and_extract 03:59:20 INFO - mkdir: /builds/slave/test/build/tests 03:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:20 INFO - https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:59:24 INFO - Downloaded 1327 bytes. 03:59:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:59:24 INFO - Using the following test package requirements: 03:59:24 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:59:24 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:24 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:59:24 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'jsshell-linux-x86_64.zip'], 03:59:24 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:24 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:59:24 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:59:24 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:59:24 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:24 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:59:24 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:24 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:24 INFO - https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:25 INFO - Downloaded 24237200 bytes. 03:59:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:26 INFO - Return code: 0 03:59:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:26 INFO - https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:31 INFO - Downloaded 24237200 bytes. 03:59:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:33 INFO - Return code: 0 03:59: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')]} 03:59:33 INFO - https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:59:34 INFO - Downloaded 10840145 bytes. 03:59:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:59:34 INFO - Return code: 0 03:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:34 INFO - https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:59:35 INFO - Downloaded 56015112 bytes. 03:59:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:59:35 INFO - mkdir: /builds/slave/test/properties 03:59:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:35 INFO - Contents: 03:59:35 INFO - build_url:https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:59:36 INFO - Running post-action listener: _resource_record_post_action 03:59:36 INFO - Running post-action listener: set_extra_try_arguments 03:59:36 INFO - ##### 03:59:36 INFO - ##### Running populate-webroot step. 03:59:36 INFO - ##### 03:59:36 INFO - Running pre-action listener: _resource_record_pre_action 03:59:36 INFO - Running main action method: populate_webroot 03:59:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:36 INFO - '--tppagecycles', 03:59:36 INFO - '7'], 03:59:36 INFO - 'tests': ['tsvgm']}}, 03:59:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['damp', 'tps']}, 03:59:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'tests': ['damp', 'tps']}, 03:59:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['dromaeo_dom']}, 03:59:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['a11yr', 03:59:36 INFO - 'ts_paint', 03:59:36 INFO - 'tpaint', 03:59:36 INFO - 'sessionrestore', 03:59:36 INFO - 'sessionrestore_no_auto_restore', 03:59:36 INFO - 'tabpaint']}, 03:59:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:36 INFO - 'ts_paint', 03:59:36 INFO - 'tpaint', 03:59:36 INFO - 'sessionrestore', 03:59:36 INFO - 'sessionrestore_no_auto_restore', 03:59:36 INFO - 'tabpaint']}, 03:59:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:59:36 INFO - 'ts_paint', 03:59:36 INFO - 'tpaint', 03:59:36 INFO - 'sessionrestore', 03:59:36 INFO - 'sessionrestore_no_auto_restore', 03:59:36 INFO - 'tabpaint']}, 03:59:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:59:36 INFO - 'ts_paint', 03:59:36 INFO - 'tpaint', 03:59:36 INFO - 'sessionrestore', 03:59:36 INFO - 'sessionrestore_no_auto_restore', 03:59:36 INFO - 'tabpaint']}, 03:59:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['a11yr', 03:59:36 INFO - 'ts_paint', 03:59:36 INFO - 'tpaint', 03:59:36 INFO - 'sessionrestore', 03:59:36 INFO - 'sessionrestore_no_auto_restore', 03:59:36 INFO - 'tabpaint']}, 03:59:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['a11yr', 03:59:36 INFO - 'ts_paint', 03:59:36 INFO - 'tpaint', 03:59:36 INFO - 'sessionrestore', 03:59:36 INFO - 'sessionrestore_no_auto_restore', 03:59:36 INFO - 'tabpaint']}, 03:59:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['tsvgx', 03:59:36 INFO - 'tsvgr_opacity', 03:59:36 INFO - 'tart', 03:59:36 INFO - 'tscrollx', 03:59:36 INFO - 'cart']}, 03:59:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:36 INFO - 'tsvgr_opacity', 03:59:36 INFO - 'tart', 03:59:36 INFO - 'tscrollx', 03:59:36 INFO - 'cart']}, 03:59:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'talos_options': ['--disable-e10s'], 03:59:36 INFO - 'tests': ['tp5o']}, 03:59:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'tests': ['tp5o']}, 03:59:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'talos_options': ['--disable-e10s', 03:59:36 INFO - '--xperf_path', 03:59:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:36 INFO - 'tests': ['tp5n']}, 03:59:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:36 INFO - 'talos_options': ['--xperf_path', 03:59:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:36 INFO - 'tests': ['tp5n']}}, 03:59:36 INFO - 'talos.zip': {'path': '', 03:59:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:36 INFO - Running post-action listener: _resource_record_post_action 03:59:36 INFO - ##### 03:59:36 INFO - ##### Running create-virtualenv step. 03:59:36 INFO - ##### 03:59:36 INFO - Running pre-action listener: _resource_record_pre_action 03:59:36 INFO - Running main action method: create_virtualenv 03:59:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:59:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:36 INFO - Using real prefix '/usr' 03:59:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:39 INFO - Installing pip.................done. 03:59:39 INFO - Return code: 0 03:59:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:39 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:59:39 INFO - Using env: {'DISPLAY': ':0', 03:59:39 INFO - 'HOME': '/home/cltbld', 03:59:39 INFO - 'LANG': 'en_US.UTF-8', 03:59:39 INFO - 'LANGUAGE': 'en_US:en', 03:59:39 INFO - 'LOGNAME': 'cltbld', 03:59:39 INFO - 'MAIL': '/var/mail/cltbld', 03:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:39 INFO - 'MOZ_NO_REMOTE': '1', 03:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:39 INFO - 'NO_EM_RESTART': '1', 03:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:39 INFO - 'PWD': '/builds/slave/test', 03:59:39 INFO - 'SHELL': '/bin/bash', 03:59:39 INFO - 'SHLVL': '1', 03:59:39 INFO - 'TERM': 'linux', 03:59:39 INFO - 'TMOUT': '86400', 03:59:39 INFO - 'USER': 'cltbld', 03:59:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:39 INFO - '_': '/tools/buildbot/bin/python'} 03:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:59:39 INFO - Cleaning up... 03:59:39 INFO - Return code: 0 03:59:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:39 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:59:39 INFO - Using env: {'DISPLAY': ':0', 03:59:39 INFO - 'HOME': '/home/cltbld', 03:59:39 INFO - 'LANG': 'en_US.UTF-8', 03:59:39 INFO - 'LANGUAGE': 'en_US:en', 03:59:39 INFO - 'LOGNAME': 'cltbld', 03:59:39 INFO - 'MAIL': '/var/mail/cltbld', 03:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:39 INFO - 'MOZ_NO_REMOTE': '1', 03:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:39 INFO - 'NO_EM_RESTART': '1', 03:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:39 INFO - 'PWD': '/builds/slave/test', 03:59:39 INFO - 'SHELL': '/bin/bash', 03:59:39 INFO - 'SHLVL': '1', 03:59:39 INFO - 'TERM': 'linux', 03:59:39 INFO - 'TMOUT': '86400', 03:59:39 INFO - 'USER': 'cltbld', 03:59:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:39 INFO - '_': '/tools/buildbot/bin/python'} 03:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:39 INFO - Downloading/unpacking psutil>=0.7.1 03:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:41 INFO - Installing collected packages: psutil 03:59:41 INFO - Running setup.py install for psutil 03:59:41 INFO - building 'psutil._psutil_linux' extension 03:59:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:59:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:59:41 INFO - building 'psutil._psutil_posix' extension 03:59:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:59:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:42 INFO - Successfully installed psutil 03:59:42 INFO - Cleaning up... 03:59:42 INFO - Return code: 0 03:59:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:42 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:59:42 INFO - Using env: {'DISPLAY': ':0', 03:59:42 INFO - 'HOME': '/home/cltbld', 03:59:42 INFO - 'LANG': 'en_US.UTF-8', 03:59:42 INFO - 'LANGUAGE': 'en_US:en', 03:59:42 INFO - 'LOGNAME': 'cltbld', 03:59:42 INFO - 'MAIL': '/var/mail/cltbld', 03:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:42 INFO - 'MOZ_NO_REMOTE': '1', 03:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:42 INFO - 'NO_EM_RESTART': '1', 03:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:42 INFO - 'PWD': '/builds/slave/test', 03:59:42 INFO - 'SHELL': '/bin/bash', 03:59:42 INFO - 'SHLVL': '1', 03:59:42 INFO - 'TERM': 'linux', 03:59:42 INFO - 'TMOUT': '86400', 03:59:42 INFO - 'USER': 'cltbld', 03:59:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:42 INFO - '_': '/tools/buildbot/bin/python'} 03:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:59:44 INFO - Installing collected packages: mozsystemmonitor 03:59:44 INFO - Running setup.py install for mozsystemmonitor 03:59:44 INFO - Successfully installed mozsystemmonitor 03:59:44 INFO - Cleaning up... 03:59:44 INFO - Return code: 0 03:59:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:44 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:59:44 INFO - Using env: {'DISPLAY': ':0', 03:59:44 INFO - 'HOME': '/home/cltbld', 03:59:44 INFO - 'LANG': 'en_US.UTF-8', 03:59:44 INFO - 'LANGUAGE': 'en_US:en', 03:59:44 INFO - 'LOGNAME': 'cltbld', 03:59:44 INFO - 'MAIL': '/var/mail/cltbld', 03:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:44 INFO - 'MOZ_NO_REMOTE': '1', 03:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:44 INFO - 'NO_EM_RESTART': '1', 03:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:44 INFO - 'PWD': '/builds/slave/test', 03:59:44 INFO - 'SHELL': '/bin/bash', 03:59:44 INFO - 'SHLVL': '1', 03:59:44 INFO - 'TERM': 'linux', 03:59:44 INFO - 'TMOUT': '86400', 03:59:44 INFO - 'USER': 'cltbld', 03:59:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:44 INFO - '_': '/tools/buildbot/bin/python'} 03:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:47 INFO - Downloading docopt-0.6.1.tar.gz 03:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:47 INFO - Running setup.py install for blobuploader 03:59:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:47 INFO - Running setup.py install for requests 03:59:47 INFO - Running setup.py install for docopt 03:59:47 INFO - Successfully installed blobuploader requests docopt 03:59:47 INFO - Cleaning up... 03:59:47 INFO - Return code: 0 03:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:47 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:47 INFO - Using env: {'DISPLAY': ':0', 03:59:47 INFO - 'HOME': '/home/cltbld', 03:59:47 INFO - 'LANG': 'en_US.UTF-8', 03:59:47 INFO - 'LANGUAGE': 'en_US:en', 03:59:47 INFO - 'LOGNAME': 'cltbld', 03:59:47 INFO - 'MAIL': '/var/mail/cltbld', 03:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:47 INFO - 'MOZ_NO_REMOTE': '1', 03:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:47 INFO - 'NO_EM_RESTART': '1', 03:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:47 INFO - 'PWD': '/builds/slave/test', 03:59:47 INFO - 'SHELL': '/bin/bash', 03:59:47 INFO - 'SHLVL': '1', 03:59:47 INFO - 'TERM': 'linux', 03:59:47 INFO - 'TMOUT': '86400', 03:59:47 INFO - 'USER': 'cltbld', 03:59:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:47 INFO - '_': '/tools/buildbot/bin/python'} 03:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:48 INFO - Running setup.py (path:/tmp/pip-aZ0BD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:48 INFO - Running setup.py (path:/tmp/pip-pLdhfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:48 INFO - Running setup.py (path:/tmp/pip-sE0YNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:48 INFO - Running setup.py (path:/tmp/pip-zpsnva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:48 INFO - Running setup.py (path:/tmp/pip-kSPXS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:48 INFO - Running setup.py (path:/tmp/pip-3EqFsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:48 INFO - Running setup.py (path:/tmp/pip-fdtfMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:48 INFO - Running setup.py (path:/tmp/pip-Azbpxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:48 INFO - Running setup.py (path:/tmp/pip-HYftxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:48 INFO - Running setup.py (path:/tmp/pip-PZ08Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:48 INFO - Running setup.py (path:/tmp/pip-4U7Uwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:48 INFO - Running setup.py (path:/tmp/pip-uSua1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:49 INFO - Running setup.py (path:/tmp/pip-7786BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:49 INFO - Running setup.py (path:/tmp/pip-ba_XgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:49 INFO - Running setup.py (path:/tmp/pip-63YNsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:49 INFO - Running setup.py (path:/tmp/pip-tF7JVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:49 INFO - Running setup.py (path:/tmp/pip-a56pXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:49 INFO - Running setup.py install for manifestparser 03:59:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:49 INFO - Running setup.py install for mozcrash 03:59:49 INFO - Running setup.py install for mozdebug 03:59:49 INFO - Running setup.py install for mozdevice 03:59:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:49 INFO - Running setup.py install for mozfile 03:59:49 INFO - Running setup.py install for mozhttpd 03:59:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozinfo 03:59:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozInstall 03:59:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozleak 03:59:50 INFO - Running setup.py install for mozlog 03:59:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for moznetwork 03:59:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozprocess 03:59:50 INFO - Running setup.py install for mozprofile 03:59:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozrunner 03:59:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozscreenshot 03:59:50 INFO - Running setup.py install for moztest 03:59:51 INFO - Running setup.py install for mozversion 03:59:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:51 INFO - Cleaning up... 03:59:51 INFO - Return code: 0 03:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:51 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:51 INFO - Using env: {'DISPLAY': ':0', 03:59:51 INFO - 'HOME': '/home/cltbld', 03:59:51 INFO - 'LANG': 'en_US.UTF-8', 03:59:51 INFO - 'LANGUAGE': 'en_US:en', 03:59:51 INFO - 'LOGNAME': 'cltbld', 03:59:51 INFO - 'MAIL': '/var/mail/cltbld', 03:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:51 INFO - 'MOZ_NO_REMOTE': '1', 03:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:51 INFO - 'NO_EM_RESTART': '1', 03:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:51 INFO - 'PWD': '/builds/slave/test', 03:59:51 INFO - 'SHELL': '/bin/bash', 03:59:51 INFO - 'SHLVL': '1', 03:59:51 INFO - 'TERM': 'linux', 03:59:51 INFO - 'TMOUT': '86400', 03:59:51 INFO - 'USER': 'cltbld', 03:59:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:51 INFO - '_': '/tools/buildbot/bin/python'} 03:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:51 INFO - Running setup.py (path:/tmp/pip-EgpbLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:51 INFO - Running setup.py (path:/tmp/pip-PcOLjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:51 INFO - Running setup.py (path:/tmp/pip-CkkDTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:51 INFO - Running setup.py (path:/tmp/pip-z9W7Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:51 INFO - Running setup.py (path:/tmp/pip-XNZL0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:51 INFO - Running setup.py (path:/tmp/pip-gIKwdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:51 INFO - Running setup.py (path:/tmp/pip-EUBhcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:51 INFO - Running setup.py (path:/tmp/pip-_qIbkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:52 INFO - Running setup.py (path:/tmp/pip-kbI3YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:52 INFO - Running setup.py (path:/tmp/pip-29Pfwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:52 INFO - Running setup.py (path:/tmp/pip-sN5TZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:52 INFO - Running setup.py (path:/tmp/pip-0RNyb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:52 INFO - Running setup.py (path:/tmp/pip-aOl4yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:52 INFO - Running setup.py (path:/tmp/pip-CM0OKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:52 INFO - Running setup.py (path:/tmp/pip-2HKc6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:52 INFO - Running setup.py (path:/tmp/pip-NXeWdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:52 INFO - Running setup.py (path:/tmp/pip-3CsFe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:54 INFO - Downloading blessings-1.6.tar.gz 03:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:54 INFO - Installing collected packages: blessings 03:59:54 INFO - Running setup.py install for blessings 03:59:54 INFO - Successfully installed blessings 03:59:54 INFO - Cleaning up... 03:59:54 INFO - Return code: 0 03:59:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:55 INFO - Reading from file tmpfile_stdout 03:59:55 INFO - Current package versions: 03:59:55 INFO - argparse == 1.2.1 03:59:55 INFO - blessings == 1.6 03:59:55 INFO - blobuploader == 1.2.4 03:59:55 INFO - docopt == 0.6.1 03:59:55 INFO - manifestparser == 1.1 03:59:55 INFO - mozInstall == 1.12 03:59:55 INFO - mozcrash == 0.17 03:59:55 INFO - mozdebug == 0.1 03:59:55 INFO - mozdevice == 0.48 03:59:55 INFO - mozfile == 1.2 03:59:55 INFO - mozhttpd == 0.7 03:59:55 INFO - mozinfo == 0.9 03:59:55 INFO - mozleak == 0.1 03:59:55 INFO - mozlog == 3.1 03:59:55 INFO - moznetwork == 0.27 03:59:55 INFO - mozprocess == 0.22 03:59:55 INFO - mozprofile == 0.28 03:59:55 INFO - mozrunner == 6.11 03:59:55 INFO - mozscreenshot == 0.1 03:59:55 INFO - mozsystemmonitor == 0.0 03:59:55 INFO - moztest == 0.7 03:59:55 INFO - mozversion == 1.4 03:59:55 INFO - psutil == 3.1.1 03:59:55 INFO - requests == 1.2.3 03:59:55 INFO - wsgiref == 0.1.2 03:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:55 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:55 INFO - Using env: {'DISPLAY': ':0', 03:59:55 INFO - 'HOME': '/home/cltbld', 03:59:55 INFO - 'LANG': 'en_US.UTF-8', 03:59:55 INFO - 'LANGUAGE': 'en_US:en', 03:59:55 INFO - 'LOGNAME': 'cltbld', 03:59:55 INFO - 'MAIL': '/var/mail/cltbld', 03:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:55 INFO - 'MOZ_NO_REMOTE': '1', 03:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:55 INFO - 'NO_EM_RESTART': '1', 03:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:55 INFO - 'PWD': '/builds/slave/test', 03:59:55 INFO - 'SHELL': '/bin/bash', 03:59:55 INFO - 'SHLVL': '1', 03:59:55 INFO - 'TERM': 'linux', 03:59:55 INFO - 'TMOUT': '86400', 03:59:55 INFO - 'USER': 'cltbld', 03:59:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:55 INFO - '_': '/tools/buildbot/bin/python'} 03:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:59:55 INFO - Cleaning up... 03:59:55 INFO - Return code: 0 03:59:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:55 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:59:55 INFO - Using env: {'DISPLAY': ':0', 03:59:55 INFO - 'HOME': '/home/cltbld', 03:59:55 INFO - 'LANG': 'en_US.UTF-8', 03:59:55 INFO - 'LANGUAGE': 'en_US:en', 03:59:55 INFO - 'LOGNAME': 'cltbld', 03:59:55 INFO - 'MAIL': '/var/mail/cltbld', 03:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:55 INFO - 'MOZ_NO_REMOTE': '1', 03:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:55 INFO - 'NO_EM_RESTART': '1', 03:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:55 INFO - 'PWD': '/builds/slave/test', 03:59:55 INFO - 'SHELL': '/bin/bash', 03:59:55 INFO - 'SHLVL': '1', 03:59:55 INFO - 'TERM': 'linux', 03:59:55 INFO - 'TMOUT': '86400', 03:59:55 INFO - 'USER': 'cltbld', 03:59:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:55 INFO - '_': '/tools/buildbot/bin/python'} 03:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:55 INFO - Downloading/unpacking jsonschema 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:57 INFO - Downloading/unpacking functools32 (from jsonschema) 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:57 INFO - warning: no files found matching '*.txt' 03:59:57 INFO - no previously-included directories found matching 'build' 03:59:57 INFO - no previously-included directories found matching 'dist' 03:59:57 INFO - no previously-included directories found matching '.git*' 03:59:57 INFO - Installing collected packages: jsonschema, functools32 03:59:57 INFO - Running setup.py install for functools32 03:59:57 INFO - warning: no files found matching '*.txt' 03:59:57 INFO - no previously-included directories found matching 'build' 03:59:57 INFO - no previously-included directories found matching 'dist' 03:59:57 INFO - no previously-included directories found matching '.git*' 03:59:57 INFO - Successfully installed jsonschema functools32 03:59:57 INFO - Cleaning up... 03:59:57 INFO - Return code: 0 03:59:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:57 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 0x7fcb1e233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:59:57 INFO - Using env: {'DISPLAY': ':0', 03:59:57 INFO - 'HOME': '/home/cltbld', 03:59:57 INFO - 'LANG': 'en_US.UTF-8', 03:59:57 INFO - 'LANGUAGE': 'en_US:en', 03:59:57 INFO - 'LOGNAME': 'cltbld', 03:59:57 INFO - 'MAIL': '/var/mail/cltbld', 03:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:57 INFO - 'MOZ_NO_REMOTE': '1', 03:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:57 INFO - 'NO_EM_RESTART': '1', 03:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:57 INFO - 'PWD': '/builds/slave/test', 03:59:57 INFO - 'SHELL': '/bin/bash', 03:59:57 INFO - 'SHLVL': '1', 03:59:57 INFO - 'TERM': 'linux', 03:59:57 INFO - 'TMOUT': '86400', 03:59:57 INFO - 'USER': 'cltbld', 03:59:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 03:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:57 INFO - '_': '/tools/buildbot/bin/python'} 03:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:58 INFO - Downloading/unpacking flake8 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:59:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:00:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:00 INFO - no previously-included directories found matching 'docs/_build' 04:00:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:00:00 INFO - Running setup.py install for pep8 04:00:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:00 INFO - no previously-included directories found matching 'docs/_build' 04:00:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:00:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Running post-action listener: _resource_record_post_action 04:00:00 INFO - Running post-action listener: _start_resource_monitoring 04:00:00 INFO - Starting resource monitoring. 04:00:00 INFO - ##### 04:00:00 INFO - ##### Running install step. 04:00:00 INFO - ##### 04:00:00 INFO - Running pre-action listener: _resource_record_pre_action 04:00:00 INFO - Running main action method: install 04:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:01 INFO - Reading from file tmpfile_stdout 04:00:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:01 INFO - Reading from file tmpfile_stdout 04:00:01 INFO - Output received: 04:00:01 INFO - Usage: mozinstall [options] installer 04:00:01 INFO - Options: 04:00:01 INFO - -h, --help show this help message and exit 04:00:01 INFO - -d DEST, --destination=DEST 04:00:01 INFO - Directory to install application into. [default: 04:00:01 INFO - "/builds/slave/test"] 04:00:01 INFO - --app=APP Application being installed. [default: firefox] 04:00:01 INFO - mkdir: /builds/slave/test/build/application 04:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:00:14 INFO - Reading from file tmpfile_stdout 04:00:14 INFO - Output received: 04:00:14 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:14 INFO - Running post-action listener: _resource_record_post_action 04:00:14 INFO - ##### 04:00:14 INFO - ##### Running run-tests step. 04:00:14 INFO - ##### 04:00:14 INFO - Running pre-action listener: _resource_record_pre_action 04:00:14 INFO - Running main action method: run_tests 04:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:14 INFO - Python 2.7.3 04:00:14 INFO - Return code: 0 04:00:14 INFO - grabbing minidump binary from tooltool 04:00:14 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')]} 04:00:14 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 0x26c2410>, '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 0x26c3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:14 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 04:00:14 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 04:00:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:14 INFO - Return code: 0 04:00:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:00:15 INFO - Return code: 0 04:00:15 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/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:00:15 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/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 04:00:15 INFO - Using env: {'DISPLAY': ':0', 04:00:15 INFO - 'HOME': '/home/cltbld', 04:00:15 INFO - 'LANG': 'en_US.UTF-8', 04:00:15 INFO - 'LANGUAGE': 'en_US:en', 04:00:15 INFO - 'LOGNAME': 'cltbld', 04:00:15 INFO - 'MAIL': '/var/mail/cltbld', 04:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:15 INFO - 'MOZ_NO_REMOTE': '1', 04:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:15 INFO - 'NO_EM_RESTART': '1', 04:00:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:15 INFO - 'PWD': '/builds/slave/test', 04:00:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:15 INFO - 'SHELL': '/bin/bash', 04:00:15 INFO - 'SHLVL': '1', 04:00:15 INFO - 'TERM': 'linux', 04:00:15 INFO - 'TMOUT': '86400', 04:00:15 INFO - 'USER': 'cltbld', 04:00:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610', 04:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:15 INFO - '_': '/tools/buildbot/bin/python'} 04:00:15 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/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:00:15 INFO - mozversion application_buildid: 20160703011523 04:00:15 INFO - mozversion application_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 04:00:15 INFO - mozversion application_display_name: Firefox 04:00:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:15 INFO - mozversion application_name: Firefox 04:00:15 INFO - mozversion application_remotingname: firefox 04:00:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:00:15 INFO - mozversion application_vendor: Mozilla 04:00:15 INFO - mozversion application_version: 48.0 04:00:15 INFO - mozversion platform_buildid: 20160703011523 04:00:15 INFO - mozversion platform_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 04:00:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:00:15 INFO - mozversion platform_version: 48.0 04:00:15 INFO - using testdate: 1467543615 04:00:15 INFO - actual date: 1467543615 04:00:15 INFO - starting webserver on 'localhost:36009' 04:00:15 INFO - SUITE-START | Running 2 tests 04:00:15 INFO - TEST-START | dromaeo_css 04:00:15 INFO - operating with platform_type : linux_ 04:00:15 INFO - Initialising browser for dromaeo_css test... 04:00:15 INFO - TEST-INFO | started process 14185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIMEX2/profile http://localhost:36009/getInfo.html) 04:00:19 INFO - PROCESS | 14185 | 04:00:19 INFO - PROCESS | 14185 | (process:14262): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:20 INFO - PROCESS | 14185 | __metrics Screen width/height:1600/1200 04:00:20 INFO - PROCESS | 14185 | colorDepth:24 04:00:20 INFO - PROCESS | 14185 | Browser inner width/height: 1024/697 04:00:20 INFO - PROCESS | 14185 | __metrics 04:00:21 ERROR - PROCESS | 14185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:00:21 INFO - TEST-INFO | 14185: exit 0 04:00:21 INFO - Browser initialized. 04:00:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:21 INFO - TEST-INFO | started process 14312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIMEX2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:23 INFO - PROCESS | 14312 | 04:00:23 INFO - PROCESS | 14312 | (process:14380): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:33 INFO - PROCESS | 14312 | RSS: Main: 150663168 04:00:33 INFO - PROCESS | 14312 | 04:01:23 INFO - PROCESS | 14312 | 1467543683258 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] 04:03:30 INFO - PROCESS | 14312 | Cycle 1(1): loaded http://localhost:36009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36009/tests/dromaeo/cssquery-ext.html) 04:03:31 INFO - PROCESS | 14312 | RSS: Main: 154812416 04:03:31 INFO - PROCESS | 14312 | 04:06:33 INFO - PROCESS | 14312 | Cycle 1(1): loaded http://localhost:36009/tests/dromaeo/cssquery-ext.html (next: http://localhost:36009/tests/dromaeo/cssquery-jquery.html) 04:06:34 INFO - PROCESS | 14312 | RSS: Main: 152518656 04:06:34 INFO - PROCESS | 14312 | 04:09:36 INFO - PROCESS | 14312 | Cycle 1(1): loaded http://localhost:36009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36009/tests/dromaeo/cssquery-mootools.html) 04:09:36 INFO - PROCESS | 14312 | RSS: Main: 152285184 04:09:36 INFO - PROCESS | 14312 | 04:12:38 INFO - PROCESS | 14312 | Cycle 1(1): loaded http://localhost:36009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36009/tests/dromaeo/cssquery-prototype.html) 04:12:38 INFO - PROCESS | 14312 | RSS: Main: 153726976 04:12:38 INFO - PROCESS | 14312 | 04:15:41 INFO - PROCESS | 14312 | Cycle 1(1): loaded http://localhost:36009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36009/tests/dromaeo/cssquery-yui.html) 04:15:41 INFO - PROCESS | 14312 | RSS: Main: 152285184 04:15:41 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | Cycle 1(1): loaded http://localhost:36009/tests/dromaeo/cssquery-yui.html (next: http://localhost:36009/tests/dromaeo/cssquery-dojo.html) 04:18:44 INFO - PROCESS | 14312 | RSS: Main: 156389376 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | __start_tp_report 04:18:44 INFO - PROCESS | 14312 | _x_x_mozilla_page_load 04:18:44 INFO - PROCESS | 14312 | _x_x_mozilla_page_load_details 04:18:44 INFO - PROCESS | 14312 | |i|pagename|runs| 04:18:44 INFO - PROCESS | 14312 | |0;dojo.html;3369.9831500842492;3419.247765491591;3442.1394651337164;3453.1539772755677;3456.7061799747053;5607.57943154263;5627.296587926509;5634.605577609569;5635.492805647496;5636.746346414411;5606.803761868336;5646.01194790911;5652.06740887753;5657.688827114507;5685.630434021786;5079.466656001122;5106.412762532301;5121.206213036967;5157.510036546522;5165.251038599401;5036.471170527097;5119.616028797836;5152.793888244484;5228;5259.86850328741;5194;5197.220416937471;5212.687238765668;5226.529612334908;5250.7374631268285;5171.896562068757;5191.792328306863;5196.610254230929;5211.973940130313;5249.973750131263;4962.3548938638105;5083.135866902636;5115.923261151086;5120.769565369567;5151.665141765773;5424.186372044185;5441;5464.453554644543;5477.287952566141;5514.062609356419;5978.730957106897;6010.75956961721;6018;6030.909536356959;6034.547408944347;6035.034394496904;6043.153958445821;6089.299730531001;6092.72582733778;6127.525510585588;5661.150827375926;5662.207290979225;5669.461401166883;5671.06427439472;5686.5735069869925;6151.2618485781095;6155.446009859134;6160.075988601746;6162.845928851725;6164.6917654117115;5842.328132264759;5862.736176872051;5913.822585322448;5918.674472904032;5950.672713000827;6046.455818976226;6059.454649081604;6067.878642427127;6068.180795592539;6069.666168360694;5989.490893274121;5997.760089596454;6012.759489620454;6019.668918209453;6071.483923866433;5808.82573522795;5974.790882319185;6030.155778191057;6043.244594425697;6069.453749162508;4553.317002449659;4616.676832621684;4626.375439315717;4633.698809577367;4662.743549104832;4079.714419990572;4120.443740095108;4144.129732756095;4144.979275103605;4160.812763425653;5679.375268720438;5699;5791.507721843691;5882.088276317178;5914.053751399755;6112.541559383064;6127.754889804358;6133.662648554372;6145.877082458415;6158.907616385758;5835.44563266489;5846.824595262149;5863.442972917566;5865.472107510344;5881.941180588225;5113.386393632713;5143.537081662668;5158.845234642967;5196.792128314901;5199.792008319625;6381.8085457436355;6388.488920886318;6396.584222025554;6414.390632889868;6426.389492998252;5969.074793407029;6069.726862291296;6098.26820781509;6140.754369825336;6148.1085242640465;6121.693915304128;6249.812505624838;6341.904871427025;6389;6395.360463953567;5937.317208521075;5985.375957675162;5990.281166260077;6003.189569408249;6026.276846778414;5947.940520594739;6063.393660634078;6067.575269731076;6077.787277445268;6091;5884.411558844081;5977;5978.940210597838;6001.099835024606;6027.427394397525;5872.442117998954;5897.3807750185615;5900.763969441175;5918.526517878646;5925.881482370414;5462.9726851365485;5763.452472015152;5816.767329306949;5824.126381042708;5829.038208695687;5869.53043756507;5928.318243402064;5957.16599676037;5963.970180149072;5980.372060933713;5790.594658373873;5792.102224155263;5795.59430839854;5803.071508558779;5813 04:18:44 INFO - PROCESS | 14312 | |1;ext.html;661.9371159739826;667.8096742428409;675.2369822101025;720.585663243635;739.3161325773659;39644;41686.58313416865;41841.58158418415;41974.160516789685;41987.370189447145;44435;44670.77664611681;45029.77485112578;45178;45307.54692453075;8938.95530522348;9109.180173784358;9112.362134650577;9133.315001374891;9143.86284205734;8775.736727898173;8867.866981995276;8879.644814207424;8908.109189081104;8909.287257019456;9096;9147.542622868863;9157.221636160933;9187.954060229722;9213.262938964901;8952.418092823978;9058.365914385995;9074.500902450363;9103.408278461879;9103.544822758902;9159.129882661136;9298;9298.674546390912;9299.070092990714;9331.393459425184;44063.898402539875;44309.33535996963;44594.33108503375;44598.55401445976;44618.776906115265;3954.4068389741483;4483.641308695296;4582.450105987269;4679.017406344672;4698.6241100712205;34139.829300853584;35298;35742.64257357445;36466.81766591177;37098;4656.627469802408;4699.0836786826585;4720.1975664136835;4790.760461976887;4819.156647586658;267692;268697;269220;270381.64809176023;271125;66569.33430665631;66803;67060.6646966762;67102.66448667823;67372;76511;77280;77506.2249377499;77561.61219193981;77797.61101194458;19370.80629193718;19713.704294435596;19715;19750.604987900162;19884.60230795376;15090.773638395432;15189.544313670607;15204.46784362542;15233;15301.311440985182;21447.571048578942;21826.563468730856;21861.234856779938;22509.54980900373;22593.2092376766;8363.623636936352;8624.353173512012;8732.781680457912;8743;8759.386842920934;1123.9887601124049;1134.7673726885969;1139.4075080957855;1176.2178151529138;1249.9187552809037;33261.667383325854;33289.500657490156;33826.83086584601;34253.486197707054;34413;1220.5911019808286;1224.0758227538329;1234.2656119608998;1254.9749005019848;1323.6293837725452;17526.386576469762;17861.374851880122;17863.73204401935;17918.91040544789;18077.548061298574;498759;605589;607948;614915;909698;60643.69678151669;61559;61563.692181538805;61600.69199653973;61727.07409388863;1554.1840533719887;1557.5483109898003;1579.5893067802454;1583.1213676409702;1666.7666526686273;33510;33831;33851.32297354088;34022.31955360928;34900.301993960486;56288.43711562996;57291.42708572861;57347.713261433426;57397;57643;449367;451726;451857;452218;453244;30984.22539436532;32044;32044.359112818078;32074.67925320717;32324.191895202806;50511.24233136432;51282;51632.63982114079;51788;51801;42791.35812962746;43493.56506434895;43635.345469817345;44182;44215.778921105186;42546.78726606471;43178.568214317456;43254;43649.34525982176;44317;43033;43697.56302436935;44519.55480445154;44802.3279650799;44857.327140092275;37526;37560.49758009649;37667;38213;38420.6157938417;29595;29807.254818629706;29829.254268642588;29841.701582983893;30006.54990175193 04:18:44 INFO - PROCESS | 14312 | |2;jquery.html;440.73115399606235;441.8409372625855;444.1760534209044;446.7587502748516;449.2968504290787;19069.52326191846;19196.904015479922;19885.105170267336;20689.58620827586;20700.8964955175;19934.80065199351;20089.698654520194;20351.592968140667;20622;20773.480662983435;5550.333959924815;5825.097109947944;5836.6789826559525;5837.299524057119;5853.092770620539;5652.915206271889;5820.534357251409;5850.531957443415;5876.412358764111;5956.583039187237;5882.235309409771;5935.940640593603;5938.376470470582;5947.256592925884;5989.520838332923;5783.190353350535;5913.113033045035;5934.139549765281;6041.184440100574;6069.02895536712;5879.647221166701;5897.764089436418;5940.257467816523;5944.583879128462;5950.613210141327;14833.332500037417;19972.801631901988;21321.893390532947;24204.39489012771;24822.627660585105;2358.5282943411385;2427.1626288930293;2435.7198922124007;2462.187478132212;3069.2326918270433;10141.18870490359;10349.482525873676;10430.739231519197;10659.253852230348;10803.081738052275;1924.4611508777564;1969.5273134447773;1992.4520756791853;2018.535736780534;2027.3107143571256;72727.27272727258;79390;84437.57781211054;87689;90115.54942225313;11558.94220528892;11747.530098795953;12015.699607509881;12032.338221397908;12074;16870.493885183463;16999.320027198773;17054.062026588657;17102.743458848126;17103.657926841395;9118.452892826319;9146.451212927246;9283.62865485373;9345.15893569582;9445.338826282094;9123.087691230823;9156.084391560791;9224.215941645036;9259.490728010023;9260.259179265642;5063.721495317793;5144.279800827887;5146.382434107931;5190.766415511311;5231.01221535814;2075.9792402076087;2122.2784253353934;2134.3063504361144;2202.8568143070647;2249.5613355395867;1026.2764750850633;1076.2466273608504;1098.7308109513222;1107.2636696596674;1167;17935.461936141935;19047.809521904604;19230.326938557082;19839.504012399804;19952.800471995095;1068.273573969708;1106.618216715232;1117.5306371324064;1176.611718133014;1184.135581025856;11079.28271117978;11223.831642525369;11288.2662626929;11329.943350283196;11338.60314888975;318921;526908;569609;666604;666931;94947.52526237463;103054.48472757588;107367.46316268525;107779;112042.43978780054;511.7134404733361;525.6583220906365;531.4366771222517;532.1485623003164;543.3696911582624;10848.566057357617;11097.500612472619;11438.370889601152;11585.884141158818;11666.88333116658;41385.172296554505;41502;41687.374689379074;42199.367009494264;42854;62674.37325626868;64390;64468.355316446236;64986.67506662436;65102.34897650963;9227.21568666644;9354.953225234103;9355.111264429868;9360.485173315534;9511.667091652036;11985.760284794429;14050.297485125908;14304.213268270345;14340.784888226477;14407.567772966828;12259.632211033684;12453.1905426147;12585.748285034066;12656.6835829105;12715.300658463873;11910.344931028876;11923.0461563073;12109.636710898687;12256.264624122581;12295.56965506203;12444.688882778002;12495;12897.29064901402;12949.935250323688;13014.869851301366;8971.372003959921;9058.954705226432;9087.863682044643;9114.40756350835;9441.716748497556;9330.160285574331;12088.879111209128;12656.6835829105;12777.48890044425;12851.100422970303 04:18:44 INFO - PROCESS | 14312 | |3;mootools.html;1584.9920750396245;1588.9920550397246;1812.10300901054;1905.409323109837;1916.26931622438;7534.359579435754;8165.3875959302995;8366.37252206084;8592.828143437135;8599.570021498923;8278.130796266396;8281.91718082819;8367.163283671629;8486.95756521218;8538.487690738544;2394.784469397758;2415.758424157588;2425.126954296452;2426.1023421334044;2431.63525471179;2460.1020627470934;2521.773040426361;2524.0156339027703;2525.02786427225;2525.684289463817;2476.3313905245573;2478.6405971134177;2511.7613826686434;2512.371907023244;2513.7988960883085;2439.121916110199;2441.3896525868445;2452.8405653632544;2460.5324988252173;2482.5283196192845;2502.6621406110307;2526.166365099531;2530.4559519703166;2539.390546268901;2540.618907163922;8500.74497765068;8502.872456913152;8503.1921967413;8507.702230421968;8515.403921725481;5364.8122315718765;5420.864478388033;5453.618246722731;5484.287042684466;5494.917576236359;3412.6282233847487;3429.3827111120236;3457.3776720190353;3561.305545418644;3566.857325706969;1127.0983213429306;1151.113642495274;1158.7276989907366;1184.798584240681;1193.498730533178;11984.221025633306;12042.458089386086;12047.81928271068;12080.697982550419;12089.21420107699;4556.749378784199;4601.309803529431;4641.094986477605;4645.326427667969;4651.441826980784;9645.855312170323;9717.757056073655;9721.562529686182;9726.221902247804;9731.854022189673;5329.387120481194;5355.062863998784;5373.301470808769;5390.191471279261;5411.891762164734;4877.951220487821;5004.574611158092;5023.572996295283;5049.949500505021;5055.51972562606;3937.7637341759014;3970;4023.657989070903;4062.756234625873;4104.0970986383545;1215.4166000319897;1222.7921253386946;1229.883161099694;1249.4752204074312;1257.867923867999;972.8589354543693;1007.8639383683255;1061.5647584490475;1065.4033741105006;1081.4646749858714;6072.180255665517;6076.574639775174;6092.116643086728;6154.261488621304;6182.938170618326;500.5670095367481;501.9347484826949;505.99747001264757;510.07421529923073;513.2967834067351;4242.851500197478;4295.4415925929425;4316.460442444694;4322.438083049184;4404.691671583022;10280.742981425525;10594.470276486145;10725.30285531438;10762.139028877671;10811.6215932442;10197.541110650038;10576.629817956335;10609.84085238722;10626.521806518725;10669.679909602724;7924.088729796147;7948.443608947318;7958;7972.60136993148;8032.598370081472;5975.193348897843;5997.370276120944;5999.790007349722;6079.392060793885;6103.938960610337;9468.573914173741;9542.37974531681;9571.425714457155;9716.465594392093;9719.27105467107;9410.670626528039;9631.518424078908;9693.642889995264;9895.851562226428;9988.700338989842;7130.7147714092935;7240.601766902871;7252.238514955854;7345.926540734525;7462.440316976357;7669.6548655309525;7673.769786906401;7700;7740.187280335709;7749.070111586646;6880.827979300558;6907.965460172667;7030.753923612853;7081.681324340314;7250.166230883305;6866.485013623898;7127.2516385778745;7264.927350726425;7334.449916256195;7345.853082938418;6170.352113028068;6340;6346.428821406095;6355.396237357444;6388.840278992877;5044.445111037856;5086.059079070384;5103.387593488656;5104.872378190426;5118.232265160255;4901.313816065683;5149.48505149482;5163.432022477449;5178.171492561172;5183.896322073462 04:18:44 INFO - PROCESS | 14312 | |4;prototype.html;360.49710653638175;368.77320447924535;371.120444546425;372.0382810435026;374.25523208814457;6456.7094480748365;6519.315471875456;6539.378759017892;6608.438282745967;6726.125603671522;6560.967195164029;6585.473162147029;6612.933870661304;6645.700943457544;6675.799726008216;4999.925001124986;5009.924851127236;5029.874253143673;5030.6730062546;5044.445111037783;5024.095662780698;5026.547610715035;5039.6976181429045;5050.84847454577;5051.040302342543;4989.376327959005;4989.925151122736;5000.049990501811;5003.774830132653;5011.924821127686;4815;4964.230544265644;4989.176785830316;4991.026749783794;4997.875053123683;4312.805923733439;4313.525512193656;4327.913441731179;4332.631726303268;4338.848140315074;6242.87514249717;6242.96878515609;6249.437550620421;6250.249970003629;6260.342664020303;5674.829755107354;5842.620229685057;5846.41535846412;5854.590178687494;5858.941410585882;6946.895796563055;6965.442764578822;6965.965170174168;6976.930230697679;6977.6511174441075;4819.662623616348;4830.420349558076;4833.299171620095;4840.782164802592;4841.636877234221;7256.1655409628565;7271.963640181818;7333.266673332678;7356.411487081021;7357.117145942468;4610.469795973506;4935.728534930541;4942.135126352874;4946.505349465025;4958.528939750718;4762.738049407316;4786.760661966888;4803.855884323476;4811;4820.084184005098;5654.349749778746;5668.234788303526;5670;5676.971615141898;5690.032694441955;6957.652117394211;6997.335253150943;7017.333353331425;7025.613591252428;7032.683529241094;1735;1738.8695847811464;1743.7994630617388;1753.281154726556;1757.9384721534684;1108.4513165982728;1121.243160866412;1139.1114930354338;1157.346099453806;1178.2459226095307;6679.632620205838;6700.530962832652;6793.694283757242;6802.3537763912345;6834;7211.783646490614;7250.927490725131;7285.927140728525;7288.854222915618;7292.088488938883;6728.697208625624;6756.729730810811;6762.966185169043;6765.391114799593;6768.932310676929;3832.9233415331537;3901.4342920276968;3906.8670085675403;3915.353966595537;3915.569287378386;7442.404607631376;7615.276548727862;7777.144514103444;7780.572068536285;7783.571903545359;7488.550686958691;7518.323350898446;7519.172890981988;7534.886976695354;7534.927894828966;7756.3019328260725;7761.068671759312;7768.495047821986;7772.106207786064;7779.260970207822;7175.820604484929;7326.890096648661;7327.303906128909;7352.301531354513;7373.483856130019;7210.711571537289;7224.060872086595;7241.5293005954445;7246.311600397954;7253.347198752138;7630.7329243476215;7653.961730191313;7658.617069146632;7674.6930122794465;7729.961350193438;4915.3855768029;4966.652334336562;4966.701997880139;4967.205247160437;4987.326710893983;7134.2152363238965;7284.417246620152;7285.380742636935;7307.67115479794;7336.266373362834;7075.787726368011;7090.929090709234;7096.254893236136;7106.010317111217;7112.928870711226;7036.2260151384335;7053.823654408681;7065.399441047569;7076.25699301566;7082.902150166732;6833.3166683331265;6933.618650974043;6939.687714052779;6949.131358580177;6978.546394484342;6994.475414343843;7129.073220481304;7146.071010768775;7150.392216661642;7165.964170179116;6758.662066896733;6966.12923384577;6970.23327433992;6973.476989225727;6976.7558135465015 04:18:44 INFO - PROCESS | 14312 | |5;yui.html;849.4563479373201;934.7195841247624;941.0542404883091;955.8231727130477;956.9808603827923;15126.848731512682;15498.767518487217;15501.534953951372;17114.05872677002;17747.37884174054;16141.273642686077;16203.351865925379;16227.756583651226;16235.91882040591;16257.674846503063;918.728974952389;927.3091546797611;931.4039015030386;935.3546053223288;937.2501998401286;925.9166674999249;943.1841457139559;946.1531928923644;946.4274114160937;947.6777895515523;966.3718582921088;973.5910917414703;974.3471873844505;974.6491263145263;975.6633961283381;961.2310151878504;965.0446058402131;966.294604938399;968.7093871838456;969.0745338202036;712.9108861392326;714.6176795414428;714.9428045756379;715.2632788228134;716.5449939288537;15861;15899.60250993723;15912.52262432129;15913.363465461367;15950.122743249116;14786.482473113389;14817.333220005126;14927.626809329853;14947.626309342244;15000.474983375529;11241.213115081948;11322.20744547882;11673.474693638807;11786.941065294619;12151.574694885636;4040.333344998072;4041.6160464755803;4105.4252404663375;4158.6673066154635;4226.154769046172;56689.71655141739;57893.42106578965;57998.130028049614;59536.70231648814;60733;11678.6496405108;11758.412079396167;12033.63899083029;12224.816627750592;12262.570810021607;20609.690854637192;20659.380218593466;20703.550751447554;20757.27349542789;20757.896210519153;9086.727398178065;9121.90878091224;9132.452052876848;9234.769130771785;9572.090651388107;4909.263610458388;4982.451930287665;4990.051890140861;5008.899822003539;5075.5178258065425;3343.398188326076;3381.932361352759;3390.3727810355163;3392.270661807674;3399.099238701746;657.3590749019763;664.4617859533793;667.8196886840526;673.0039541478541;681.2438193605094;798.7444017914212;799.8800179972934;825.9881644984846;845.644829171737;856.9700060497853;9557.63289391345;10058.54736536843;10316.27786054969;10376.481175941173;10469.581216751245;662.3806740697463;831.8876951611455;838.5974732128612;846.420202161509;856.3534531428731;4383.517813040563;4406.471223453206;4424.668149888771;4560.885977850514;4592.7933243004145;63093.05360419597;63463;63720.681396593645;63859;64146;55946.720266398406;57940.130898036565;58164.70917645385;58263;58508.70745646244;51012.23481647778;51859.74070129701;52303;53017.469825302025;54290;8868.290536757173;8931.910680893108;9075.727728167902;9564.713058608253;9668.564914579001;39675.80162099171;40235;40336.79831600823;40611.18777624372;40711.1857762849;45235.321470178635;47002.76498617485;51855.481445186575;52079;52150.73924630504;11194;11528.769424611628;11718.824217636571;11724.531018759495;12171.634850954486;12999.220046797222;13136;13174.802377964146;13210.471581136648;13267.2703001332;12005.099617528545;12169.391530423267;12222.572209972608;12222.87777122253;12703.87296127064;12062.939685301517;12294.569690060805;12523.37383130858;12784.488620455078;12790.552330668383;11935.104867134825;12593;12604.243745375306;12662.176958498037;12665.366731663564;10326.432046237529;10508.474576271003;10595.152387808803;10713.732156696145;10715.839262410915;10076.69769906904;10776.838347424951;10909.236353455182;10910.836337455103;10915.345079295268 04:18:44 INFO - PROCESS | 14312 | __end_tp_report 04:18:44 INFO - PROCESS | 14312 | __start_cc_report 04:18:44 INFO - PROCESS | 14312 | _x_x_mozilla_cycle_collect,336 04:18:44 INFO - PROCESS | 14312 | __end_cc_report 04:18:44 INFO - PROCESS | 14312 | __startTimestamp1467544724265__endTimestamp 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | ------- Summary: start ------- 04:18:44 INFO - PROCESS | 14312 | Number of tests: 6 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | [#0] dojo.html Cycles:165 Average:5628.05 Median:5862.74 stddev:628.53 (10.7%) stddev-sans-first:604.98 04:18:44 INFO - PROCESS | 14312 | Values: 3370.0 3419.2 3442.1 3453.2 3456.7 5607.6 5627.3 5634.6 5635.5 5636.7 5606.8 5646.0 5652.1 5657.7 5685.6 5079.5 5106.4 5121.2 5157.5 5165.3 5036.5 5119.6 5152.8 5228.0 5259.9 5194.0 5197.2 5212.7 5226.5 5250.7 5171.9 5191.8 5196.6 5212.0 5250.0 4962.4 5083.1 5115.9 5120.8 5151.7 5424.2 5441.0 5464.5 5477.3 5514.1 5978.7 6010.8 6018.0 6030.9 6034.5 6035.0 6043.2 6089.3 6092.7 6127.5 5661.2 5662.2 5669.5 5671.1 5686.6 6151.3 6155.4 6160.1 6162.8 6164.7 5842.3 5862.7 5913.8 5918.7 5950.7 6046.5 6059.5 6067.9 6068.2 6069.7 5989.5 5997.8 6012.8 6019.7 6071.5 5808.8 5974.8 6030.2 6043.2 6069.5 4553.3 4616.7 4626.4 4633.7 4662.7 4079.7 4120.4 4144.1 4145.0 4160.8 5679.4 5699.0 5791.5 5882.1 5914.1 6112.5 6127.8 6133.7 6145.9 6158.9 5835.4 5846.8 5863.4 5865.5 5881.9 5113.4 5143.5 5158.8 5196.8 5199.8 6381.8 6388.5 6396.6 6414.4 6426.4 5969.1 6069.7 6098.3 6140.8 6148.1 6121.7 6249.8 6341.9 6389.0 6395.4 5937.3 5985.4 5990.3 6003.2 6026.3 5947.9 6063.4 6067.6 6077.8 6091.0 5884.4 5977.0 5978.9 6001.1 6027.4 5872.4 5897.4 5900.8 5918.5 5925.9 5463.0 5763.5 5816.8 5824.1 5829.0 5869.5 5928.3 5957.2 5964.0 5980.4 5790.6 5792.1 5795.6 5803.1 5813.0 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | [#1] ext.html Cycles:180 Average:63633.49 Median:44477.28 stddev:130478.07 (293.4%) stddev-sans-first:130758.44 04:18:44 INFO - PROCESS | 14312 | Values: 661.9 667.8 675.2 720.6 739.3 39644.0 41686.6 41841.6 41974.2 41987.4 44435.0 44670.8 45029.8 45178.0 45307.5 8939.0 9109.2 9112.4 9133.3 9143.9 8775.7 8867.9 8879.6 8908.1 8909.3 9096.0 9147.5 9157.2 9188.0 9213.3 8952.4 9058.4 9074.5 9103.4 9103.5 9159.1 9298.0 9298.7 9299.1 9331.4 44063.9 44309.3 44594.3 44598.6 44618.8 3954.4 4483.6 4582.5 4679.0 4698.6 34139.8 35298.0 35742.6 36466.8 37098.0 4656.6 4699.1 4720.2 4790.8 4819.2 267692.0 268697.0 269220.0 270381.6 271125.0 66569.3 66803.0 67060.7 67102.7 67372.0 76511.0 77280.0 77506.2 77561.6 77797.6 19370.8 19713.7 19715.0 19750.6 19884.6 15090.8 15189.5 15204.5 15233.0 15301.3 21447.6 21826.6 21861.2 22509.5 22593.2 8363.6 8624.4 8732.8 8743.0 8759.4 1124.0 1134.8 1139.4 1176.2 1249.9 33261.7 33289.5 33826.8 34253.5 34413.0 1220.6 1224.1 1234.3 1255.0 1323.6 17526.4 17861.4 17863.7 17918.9 18077.5 498759.0 605589.0 607948.0 614915.0 909698.0 60643.7 61559.0 61563.7 61600.7 61727.1 1554.2 1557.5 1579.6 1583.1 1666.8 33510.0 33831.0 33851.3 34022.3 34900.3 56288.4 57291.4 57347.7 57397.0 57643.0 449367.0 451726.0 451857.0 452218.0 453244.0 30984.2 32044.0 32044.4 32074.7 32324.2 50511.2 51282.0 51632.6 51788.0 51801.0 42791.4 43493.6 43635.3 44182.0 44215.8 42546.8 43178.6 43254.0 43649.3 44317.0 43033.0 43697.6 44519.6 44802.3 44857.3 37526.0 37560.5 37667.0 38213.0 38420.6 29595.0 29807.3 29829.3 29841.7 30006.5 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | [#2] jquery.html Cycles:180 Average:31416.90 Median:2304.04 stddev:93163.13 (4043.5%) stddev-sans-first:93395.44 04:18:44 INFO - PROCESS | 14312 | Values: 440.7 441.8 444.2 446.8 449.3 19069.5 19196.9 19885.1 20689.6 20700.9 19934.8 20089.7 20351.6 20622.0 20773.5 5550.3 5825.1 5836.7 5837.3 5853.1 5652.9 5820.5 5850.5 5876.4 5956.6 5882.2 5935.9 5938.4 5947.3 5989.5 5783.2 5913.1 5934.1 6041.2 6069.0 5879.6 5897.8 5940.3 5944.6 5950.6 14833.3 19972.8 21321.9 24204.4 24822.6 2358.5 2427.2 2435.7 2462.2 3069.2 10141.2 10349.5 10430.7 10659.3 10803.1 1924.5 1969.5 1992.5 2018.5 2027.3 72727.3 79390.0 84437.6 87689.0 90115.5 11558.9 11747.5 12015.7 12032.3 12074.0 16870.5 16999.3 17054.1 17102.7 17103.7 9118.5 9146.5 9283.6 9345.2 9445.3 9123.1 9156.1 9224.2 9259.5 9260.3 5063.7 5144.3 5146.4 5190.8 5231.0 2076.0 2122.3 2134.3 2202.9 2249.6 1026.3 1076.2 1098.7 1107.3 1167.0 17935.5 19047.8 19230.3 19839.5 19952.8 1068.3 1106.6 1117.5 1176.6 1184.1 11079.3 11223.8 11288.3 11329.9 11338.6 318921.0 526908.0 569609.0 666604.0 666931.0 94947.5 103054.5 107367.5 107779.0 112042.4 511.7 525.7 531.4 532.1 543.4 10848.6 11097.5 11438.4 11585.9 11666.9 41385.2 41502.0 41687.4 42199.4 42854.0 62674.4 64390.0 64468.4 64986.7 65102.3 9227.2 9355.0 9355.1 9360.5 9511.7 11985.8 14050.3 14304.2 14340.8 14407.6 12259.6 12453.2 12585.7 12656.7 12715.3 11910.3 11923.0 12109.6 12256.3 12295.6 12444.7 12495.0 12897.3 12949.9 13014.9 8971.4 9059.0 9087.9 9114.4 9441.7 9330.2 12088.9 12656.7 12777.5 12851.1 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | [#3] mootools.html Cycles:180 Average:5656.40 Median:2806.73 stddev:3093.30 (110.2%) stddev-sans-first:3086.84 04:18:44 INFO - PROCESS | 14312 | Values: 1585.0 1589.0 1812.1 1905.4 1916.3 7534.4 8165.4 8366.4 8592.8 8599.6 8278.1 8281.9 8367.2 8487.0 8538.5 2394.8 2415.8 2425.1 2426.1 2431.6 2460.1 2521.8 2524.0 2525.0 2525.7 2476.3 2478.6 2511.8 2512.4 2513.8 2439.1 2441.4 2452.8 2460.5 2482.5 2502.7 2526.2 2530.5 2539.4 2540.6 8500.7 8502.9 8503.2 8507.7 8515.4 5364.8 5420.9 5453.6 5484.3 5494.9 3412.6 3429.4 3457.4 3561.3 3566.9 1127.1 1151.1 1158.7 1184.8 1193.5 11984.2 12042.5 12047.8 12080.7 12089.2 4556.7 4601.3 4641.1 4645.3 4651.4 9645.9 9717.8 9721.6 9726.2 9731.9 5329.4 5355.1 5373.3 5390.2 5411.9 4878.0 5004.6 5023.6 5049.9 5055.5 3937.8 3970.0 4023.7 4062.8 4104.1 1215.4 1222.8 1229.9 1249.5 1257.9 972.9 1007.9 1061.6 1065.4 1081.5 6072.2 6076.6 6092.1 6154.3 6182.9 500.6 501.9 506.0 510.1 513.3 4242.9 4295.4 4316.5 4322.4 4404.7 10280.7 10594.5 10725.3 10762.1 10811.6 10197.5 10576.6 10609.8 10626.5 10669.7 7924.1 7948.4 7958.0 7972.6 8032.6 5975.2 5997.4 5999.8 6079.4 6103.9 9468.6 9542.4 9571.4 9716.5 9719.3 9410.7 9631.5 9693.6 9895.9 9988.7 7130.7 7240.6 7252.2 7345.9 7462.4 7669.7 7673.8 7700.0 7740.2 7749.1 6880.8 6908.0 7030.8 7081.7 7250.2 6866.5 7127.3 7264.9 7334.4 7345.9 6170.4 6340.0 6346.4 6355.4 6388.8 5044.4 5086.1 5103.4 5104.9 5118.2 4901.3 5149.5 5163.4 5178.2 5183.9 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | [#4] prototype.html Cycles:180 Average:5876.00 Median:6713.33 stddev:1814.42 (27.0%) stddev-sans-first:1771.66 04:18:44 INFO - PROCESS | 14312 | Values: 360.5 368.8 371.1 372.0 374.3 6456.7 6519.3 6539.4 6608.4 6726.1 6561.0 6585.5 6612.9 6645.7 6675.8 4999.9 5009.9 5029.9 5030.7 5044.4 5024.1 5026.5 5039.7 5050.8 5051.0 4989.4 4989.9 5000.0 5003.8 5011.9 4815.0 4964.2 4989.2 4991.0 4997.9 4312.8 4313.5 4327.9 4332.6 4338.8 6242.9 6243.0 6249.4 6250.2 6260.3 5674.8 5842.6 5846.4 5854.6 5858.9 6946.9 6965.4 6966.0 6976.9 6977.7 4819.7 4830.4 4833.3 4840.8 4841.6 7256.2 7272.0 7333.3 7356.4 7357.1 4610.5 4935.7 4942.1 4946.5 4958.5 4762.7 4786.8 4803.9 4811.0 4820.1 5654.3 5668.2 5670.0 5677.0 5690.0 6957.7 6997.3 7017.3 7025.6 7032.7 1735.0 1738.9 1743.8 1753.3 1757.9 1108.5 1121.2 1139.1 1157.3 1178.2 6679.6 6700.5 6793.7 6802.4 6834.0 7211.8 7250.9 7285.9 7288.9 7292.1 6728.7 6756.7 6763.0 6765.4 6768.9 3832.9 3901.4 3906.9 3915.4 3915.6 7442.4 7615.3 7777.1 7780.6 7783.6 7488.6 7518.3 7519.2 7534.9 7534.9 7756.3 7761.1 7768.5 7772.1 7779.3 7175.8 7326.9 7327.3 7352.3 7373.5 7210.7 7224.1 7241.5 7246.3 7253.3 7630.7 7654.0 7658.6 7674.7 7730.0 4915.4 4966.7 4966.7 4967.2 4987.3 7134.2 7284.4 7285.4 7307.7 7336.3 7075.8 7090.9 7096.3 7106.0 7112.9 7036.2 7053.8 7065.4 7076.3 7082.9 6833.3 6933.6 6939.7 6949.1 6978.5 6994.5 7129.1 7146.1 7150.4 7166.0 6758.7 6966.1 6970.2 6973.5 6976.8 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - PROCESS | 14312 | [#5] yui.html Cycles:180 Average:15741.45 Median:4415.57 stddev:18171.33 (411.5%) stddev-sans-first:18187.89 04:18:44 INFO - PROCESS | 14312 | Values: 849.5 934.7 941.1 955.8 957.0 15126.8 15498.8 15501.5 17114.1 17747.4 16141.3 16203.4 16227.8 16235.9 16257.7 918.7 927.3 931.4 935.4 937.3 925.9 943.2 946.2 946.4 947.7 966.4 973.6 974.3 974.6 975.7 961.2 965.0 966.3 968.7 969.1 712.9 714.6 714.9 715.3 716.5 15861.0 15899.6 15912.5 15913.4 15950.1 14786.5 14817.3 14927.6 14947.6 15000.5 11241.2 11322.2 11673.5 11786.9 12151.6 4040.3 4041.6 4105.4 4158.7 4226.2 56689.7 57893.4 57998.1 59536.7 60733.0 11678.6 11758.4 12033.6 12224.8 12262.6 20609.7 20659.4 20703.6 20757.3 20757.9 9086.7 9121.9 9132.5 9234.8 9572.1 4909.3 4982.5 4990.1 5008.9 5075.5 3343.4 3381.9 3390.4 3392.3 3399.1 657.4 664.5 667.8 673.0 681.2 798.7 799.9 826.0 845.6 857.0 9557.6 10058.5 10316.3 10376.5 10469.6 662.4 831.9 838.6 846.4 856.4 4383.5 4406.5 4424.7 4560.9 4592.8 63093.1 63463.0 63720.7 63859.0 64146.0 55946.7 57940.1 58164.7 58263.0 58508.7 51012.2 51859.7 52303.0 53017.5 54290.0 8868.3 8931.9 9075.7 9564.7 9668.6 39675.8 40235.0 40336.8 40611.2 40711.2 45235.3 47002.8 51855.5 52079.0 52150.7 11194.0 11528.8 11718.8 11724.5 12171.6 12999.2 13136.0 13174.8 13210.5 13267.3 12005.1 12169.4 12222.6 12222.9 12703.9 12062.9 12294.6 12523.4 12784.5 12790.6 11935.1 12593.0 12604.2 12662.2 12665.4 10326.4 10508.5 10595.2 10713.7 10715.8 10076.7 10776.8 10909.2 10910.8 10915.3 04:18:44 INFO - PROCESS | 14312 | -------- Summary: end -------- 04:18:44 INFO - PROCESS | 14312 | 04:18:44 INFO - TEST-INFO | 14312: exit 0 04:18:44 INFO - TEST-OK | dromaeo_css | took 1109323ms 04:18:44 INFO - TEST-START | kraken 04:18:44 INFO - operating with platform_type : linux_ 04:18:44 INFO - Initialising browser for kraken test... 04:18:44 INFO - TEST-INFO | started process 14554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pIqJd/profile http://localhost:36009/getInfo.html) 04:18:48 INFO - PROCESS | 14554 | 04:18:48 INFO - PROCESS | 14554 | (process:14633): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:18:49 INFO - PROCESS | 14554 | __metrics Screen width/height:1600/1200 04:18:49 INFO - PROCESS | 14554 | colorDepth:24 04:18:49 INFO - PROCESS | 14554 | Browser inner width/height: 1024/697 04:18:49 INFO - PROCESS | 14554 | __metrics 04:18:50 ERROR - PROCESS | 14554 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:18:50 INFO - TEST-INFO | 14554: exit 0 04:18:50 INFO - Browser initialized. 04:18:50 INFO - Running cycle 1/1 for kraken test... 04:18:50 INFO - TEST-INFO | started process 14683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pIqJd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:52 INFO - PROCESS | 14683 | 04:18:52 INFO - PROCESS | 14683 | (process:14749): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:02 INFO - PROCESS | 14683 | RSS: Main: 150892544 04:19:02 INFO - PROCESS | 14683 | 04:19:05 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36009/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:05 INFO - PROCESS | 14683 | RSS: Main: 156057600 04:19:05 INFO - PROCESS | 14683 | 04:19:08 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36009/tests/kraken/driver.html?testName=audio-dft) 04:19:09 INFO - PROCESS | 14683 | RSS: Main: 156479488 04:19:09 INFO - PROCESS | 14683 | 04:19:12 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36009/tests/kraken/driver.html?testName=audio-fft) 04:19:12 INFO - PROCESS | 14683 | RSS: Main: 156807168 04:19:12 INFO - PROCESS | 14683 | 04:19:14 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36009/tests/kraken/driver.html?testName=audio-oscillator) 04:19:15 INFO - PROCESS | 14683 | RSS: Main: 156782592 04:19:15 INFO - PROCESS | 14683 | 04:19:17 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:18 INFO - PROCESS | 14683 | RSS: Main: 156684288 04:19:18 INFO - PROCESS | 14683 | 04:19:21 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36009/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:21 INFO - PROCESS | 14683 | RSS: Main: 157159424 04:19:21 INFO - PROCESS | 14683 | 04:19:25 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36009/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:25 INFO - PROCESS | 14683 | RSS: Main: 156655616 04:19:25 INFO - PROCESS | 14683 | 04:19:28 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36009/tests/kraken/driver.html?testName=json-parse-financial) 04:19:29 INFO - PROCESS | 14683 | RSS: Main: 156430336 04:19:29 INFO - PROCESS | 14683 | 04:19:30 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:31 INFO - PROCESS | 14683 | RSS: Main: 156250112 04:19:31 INFO - PROCESS | 14683 | 04:19:32 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:33 INFO - PROCESS | 14683 | RSS: Main: 156774400 04:19:33 INFO - PROCESS | 14683 | 04:19:35 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:36 INFO - PROCESS | 14683 | RSS: Main: 156516352 04:19:36 INFO - PROCESS | 14683 | 04:19:38 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:39 INFO - PROCESS | 14683 | RSS: Main: 157024256 04:19:39 INFO - PROCESS | 14683 | 04:19:42 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:42 INFO - PROCESS | 14683 | RSS: Main: 156835840 04:19:42 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | Cycle 1(1): loaded http://localhost:36009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36009/tests/kraken/driver.html?testName=ai-astar) 04:19:44 INFO - PROCESS | 14683 | RSS: Main: 158670848 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | __start_tp_report 04:19:44 INFO - PROCESS | 14683 | _x_x_mozilla_page_load 04:19:44 INFO - PROCESS | 14683 | _x_x_mozilla_page_load_details 04:19:44 INFO - PROCESS | 14683 | |i|pagename|runs| 04:19:44 INFO - PROCESS | 14683 | |0;ai-astar;110;112;106;111;111;111;103;111;112;110 04:19:44 INFO - PROCESS | 14683 | |1;audio-beat-detection;161;126;157;174;134;154;160;128;183;126 04:19:44 INFO - PROCESS | 14683 | |2;audio-dft;163;163;161;164;165;162;162;163;162;165 04:19:44 INFO - PROCESS | 14683 | |3;audio-fft;76;76;77;175;76;73;72;76;176;76 04:19:44 INFO - PROCESS | 14683 | |4;audio-oscillator;91;92;164;91;93;92;142;93;92;161 04:19:44 INFO - PROCESS | 14683 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;121;117;119 04:19:44 INFO - PROCESS | 14683 | |6;imaging-darkroom;148;146;147;146;146;146;147;147;146;147 04:19:44 INFO - PROCESS | 14683 | |7;imaging-desaturate;95;96;97;95;95;95;95;95;95;95 04:19:44 INFO - PROCESS | 14683 | |8;json-parse-financial;58;56;57;57;62;68;58;77;55;58 04:19:44 INFO - PROCESS | 14683 | |9;json-stringify-tinderbox;59;60;60;59;60;59;60;60;60;59 04:19:44 INFO - PROCESS | 14683 | |10;stanford-crypto-aes;81;72;73;81;73;77;74;74;73;73 04:19:44 INFO - PROCESS | 14683 | |11;stanford-crypto-ccm;115;127;127;115;125;122;114;115;135;131 04:19:44 INFO - PROCESS | 14683 | |12;stanford-crypto-pbkdf2;162;163;159;160;170;162;160;164;161;158 04:19:44 INFO - PROCESS | 14683 | |13;stanford-crypto-sha256-iterative;67;67;68;66;70;68;67;65;69;73 04:19:44 INFO - PROCESS | 14683 | __end_tp_report 04:19:44 INFO - PROCESS | 14683 | __start_cc_report 04:19:44 INFO - PROCESS | 14683 | _x_x_mozilla_cycle_collect,839 04:19:44 INFO - PROCESS | 14683 | __end_cc_report 04:19:44 INFO - PROCESS | 14683 | __startTimestamp1467544784593__endTimestamp 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | ------- Summary: start ------- 04:19:44 INFO - PROCESS | 14683 | Number of tests: 14 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.91 (2.6%) stddev-sans-first:3.08 04:19:44 INFO - PROCESS | 14683 | Values: 110.0 112.0 106.0 111.0 111.0 111.0 103.0 111.0 112.0 110.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.50 stddev:20.66 (13.0%) stddev-sans-first:21.55 04:19:44 INFO - PROCESS | 14683 | Values: 161.0 126.0 157.0 174.0 134.0 154.0 160.0 128.0 183.0 126.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 04:19:44 INFO - PROCESS | 14683 | Values: 163.0 163.0 161.0 164.0 165.0 162.0 162.0 163.0 162.0 165.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:42.30 (55.7%) stddev-sans-first:44.28 04:19:44 INFO - PROCESS | 14683 | Values: 76.0 76.0 77.0 175.0 76.0 73.0 72.0 76.0 176.0 76.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:92.00 stddev:31.27 (34.0%) stddev-sans-first:32.31 04:19:44 INFO - PROCESS | 14683 | Values: 91.0 92.0 164.0 91.0 93.0 92.0 142.0 93.0 92.0 161.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.34 (1.1%) stddev-sans-first:1.39 04:19:44 INFO - PROCESS | 14683 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 121.0 117.0 119.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 04:19:44 INFO - PROCESS | 14683 | Values: 148.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:19:44 INFO - PROCESS | 14683 | Values: 95.0 96.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:58.00 stddev:6.87 (11.8%) stddev-sans-first:7.22 04:19:44 INFO - PROCESS | 14683 | Values: 58.0 56.0 57.0 57.0 62.0 68.0 58.0 77.0 55.0 58.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 04:19:44 INFO - PROCESS | 14683 | Values: 59.0 60.0 60.0 59.0 60.0 59.0 60.0 60.0 60.0 59.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.00 stddev:3.38 (4.6%) stddev-sans-first:2.83 04:19:44 INFO - PROCESS | 14683 | Values: 81.0 72.0 73.0 81.0 73.0 77.0 74.0 74.0 73.0 73.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:126.00 stddev:7.57 (6.0%) stddev-sans-first:7.52 04:19:44 INFO - PROCESS | 14683 | Values: 115.0 127.0 127.0 115.0 125.0 122.0 114.0 115.0 135.0 131.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:3.38 (2.1%) stddev-sans-first:3.59 04:19:44 INFO - PROCESS | 14683 | Values: 162.0 163.0 159.0 160.0 170.0 162.0 160.0 164.0 161.0 158.0 04:19:44 INFO - PROCESS | 14683 | 04:19:44 INFO - PROCESS | 14683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.26 (3.3%) stddev-sans-first:2.37 04:19:44 INFO - PROCESS | 14683 | Values: 67.0 67.0 68.0 66.0 70.0 68.0 67.0 65.0 69.0 73.0 04:19:44 INFO - PROCESS | 14683 | -------- Summary: end -------- 04:19:44 INFO - PROCESS | 14683 | 04:19:45 INFO - TEST-INFO | 14683: exit 0 04:19:45 INFO - TEST-OK | kraken | took 60499ms 04:19:45 INFO - SUITE-END | took 1169s 04:19:45 INFO - Completed test suite (00:19:30) 04:19:45 INFO - javascript benchmark 04:19:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3369.9831500842492, 3419.247765491591, 3442.1394651337164, 3453.1539772755677, 3456.7061799747053, 5607.57943154263, 5627.296587926509, 5634.605577609569, 5635.492805647496, 5636.746346414411, 5606.803761868336, 5646.01194790911, 5652.06740887753, 5657.688827114507, 5685.630434021786, 5079.466656001122, 5106.412762532301, 5121.206213036967, 5157.510036546522, 5165.251038599401, 5036.471170527097, 5119.616028797836, 5152.793888244484, 5228.0, 5259.86850328741, 5194.0, 5197.220416937471, 5212.687238765668, 5226.529612334908, 5250.7374631268285, 5171.896562068757, 5191.792328306863, 5196.610254230929, 5211.973940130313, 5249.973750131263, 4962.3548938638105, 5083.135866902636, 5115.923261151086, 5120.769565369567, 5151.665141765773, 5424.186372044185, 5441.0, 5464.453554644543, 5477.287952566141, 5514.062609356419, 5978.730957106897, 6010.75956961721, 6018.0, 6030.909536356959, 6034.547408944347, 6035.034394496904, 6043.153958445821, 6089.299730531001, 6092.72582733778, 6127.525510585588, 5661.150827375926, 5662.207290979225, 5669.461401166883, 5671.06427439472, 5686.5735069869925, 6151.2618485781095, 6155.446009859134, 6160.075988601746, 6162.845928851725, 6164.6917654117115, 5842.328132264759, 5862.736176872051, 5913.822585322448, 5918.674472904032, 5950.672713000827, 6046.455818976226, 6059.454649081604, 6067.878642427127, 6068.180795592539, 6069.666168360694, 5989.490893274121, 5997.760089596454, 6012.759489620454, 6019.668918209453, 6071.483923866433, 5808.82573522795, 5974.790882319185, 6030.155778191057, 6043.244594425697, 6069.453749162508, 4553.317002449659, 4616.676832621684, 4626.375439315717, 4633.698809577367, 4662.743549104832, 4079.714419990572, 4120.443740095108, 4144.129732756095, 4144.979275103605, 4160.812763425653, 5679.375268720438, 5699.0, 5791.507721843691, 5882.088276317178, 5914.053751399755, 6112.541559383064, 6127.754889804358, 6133.662648554372, 6145.877082458415, 6158.907616385758, 5835.44563266489, 5846.824595262149, 5863.442972917566, 5865.472107510344, 5881.941180588225, 5113.386393632713, 5143.537081662668, 5158.845234642967, 5196.792128314901, 5199.792008319625, 6381.8085457436355, 6388.488920886318, 6396.584222025554, 6414.390632889868, 6426.389492998252, 5969.074793407029, 6069.726862291296, 6098.26820781509, 6140.754369825336, 6148.1085242640465, 6121.693915304128, 6249.812505624838, 6341.904871427025, 6389.0, 6395.360463953567, 5937.317208521075, 5985.375957675162, 5990.281166260077, 6003.189569408249, 6026.276846778414, 5947.940520594739, 6063.393660634078, 6067.575269731076, 6077.787277445268, 6091.0, 5884.411558844081, 5977.0, 5978.940210597838, 6001.099835024606, 6027.427394397525, 5872.442117998954, 5897.3807750185615, 5900.763969441175, 5918.526517878646, 5925.881482370414, 5462.9726851365485, 5763.452472015152, 5816.767329306949, 5824.126381042708, 5829.038208695687, 5869.53043756507, 5928.318243402064, 5957.16599676037, 5963.970180149072, 5980.372060933713, 5790.594658373873, 5792.102224155263, 5795.59430839854, 5803.071508558779, 5813.0], "value": 5587.262511397876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.9371159739826, 667.8096742428409, 675.2369822101025, 720.585663243635, 739.3161325773659, 39644.0, 41686.58313416865, 41841.58158418415, 41974.160516789685, 41987.370189447145, 44435.0, 44670.77664611681, 45029.77485112578, 45178.0, 45307.54692453075, 8938.95530522348, 9109.180173784358, 9112.362134650577, 9133.315001374891, 9143.86284205734, 8775.736727898173, 8867.866981995276, 8879.644814207424, 8908.109189081104, 8909.287257019456, 9096.0, 9147.542622868863, 9157.221636160933, 9187.954060229722, 9213.262938964901, 8952.418092823978, 9058.365914385995, 9074.500902450363, 9103.408278461879, 9103.544822758902, 9159.129882661136, 9298.0, 9298.674546390912, 9299.070092990714, 9331.393459425184, 44063.898402539875, 44309.33535996963, 44594.33108503375, 44598.55401445976, 44618.776906115265, 3954.4068389741483, 4483.641308695296, 4582.450105987269, 4679.017406344672, 4698.6241100712205, 34139.829300853584, 35298.0, 35742.64257357445, 36466.81766591177, 37098.0, 4656.627469802408, 4699.0836786826585, 4720.1975664136835, 4790.760461976887, 4819.156647586658, 267692.0, 268697.0, 269220.0, 270381.64809176023, 271125.0, 66569.33430665631, 66803.0, 67060.6646966762, 67102.66448667823, 67372.0, 76511.0, 77280.0, 77506.2249377499, 77561.61219193981, 77797.61101194458, 19370.80629193718, 19713.704294435596, 19715.0, 19750.604987900162, 19884.60230795376, 15090.773638395432, 15189.544313670607, 15204.46784362542, 15233.0, 15301.311440985182, 21447.571048578942, 21826.563468730856, 21861.234856779938, 22509.54980900373, 22593.2092376766, 8363.623636936352, 8624.353173512012, 8732.781680457912, 8743.0, 8759.386842920934, 1123.9887601124049, 1134.7673726885969, 1139.4075080957855, 1176.2178151529138, 1249.9187552809037, 33261.667383325854, 33289.500657490156, 33826.83086584601, 34253.486197707054, 34413.0, 1220.5911019808286, 1224.0758227538329, 1234.2656119608998, 1254.9749005019848, 1323.6293837725452, 17526.386576469762, 17861.374851880122, 17863.73204401935, 17918.91040544789, 18077.548061298574, 498759.0, 605589.0, 607948.0, 614915.0, 909698.0, 60643.69678151669, 61559.0, 61563.692181538805, 61600.69199653973, 61727.07409388863, 1554.1840533719887, 1557.5483109898003, 1579.5893067802454, 1583.1213676409702, 1666.7666526686273, 33510.0, 33831.0, 33851.32297354088, 34022.31955360928, 34900.301993960486, 56288.43711562996, 57291.42708572861, 57347.713261433426, 57397.0, 57643.0, 449367.0, 451726.0, 451857.0, 452218.0, 453244.0, 30984.22539436532, 32044.0, 32044.359112818078, 32074.67925320717, 32324.191895202806, 50511.24233136432, 51282.0, 51632.63982114079, 51788.0, 51801.0, 42791.35812962746, 43493.56506434895, 43635.345469817345, 44182.0, 44215.778921105186, 42546.78726606471, 43178.568214317456, 43254.0, 43649.34525982176, 44317.0, 43033.0, 43697.56302436935, 44519.55480445154, 44802.3279650799, 44857.327140092275, 37526.0, 37560.49758009649, 37667.0, 38213.0, 38420.6157938417, 29595.0, 29807.254818629706, 29829.254268642588, 29841.701582983893, 30006.54990175193], "value": 21839.20328960605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.73115399606235, 441.8409372625855, 444.1760534209044, 446.7587502748516, 449.2968504290787, 19069.52326191846, 19196.904015479922, 19885.105170267336, 20689.58620827586, 20700.8964955175, 19934.80065199351, 20089.698654520194, 20351.592968140667, 20622.0, 20773.480662983435, 5550.333959924815, 5825.097109947944, 5836.6789826559525, 5837.299524057119, 5853.092770620539, 5652.915206271889, 5820.534357251409, 5850.531957443415, 5876.412358764111, 5956.583039187237, 5882.235309409771, 5935.940640593603, 5938.376470470582, 5947.256592925884, 5989.520838332923, 5783.190353350535, 5913.113033045035, 5934.139549765281, 6041.184440100574, 6069.02895536712, 5879.647221166701, 5897.764089436418, 5940.257467816523, 5944.583879128462, 5950.613210141327, 14833.332500037417, 19972.801631901988, 21321.893390532947, 24204.39489012771, 24822.627660585105, 2358.5282943411385, 2427.1626288930293, 2435.7198922124007, 2462.187478132212, 3069.2326918270433, 10141.18870490359, 10349.482525873676, 10430.739231519197, 10659.253852230348, 10803.081738052275, 1924.4611508777564, 1969.5273134447773, 1992.4520756791853, 2018.535736780534, 2027.3107143571256, 72727.27272727258, 79390.0, 84437.57781211054, 87689.0, 90115.54942225313, 11558.94220528892, 11747.530098795953, 12015.699607509881, 12032.338221397908, 12074.0, 16870.493885183463, 16999.320027198773, 17054.062026588657, 17102.743458848126, 17103.657926841395, 9118.452892826319, 9146.451212927246, 9283.62865485373, 9345.15893569582, 9445.338826282094, 9123.087691230823, 9156.084391560791, 9224.215941645036, 9259.490728010023, 9260.259179265642, 5063.721495317793, 5144.279800827887, 5146.382434107931, 5190.766415511311, 5231.01221535814, 2075.9792402076087, 2122.2784253353934, 2134.3063504361144, 2202.8568143070647, 2249.5613355395867, 1026.2764750850633, 1076.2466273608504, 1098.7308109513222, 1107.2636696596674, 1167.0, 17935.461936141935, 19047.809521904604, 19230.326938557082, 19839.504012399804, 19952.800471995095, 1068.273573969708, 1106.618216715232, 1117.5306371324064, 1176.611718133014, 1184.135581025856, 11079.28271117978, 11223.831642525369, 11288.2662626929, 11329.943350283196, 11338.60314888975, 318921.0, 526908.0, 569609.0, 666604.0, 666931.0, 94947.52526237463, 103054.48472757588, 107367.46316268525, 107779.0, 112042.43978780054, 511.7134404733361, 525.6583220906365, 531.4366771222517, 532.1485623003164, 543.3696911582624, 10848.566057357617, 11097.500612472619, 11438.370889601152, 11585.884141158818, 11666.88333116658, 41385.172296554505, 41502.0, 41687.374689379074, 42199.367009494264, 42854.0, 62674.37325626868, 64390.0, 64468.355316446236, 64986.67506662436, 65102.34897650963, 9227.21568666644, 9354.953225234103, 9355.111264429868, 9360.485173315534, 9511.667091652036, 11985.760284794429, 14050.297485125908, 14304.213268270345, 14340.784888226477, 14407.567772966828, 12259.632211033684, 12453.1905426147, 12585.748285034066, 12656.6835829105, 12715.300658463873, 11910.344931028876, 11923.0461563073, 12109.636710898687, 12256.264624122581, 12295.56965506203, 12444.688882778002, 12495.0, 12897.29064901402, 12949.935250323688, 13014.869851301366, 8971.372003959921, 9058.954705226432, 9087.863682044643, 9114.40756350835, 9441.716748497556, 9330.160285574331, 12088.879111209128, 12656.6835829105, 12777.48890044425, 12851.100422970303], "value": 9494.779010126083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1584.9920750396245, 1588.9920550397246, 1812.10300901054, 1905.409323109837, 1916.26931622438, 7534.359579435754, 8165.3875959302995, 8366.37252206084, 8592.828143437135, 8599.570021498923, 8278.130796266396, 8281.91718082819, 8367.163283671629, 8486.95756521218, 8538.487690738544, 2394.784469397758, 2415.758424157588, 2425.126954296452, 2426.1023421334044, 2431.63525471179, 2460.1020627470934, 2521.773040426361, 2524.0156339027703, 2525.02786427225, 2525.684289463817, 2476.3313905245573, 2478.6405971134177, 2511.7613826686434, 2512.371907023244, 2513.7988960883085, 2439.121916110199, 2441.3896525868445, 2452.8405653632544, 2460.5324988252173, 2482.5283196192845, 2502.6621406110307, 2526.166365099531, 2530.4559519703166, 2539.390546268901, 2540.618907163922, 8500.74497765068, 8502.872456913152, 8503.1921967413, 8507.702230421968, 8515.403921725481, 5364.8122315718765, 5420.864478388033, 5453.618246722731, 5484.287042684466, 5494.917576236359, 3412.6282233847487, 3429.3827111120236, 3457.3776720190353, 3561.305545418644, 3566.857325706969, 1127.0983213429306, 1151.113642495274, 1158.7276989907366, 1184.798584240681, 1193.498730533178, 11984.221025633306, 12042.458089386086, 12047.81928271068, 12080.697982550419, 12089.21420107699, 4556.749378784199, 4601.309803529431, 4641.094986477605, 4645.326427667969, 4651.441826980784, 9645.855312170323, 9717.757056073655, 9721.562529686182, 9726.221902247804, 9731.854022189673, 5329.387120481194, 5355.062863998784, 5373.301470808769, 5390.191471279261, 5411.891762164734, 4877.951220487821, 5004.574611158092, 5023.572996295283, 5049.949500505021, 5055.51972562606, 3937.7637341759014, 3970.0, 4023.657989070903, 4062.756234625873, 4104.0970986383545, 1215.4166000319897, 1222.7921253386946, 1229.883161099694, 1249.4752204074312, 1257.867923867999, 972.8589354543693, 1007.8639383683255, 1061.5647584490475, 1065.4033741105006, 1081.4646749858714, 6072.180255665517, 6076.574639775174, 6092.116643086728, 6154.261488621304, 6182.938170618326, 500.5670095367481, 501.9347484826949, 505.99747001264757, 510.07421529923073, 513.2967834067351, 4242.851500197478, 4295.4415925929425, 4316.460442444694, 4322.438083049184, 4404.691671583022, 10280.742981425525, 10594.470276486145, 10725.30285531438, 10762.139028877671, 10811.6215932442, 10197.541110650038, 10576.629817956335, 10609.84085238722, 10626.521806518725, 10669.679909602724, 7924.088729796147, 7948.443608947318, 7958.0, 7972.60136993148, 8032.598370081472, 5975.193348897843, 5997.370276120944, 5999.790007349722, 6079.392060793885, 6103.938960610337, 9468.573914173741, 9542.37974531681, 9571.425714457155, 9716.465594392093, 9719.27105467107, 9410.670626528039, 9631.518424078908, 9693.642889995264, 9895.851562226428, 9988.700338989842, 7130.7147714092935, 7240.601766902871, 7252.238514955854, 7345.926540734525, 7462.440316976357, 7669.6548655309525, 7673.769786906401, 7700.0, 7740.187280335709, 7749.070111586646, 6880.827979300558, 6907.965460172667, 7030.753923612853, 7081.681324340314, 7250.166230883305, 6866.485013623898, 7127.2516385778745, 7264.927350726425, 7334.449916256195, 7345.853082938418, 6170.352113028068, 6340.0, 6346.428821406095, 6355.396237357444, 6388.840278992877, 5044.445111037856, 5086.059079070384, 5103.387593488656, 5104.872378190426, 5118.232265160255, 4901.313816065683, 5149.48505149482, 5163.432022477449, 5178.171492561172, 5183.896322073462], "value": 4555.114678232203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.49710653638175, 368.77320447924535, 371.120444546425, 372.0382810435026, 374.25523208814457, 6456.7094480748365, 6519.315471875456, 6539.378759017892, 6608.438282745967, 6726.125603671522, 6560.967195164029, 6585.473162147029, 6612.933870661304, 6645.700943457544, 6675.799726008216, 4999.925001124986, 5009.924851127236, 5029.874253143673, 5030.6730062546, 5044.445111037783, 5024.095662780698, 5026.547610715035, 5039.6976181429045, 5050.84847454577, 5051.040302342543, 4989.376327959005, 4989.925151122736, 5000.049990501811, 5003.774830132653, 5011.924821127686, 4815.0, 4964.230544265644, 4989.176785830316, 4991.026749783794, 4997.875053123683, 4312.805923733439, 4313.525512193656, 4327.913441731179, 4332.631726303268, 4338.848140315074, 6242.87514249717, 6242.96878515609, 6249.437550620421, 6250.249970003629, 6260.342664020303, 5674.829755107354, 5842.620229685057, 5846.41535846412, 5854.590178687494, 5858.941410585882, 6946.895796563055, 6965.442764578822, 6965.965170174168, 6976.930230697679, 6977.6511174441075, 4819.662623616348, 4830.420349558076, 4833.299171620095, 4840.782164802592, 4841.636877234221, 7256.1655409628565, 7271.963640181818, 7333.266673332678, 7356.411487081021, 7357.117145942468, 4610.469795973506, 4935.728534930541, 4942.135126352874, 4946.505349465025, 4958.528939750718, 4762.738049407316, 4786.760661966888, 4803.855884323476, 4811.0, 4820.084184005098, 5654.349749778746, 5668.234788303526, 5670.0, 5676.971615141898, 5690.032694441955, 6957.652117394211, 6997.335253150943, 7017.333353331425, 7025.613591252428, 7032.683529241094, 1735.0, 1738.8695847811464, 1743.7994630617388, 1753.281154726556, 1757.9384721534684, 1108.4513165982728, 1121.243160866412, 1139.1114930354338, 1157.346099453806, 1178.2459226095307, 6679.632620205838, 6700.530962832652, 6793.694283757242, 6802.3537763912345, 6834.0, 7211.783646490614, 7250.927490725131, 7285.927140728525, 7288.854222915618, 7292.088488938883, 6728.697208625624, 6756.729730810811, 6762.966185169043, 6765.391114799593, 6768.932310676929, 3832.9233415331537, 3901.4342920276968, 3906.8670085675403, 3915.353966595537, 3915.569287378386, 7442.404607631376, 7615.276548727862, 7777.144514103444, 7780.572068536285, 7783.571903545359, 7488.550686958691, 7518.323350898446, 7519.172890981988, 7534.886976695354, 7534.927894828966, 7756.3019328260725, 7761.068671759312, 7768.495047821986, 7772.106207786064, 7779.260970207822, 7175.820604484929, 7326.890096648661, 7327.303906128909, 7352.301531354513, 7373.483856130019, 7210.711571537289, 7224.060872086595, 7241.5293005954445, 7246.311600397954, 7253.347198752138, 7630.7329243476215, 7653.961730191313, 7658.617069146632, 7674.6930122794465, 7729.961350193438, 4915.3855768029, 4966.652334336562, 4966.701997880139, 4967.205247160437, 4987.326710893983, 7134.2152363238965, 7284.417246620152, 7285.380742636935, 7307.67115479794, 7336.266373362834, 7075.787726368011, 7090.929090709234, 7096.254893236136, 7106.010317111217, 7112.928870711226, 7036.2260151384335, 7053.823654408681, 7065.399441047569, 7076.25699301566, 7082.902150166732, 6833.3166683331265, 6933.618650974043, 6939.687714052779, 6949.131358580177, 6978.546394484342, 6994.475414343843, 7129.073220481304, 7146.071010768775, 7150.392216661642, 7165.964170179116, 6758.662066896733, 6966.12923384577, 6970.23327433992, 6973.476989225727, 6976.7558135465015], "value": 5282.212689627873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.4563479373201, 934.7195841247624, 941.0542404883091, 955.8231727130477, 956.9808603827923, 15126.848731512682, 15498.767518487217, 15501.534953951372, 17114.05872677002, 17747.37884174054, 16141.273642686077, 16203.351865925379, 16227.756583651226, 16235.91882040591, 16257.674846503063, 918.728974952389, 927.3091546797611, 931.4039015030386, 935.3546053223288, 937.2501998401286, 925.9166674999249, 943.1841457139559, 946.1531928923644, 946.4274114160937, 947.6777895515523, 966.3718582921088, 973.5910917414703, 974.3471873844505, 974.6491263145263, 975.6633961283381, 961.2310151878504, 965.0446058402131, 966.294604938399, 968.7093871838456, 969.0745338202036, 712.9108861392326, 714.6176795414428, 714.9428045756379, 715.2632788228134, 716.5449939288537, 15861.0, 15899.60250993723, 15912.52262432129, 15913.363465461367, 15950.122743249116, 14786.482473113389, 14817.333220005126, 14927.626809329853, 14947.626309342244, 15000.474983375529, 11241.213115081948, 11322.20744547882, 11673.474693638807, 11786.941065294619, 12151.574694885636, 4040.333344998072, 4041.6160464755803, 4105.4252404663375, 4158.6673066154635, 4226.154769046172, 56689.71655141739, 57893.42106578965, 57998.130028049614, 59536.70231648814, 60733.0, 11678.6496405108, 11758.412079396167, 12033.63899083029, 12224.816627750592, 12262.570810021607, 20609.690854637192, 20659.380218593466, 20703.550751447554, 20757.27349542789, 20757.896210519153, 9086.727398178065, 9121.90878091224, 9132.452052876848, 9234.769130771785, 9572.090651388107, 4909.263610458388, 4982.451930287665, 4990.051890140861, 5008.899822003539, 5075.5178258065425, 3343.398188326076, 3381.932361352759, 3390.3727810355163, 3392.270661807674, 3399.099238701746, 657.3590749019763, 664.4617859533793, 667.8196886840526, 673.0039541478541, 681.2438193605094, 798.7444017914212, 799.8800179972934, 825.9881644984846, 845.644829171737, 856.9700060497853, 9557.63289391345, 10058.54736536843, 10316.27786054969, 10376.481175941173, 10469.581216751245, 662.3806740697463, 831.8876951611455, 838.5974732128612, 846.420202161509, 856.3534531428731, 4383.517813040563, 4406.471223453206, 4424.668149888771, 4560.885977850514, 4592.7933243004145, 63093.05360419597, 63463.0, 63720.681396593645, 63859.0, 64146.0, 55946.720266398406, 57940.130898036565, 58164.70917645385, 58263.0, 58508.70745646244, 51012.23481647778, 51859.74070129701, 52303.0, 53017.469825302025, 54290.0, 8868.290536757173, 8931.910680893108, 9075.727728167902, 9564.713058608253, 9668.564914579001, 39675.80162099171, 40235.0, 40336.79831600823, 40611.18777624372, 40711.1857762849, 45235.321470178635, 47002.76498617485, 51855.481445186575, 52079.0, 52150.73924630504, 11194.0, 11528.769424611628, 11718.824217636571, 11724.531018759495, 12171.634850954486, 12999.220046797222, 13136.0, 13174.802377964146, 13210.471581136648, 13267.2703001332, 12005.099617528545, 12169.391530423267, 12222.572209972608, 12222.87777122253, 12703.87296127064, 12062.939685301517, 12294.569690060805, 12523.37383130858, 12784.488620455078, 12790.552330668383, 11935.104867134825, 12593.0, 12604.243745375306, 12662.176958498037, 12665.366731663564, 10326.432046237529, 10508.474576271003, 10595.152387808803, 10713.732156696145, 10715.839262410915, 10076.69769906904, 10776.838347424951, 10909.236353455182, 10910.836337455103, 10915.345079295268], "value": 7239.921796893569, "unit": "score"}], "name": "dromaeo_css", "value": 7658.935491073861, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 111.0, 111.0, 111.0, 103.0, 111.0, 112.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 157.0, 174.0, 134.0, 154.0, 160.0, 128.0, 183.0, 126.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 164.0, 165.0, 162.0, 162.0, 163.0, 162.0, 165.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 175.0, 76.0, 73.0, 72.0, 76.0, 176.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 164.0, 91.0, 93.0, 92.0, 142.0, 93.0, 92.0, 161.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 121.0, 117.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 57.0, 62.0, 68.0, 58.0, 77.0, 55.0, 58.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 73.0, 81.0, 73.0, 77.0, 74.0, 74.0, 73.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 127.0, 127.0, 115.0, 125.0, 122.0, 114.0, 115.0, 135.0, 131.0], "value": 122.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 159.0, 160.0, 170.0, 162.0, 160.0, 164.0, 161.0, 158.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 70.0, 68.0, 67.0, 65.0, 69.0, 73.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1536.7999999999997, "alertThreshold": 2.0}]} 04:19:45 INFO - Return code: 0 04:19:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:19:45 ERROR - # TBPL SUCCESS # 04:19:45 INFO - Running post-action listener: _resource_record_post_action 04:19:45 INFO - Running post-run listener: _resource_record_post_run 04:19:46 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462434304; Read time: 20; Write time: 366528 04:19:46 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242167808; Read time: 0; Write time: 263188 04:19:46 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220266496; Read time: 20; Write time: 103340 04:19:46 INFO - Running post-run listener: _upload_blobber_files 04:19:46 INFO - Blob upload gear active. 04:19:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:19:46 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'] 04:19:46 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 04:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:48 INFO - (blobuploader) - INFO - Done attempting. 04:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:48 INFO - (blobuploader) - INFO - Done attempting. 04:19:48 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:48 INFO - Return code: 0 04:19:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5c05ba8f4f59b3bbd53ff899b7d1275e95d077e663b86a270bdc69801e6766a6f7cd4a1d23498df524dfac089eb01361511094fb0f4cf21260b4483509e66c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d8804b4eddf3d708244e2a7303aae29aeee6b3f90b263011199f4a8a10a538b8eb66f7ff5654fe7ce6401182be8e07e1e5e88745e27a5f362b5ae7dfab2109"} 04:19:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:48 INFO - Contents: 04:19:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5c05ba8f4f59b3bbd53ff899b7d1275e95d077e663b86a270bdc69801e6766a6f7cd4a1d23498df524dfac089eb01361511094fb0f4cf21260b4483509e66c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d8804b4eddf3d708244e2a7303aae29aeee6b3f90b263011199f4a8a10a538b8eb66f7ff5654fe7ce6401182be8e07e1e5e88745e27a5f362b5ae7dfab2109"} 04:19:48 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:48 INFO - Copying logs to upload dir... 04:19:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.234806 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-03 04:19:48.840649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:19:48.843686) ========= 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=eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610 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/e5c05ba8f4f59b3bbd53ff899b7d1275e95d077e663b86a270bdc69801e6766a6f7cd4a1d23498df524dfac089eb01361511094fb0f4cf21260b4483509e66c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d8804b4eddf3d708244e2a7303aae29aeee6b3f90b263011199f4a8a10a538b8eb66f7ff5654fe7ce6401182be8e07e1e5e88745e27a5f362b5ae7dfab2109"} build_url:https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/M6GkoRGtT9ylIWgDEBDu-w/artifacts/public/build/firefox-48.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/e5c05ba8f4f59b3bbd53ff899b7d1275e95d077e663b86a270bdc69801e6766a6f7cd4a1d23498df524dfac089eb01361511094fb0f4cf21260b4483509e66c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d8804b4eddf3d708244e2a7303aae29aeee6b3f90b263011199f4a8a10a538b8eb66f7ff5654fe7ce6401182be8e07e1e5e88745e27a5f362b5ae7dfab2109"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:19:48.871959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:19:48.872335) ========= 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=eca2ab57546de7b41f256b19000001ef-1467542972.398648-325254610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:19:48.922077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:19:48.925433) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:19:48.925727) ========= ========= Total master_lag: 0.81 =========