builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1462407989.55 results: success (0) buildid: 20160504143046 builduid: 481ab979ab6a4ed19e48cfbc72a08034 revision: 360e0a95af6f0744dbbb84ebcd9cd585893465a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.551241) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.551666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.551999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.621617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.621911) ========= 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=aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 17:26:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 143M=0s 2016-05-04 17:26:29 (143 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108873 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.759512) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.762838) ========= 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=aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020836 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.821054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:29.821374) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 360e0a95af6f0744dbbb84ebcd9cd585893465a4 --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 360e0a95af6f0744dbbb84ebcd9cd585893465a4 --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=aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 17:26:30,022 truncating revision to first 12 chars 2016-05-04 17:26:30,022 Setting DEBUG logging. 2016-05-04 17:26:30,022 attempt 1/10 2016-05-04 17:26:30,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/360e0a95af6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 17:26:30,380 unpacking tar archive at: mozilla-beta-360e0a95af6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657633 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:30.507174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:30.507467) ========= script_repo_revision: 360e0a95af6f0744dbbb84ebcd9cd585893465a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:30.507862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:30.508274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:30.514930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-04 17:26:30.515197) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:30 INFO - MultiFileLogger online at 20160504 17:26:30 in /builds/slave/test 17:26:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:26:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:30 INFO - {'append_to_log': False, 17:26:30 INFO - 'base_work_dir': '/builds/slave/test', 17:26:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:26:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:30 INFO - 'branch': 'Mozilla-Beta', 17:26:30 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:30 INFO - 'config_files': ('talos/linux_config.py',), 17:26:30 INFO - 'default_actions': ('clobber', 17:26:30 INFO - 'read-buildbot-config', 17:26:30 INFO - 'download-and-extract', 17:26:30 INFO - 'populate-webroot', 17:26:30 INFO - 'create-virtualenv', 17:26:30 INFO - 'install', 17:26:30 INFO - 'run-tests'), 17:26:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:30 INFO - 'download_minidump_stackwalk': True, 17:26:30 INFO - 'download_symbols': 'ondemand', 17:26:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:26:30 INFO - 'tooltool.py': '/tools/tooltool.py', 17:26:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:26:30 INFO - '/tools/misc-python/virtualenv.py')}, 17:26:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:30 INFO - 'installer_path': 'installer.exe', 17:26:30 INFO - 'log_level': 'info', 17:26:30 INFO - 'log_name': 'talos', 17:26:30 INFO - 'log_to_console': True, 17:26:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:30 INFO - 'opt_config_files': (), 17:26:30 INFO - 'pip_index': False, 17:26:30 INFO - 'sps_profile': False, 17:26:30 INFO - 'sps_profile_interval': 0, 17:26:30 INFO - 'suite': 'dromaeojs', 17:26:30 INFO - 'system_bits': '32', 17:26:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:30 INFO - 'title': 'talos-linux64-ix-009', 17:26:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:30 INFO - 'use_talos_json': True, 17:26:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:30 INFO - 'work_dir': 'build'} 17:26:30 INFO - ##### 17:26:30 INFO - ##### Running clobber step. 17:26:30 INFO - ##### 17:26:30 INFO - Running pre-action listener: _resource_record_pre_action 17:26:30 INFO - Running main action method: clobber 17:26:30 INFO - rmtree: /builds/slave/test/build 17:26:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - ##### 17:26:31 INFO - ##### Running read-buildbot-config step. 17:26:31 INFO - ##### 17:26:31 INFO - Running pre-action listener: _resource_record_pre_action 17:26:31 INFO - Running main action method: read_buildbot_config 17:26:31 INFO - Using buildbot properties: 17:26:31 INFO - { 17:26:31 INFO - "project": "", 17:26:31 INFO - "product": "firefox", 17:26:31 INFO - "script_repo_revision": "production", 17:26:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:26:31 INFO - "repository": "", 17:26:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:26:31 INFO - "buildid": "20160504143046", 17:26:31 INFO - "pgo_build": "True", 17:26:31 INFO - "basedir": "/builds/slave/test", 17:26:31 INFO - "buildnumber": 225, 17:26:31 INFO - "slavename": "talos-linux64-ix-009", 17:26:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:26:31 INFO - "platform": "ubuntu64_hw", 17:26:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:26:31 INFO - "branch": "mozilla-beta", 17:26:31 INFO - "repo_path": "releases/mozilla-beta", 17:26:31 INFO - "revision": "360e0a95af6f0744dbbb84ebcd9cd585893465a4", 17:26:31 INFO - "stage_platform": "linux64-pgo", 17:26:31 INFO - "builduid": "481ab979ab6a4ed19e48cfbc72a08034", 17:26:31 INFO - "slavebuilddir": "test" 17:26:31 INFO - } 17:26:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - ##### 17:26:31 INFO - ##### Running download-and-extract step. 17:26:31 INFO - ##### 17:26:31 INFO - Running pre-action listener: _resource_record_pre_action 17:26:31 INFO - Running main action method: download_and_extract 17:26:31 INFO - mkdir: /builds/slave/test/build/tests 17:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:31 INFO - https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:26:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 17:26:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 17:26:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 17:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:26:39 INFO - Downloaded 1412 bytes. 17:26:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 17:26:39 INFO - Using the following test package requirements: 17:26:39 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 17:26:39 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:26:39 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 17:26:39 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'jsshell-linux-x86_64.zip'], 17:26:39 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:26:39 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 17:26:39 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 17:26:39 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 17:26:39 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:26:39 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 17:26:39 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 17:26:39 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:26:39 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:26: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')]} 17:26:39 INFO - https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 17:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 17:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 17:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:26:43 INFO - Downloaded 23364525 bytes. 17:26:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:26:44 INFO - Return code: 0 17:26:44 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:26: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')]} 17:26:44 INFO - https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 17:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 17:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 17:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:26:48 INFO - Downloaded 23364525 bytes. 17:26:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:26:49 INFO - Return code: 0 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:49 INFO - https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 17:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 17:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 17:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:26:50 INFO - Downloaded 10845194 bytes. 17:26:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:26:50 INFO - Return code: 0 17:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:50 INFO - https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:26:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 17:26:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 17:26:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 17:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:26:52 INFO - Downloaded 53798737 bytes. 17:26:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 17:26:52 INFO - mkdir: /builds/slave/test/properties 17:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:52 INFO - Contents: 17:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 17:26:53 INFO - Running post-action listener: _resource_record_post_action 17:26:53 INFO - Running post-action listener: set_extra_try_arguments 17:26:53 INFO - ##### 17:26:53 INFO - ##### Running populate-webroot step. 17:26:53 INFO - ##### 17:26:53 INFO - Running pre-action listener: _resource_record_pre_action 17:26:53 INFO - Running main action method: populate_webroot 17:26:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:53 INFO - '--tppagecycles', 17:26:53 INFO - '7'], 17:26:53 INFO - 'tests': ['tsvgm']}}, 17:26:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:26:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:26:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'tests': ['damp', 'tps']}, 17:26:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['damp', 'tps']}, 17:26:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:53 INFO - 'other': {'tests': ['a11yr', 17:26:53 INFO - 'ts_paint', 17:26:53 INFO - 'tpaint', 17:26:53 INFO - 'sessionrestore', 17:26:53 INFO - 'sessionrestore_no_auto_restore', 17:26:53 INFO - 'tabpaint']}, 17:26:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['a11yr', 17:26:53 INFO - 'ts_paint', 17:26:53 INFO - 'tpaint', 17:26:53 INFO - 'sessionrestore', 17:26:53 INFO - 'sessionrestore_no_auto_restore', 17:26:53 INFO - 'tabpaint']}, 17:26:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['a11yr', 17:26:53 INFO - 'ts_paint', 17:26:53 INFO - 'tpaint', 17:26:53 INFO - 'sessionrestore', 17:26:53 INFO - 'sessionrestore_no_auto_restore', 17:26:53 INFO - 'tabpaint']}, 17:26:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['a11yr', 17:26:53 INFO - 'ts_paint', 17:26:53 INFO - 'tpaint', 17:26:53 INFO - 'sessionrestore', 17:26:53 INFO - 'sessionrestore_no_auto_restore', 17:26:53 INFO - 'tabpaint']}, 17:26:53 INFO - 'other_l64': {'tests': ['a11yr', 17:26:53 INFO - 'ts_paint', 17:26:53 INFO - 'tpaint', 17:26:53 INFO - 'sessionrestore', 17:26:53 INFO - 'sessionrestore_no_auto_restore', 17:26:53 INFO - 'tabpaint']}, 17:26:53 INFO - 'other_nol64': {'tests': ['a11yr', 17:26:53 INFO - 'ts_paint', 17:26:53 INFO - 'tpaint', 17:26:53 INFO - 'sessionrestore', 17:26:53 INFO - 'sessionrestore_no_auto_restore', 17:26:53 INFO - 'tabpaint']}, 17:26:53 INFO - 'svgr': {'tests': ['tsvgx', 17:26:53 INFO - 'tsvgr_opacity', 17:26:53 INFO - 'tart', 17:26:53 INFO - 'tscrollx', 17:26:53 INFO - 'cart']}, 17:26:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['tsvgx', 17:26:53 INFO - 'tsvgr_opacity', 17:26:53 INFO - 'tart', 17:26:53 INFO - 'tscrollx', 17:26:53 INFO - 'cart']}, 17:26:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'tests': ['tp5o']}, 17:26:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'talos_options': ['--e10s'], 17:26:53 INFO - 'tests': ['tp5o']}, 17:26:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'talos_options': ['--xperf_path', 17:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:53 INFO - 'tests': ['tp5n']}, 17:26:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:53 INFO - 'talos_options': ['--e10s', 17:26:53 INFO - '--xperf_path', 17:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:53 INFO - 'tests': ['tp5n']}}, 17:26:53 INFO - 'talos.zip': {'path': '', 17:26:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:53 INFO - Running post-action listener: _resource_record_post_action 17:26:53 INFO - ##### 17:26:53 INFO - ##### Running create-virtualenv step. 17:26:53 INFO - ##### 17:26:53 INFO - Running pre-action listener: _resource_record_pre_action 17:26:53 INFO - Running main action method: create_virtualenv 17:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:53 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 17:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:53 INFO - Using real prefix '/usr' 17:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:55 INFO - Installing pip.................done. 17:26:55 INFO - Return code: 0 17:26:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:26: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', 'pip>=1.5'] in /builds/slave/test/build 17:26: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 pip>=1.5 17:26:55 INFO - Using env: {'DISPLAY': ':0', 17:26:55 INFO - 'HOME': '/home/cltbld', 17:26:55 INFO - 'LANG': 'en_US.UTF-8', 17:26:55 INFO - 'LANGUAGE': 'en_US:en', 17:26:55 INFO - 'LOGNAME': 'cltbld', 17:26:55 INFO - 'MAIL': '/var/mail/cltbld', 17:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:55 INFO - 'MOZ_NO_REMOTE': '1', 17:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:55 INFO - 'NO_EM_RESTART': '1', 17:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:55 INFO - 'PWD': '/builds/slave/test', 17:26:55 INFO - 'SHELL': '/bin/bash', 17:26:55 INFO - 'SHLVL': '1', 17:26:55 INFO - 'TERM': 'linux', 17:26:55 INFO - 'TMOUT': '86400', 17:26:55 INFO - 'USER': 'cltbld', 17:26:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:55 INFO - '_': '/tools/buildbot/bin/python'} 17:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:55 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 17:26:55 INFO - Cleaning up... 17:26:55 INFO - Return code: 0 17:26:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', '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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:26: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:26: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 psutil>=0.7.1 17:26:55 INFO - Using env: {'DISPLAY': ':0', 17:26:55 INFO - 'HOME': '/home/cltbld', 17:26:55 INFO - 'LANG': 'en_US.UTF-8', 17:26:55 INFO - 'LANGUAGE': 'en_US:en', 17:26:55 INFO - 'LOGNAME': 'cltbld', 17:26:55 INFO - 'MAIL': '/var/mail/cltbld', 17:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:55 INFO - 'MOZ_NO_REMOTE': '1', 17:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:55 INFO - 'NO_EM_RESTART': '1', 17:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:55 INFO - 'PWD': '/builds/slave/test', 17:26:55 INFO - 'SHELL': '/bin/bash', 17:26:55 INFO - 'SHLVL': '1', 17:26:55 INFO - 'TERM': 'linux', 17:26:55 INFO - 'TMOUT': '86400', 17:26:55 INFO - 'USER': 'cltbld', 17:26:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:55 INFO - '_': '/tools/buildbot/bin/python'} 17:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:56 INFO - Downloading/unpacking psutil>=0.7.1 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:58 INFO - Installing collected packages: psutil 17:26:58 INFO - Running setup.py install for psutil 17:26:58 INFO - building 'psutil._psutil_linux' extension 17:26:58 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 17:26:58 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 17:26:58 INFO - building 'psutil._psutil_posix' extension 17:26:58 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 17:26:58 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 17:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:58 INFO - Successfully installed psutil 17:26:58 INFO - Cleaning up... 17:26:58 INFO - Return code: 0 17:26:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:26:58 INFO - Using env: {'DISPLAY': ':0', 17:26:58 INFO - 'HOME': '/home/cltbld', 17:26:58 INFO - 'LANG': 'en_US.UTF-8', 17:26:58 INFO - 'LANGUAGE': 'en_US:en', 17:26:58 INFO - 'LOGNAME': 'cltbld', 17:26:58 INFO - 'MAIL': '/var/mail/cltbld', 17:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:58 INFO - 'MOZ_NO_REMOTE': '1', 17:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:58 INFO - 'NO_EM_RESTART': '1', 17:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:58 INFO - 'PWD': '/builds/slave/test', 17:26:58 INFO - 'SHELL': '/bin/bash', 17:26:58 INFO - 'SHLVL': '1', 17:26:58 INFO - 'TERM': 'linux', 17:26:58 INFO - 'TMOUT': '86400', 17:26:58 INFO - 'USER': 'cltbld', 17:26:58 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:58 INFO - '_': '/tools/buildbot/bin/python'} 17:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:27:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:27:00 INFO - Installing collected packages: mozsystemmonitor 17:27:00 INFO - Running setup.py install for mozsystemmonitor 17:27:00 INFO - Successfully installed mozsystemmonitor 17:27:00 INFO - Cleaning up... 17:27:00 INFO - Return code: 0 17:27:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:27:00 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')]} 17:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:00 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')]} 17:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:00 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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:27:00 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 17:27:00 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 17:27:00 INFO - Using env: {'DISPLAY': ':0', 17:27:00 INFO - 'HOME': '/home/cltbld', 17:27:00 INFO - 'LANG': 'en_US.UTF-8', 17:27:00 INFO - 'LANGUAGE': 'en_US:en', 17:27:00 INFO - 'LOGNAME': 'cltbld', 17:27:00 INFO - 'MAIL': '/var/mail/cltbld', 17:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:00 INFO - 'MOZ_NO_REMOTE': '1', 17:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:00 INFO - 'NO_EM_RESTART': '1', 17:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:00 INFO - 'PWD': '/builds/slave/test', 17:27:00 INFO - 'SHELL': '/bin/bash', 17:27:00 INFO - 'SHLVL': '1', 17:27:00 INFO - 'TERM': 'linux', 17:27:00 INFO - 'TMOUT': '86400', 17:27:00 INFO - 'USER': 'cltbld', 17:27:00 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:00 INFO - '_': '/tools/buildbot/bin/python'} 17:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:27:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:27:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 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 17:27:03 INFO - Downloading docopt-0.6.1.tar.gz 17:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:27:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:27:03 INFO - Running setup.py install for blobuploader 17:27:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:27:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:27:03 INFO - Running setup.py install for requests 17:27:04 INFO - Running setup.py install for docopt 17:27:04 INFO - Successfully installed blobuploader requests docopt 17:27:04 INFO - Cleaning up... 17:27:04 INFO - Return code: 0 17:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:04 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')]} 17:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:04 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')]} 17:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:04 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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:27:04 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 17:27:04 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 17:27:04 INFO - Using env: {'DISPLAY': ':0', 17:27:04 INFO - 'HOME': '/home/cltbld', 17:27:04 INFO - 'LANG': 'en_US.UTF-8', 17:27:04 INFO - 'LANGUAGE': 'en_US:en', 17:27:04 INFO - 'LOGNAME': 'cltbld', 17:27:04 INFO - 'MAIL': '/var/mail/cltbld', 17:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:04 INFO - 'MOZ_NO_REMOTE': '1', 17:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:04 INFO - 'NO_EM_RESTART': '1', 17:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:04 INFO - 'PWD': '/builds/slave/test', 17:27:04 INFO - 'SHELL': '/bin/bash', 17:27:04 INFO - 'SHLVL': '1', 17:27:04 INFO - 'TERM': 'linux', 17:27:04 INFO - 'TMOUT': '86400', 17:27:04 INFO - 'USER': 'cltbld', 17:27:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:04 INFO - '_': '/tools/buildbot/bin/python'} 17:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:04 INFO - Running setup.py (path:/tmp/pip-3X7OfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:04 INFO - Running setup.py (path:/tmp/pip-ERhfF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:04 INFO - Running setup.py (path:/tmp/pip-7XR_IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:04 INFO - Running setup.py (path:/tmp/pip-fN3_3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:04 INFO - Running setup.py (path:/tmp/pip-rDtHzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:04 INFO - Running setup.py (path:/tmp/pip-okVC88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:05 INFO - Running setup.py (path:/tmp/pip-kAwipY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:05 INFO - Running setup.py (path:/tmp/pip-7tgzbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:05 INFO - Running setup.py (path:/tmp/pip-PdlCRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:05 INFO - Running setup.py (path:/tmp/pip-TQ5dI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:05 INFO - Running setup.py (path:/tmp/pip-rhlndE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:05 INFO - Running setup.py (path:/tmp/pip-i5tPDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:05 INFO - Running setup.py (path:/tmp/pip-e8mJ9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:05 INFO - Running setup.py (path:/tmp/pip-c50i0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:05 INFO - Running setup.py (path:/tmp/pip-k9q0Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:05 INFO - Running setup.py (path:/tmp/pip-dnF_IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:05 INFO - Running setup.py (path:/tmp/pip-lhbNVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:27:05 INFO - Running setup.py install for manifestparser 17:27:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:27:05 INFO - Running setup.py install for mozcrash 17:27:06 INFO - Running setup.py install for mozdebug 17:27:06 INFO - Running setup.py install for mozdevice 17:27:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Running setup.py install for mozfile 17:27:06 INFO - Running setup.py install for mozhttpd 17:27:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Running setup.py install for mozinfo 17:27:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Running setup.py install for mozInstall 17:27:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Running setup.py install for mozleak 17:27:06 INFO - Running setup.py install for mozlog 17:27:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Running setup.py install for moznetwork 17:27:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:27:06 INFO - Running setup.py install for mozprocess 17:27:07 INFO - Running setup.py install for mozprofile 17:27:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:27:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:27:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:27:07 INFO - Running setup.py install for mozrunner 17:27:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:27:07 INFO - Running setup.py install for mozscreenshot 17:27:07 INFO - Running setup.py install for moztest 17:27:07 INFO - Running setup.py install for mozversion 17:27:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:27:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:27:07 INFO - Cleaning up... 17:27:07 INFO - Return code: 0 17:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:07 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')]} 17:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:07 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')]} 17:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:07 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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:27:07 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 17:27:07 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 17:27:07 INFO - Using env: {'DISPLAY': ':0', 17:27:07 INFO - 'HOME': '/home/cltbld', 17:27:07 INFO - 'LANG': 'en_US.UTF-8', 17:27:07 INFO - 'LANGUAGE': 'en_US:en', 17:27:07 INFO - 'LOGNAME': 'cltbld', 17:27:07 INFO - 'MAIL': '/var/mail/cltbld', 17:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:07 INFO - 'MOZ_NO_REMOTE': '1', 17:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:07 INFO - 'NO_EM_RESTART': '1', 17:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:07 INFO - 'PWD': '/builds/slave/test', 17:27:07 INFO - 'SHELL': '/bin/bash', 17:27:07 INFO - 'SHLVL': '1', 17:27:07 INFO - 'TERM': 'linux', 17:27:07 INFO - 'TMOUT': '86400', 17:27:07 INFO - 'USER': 'cltbld', 17:27:07 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:07 INFO - '_': '/tools/buildbot/bin/python'} 17:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:07 INFO - Running setup.py (path:/tmp/pip-CrQXld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:07 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)) 17:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:07 INFO - Running setup.py (path:/tmp/pip-mSNEsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:07 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)) 17:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:07 INFO - Running setup.py (path:/tmp/pip-wuopoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:08 INFO - Running setup.py (path:/tmp/pip-A5LzHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:08 INFO - Running setup.py (path:/tmp/pip-9aLzKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:08 INFO - Running setup.py (path:/tmp/pip-FcHCwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:08 INFO - Running setup.py (path:/tmp/pip-ZT6xhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:08 INFO - Running setup.py (path:/tmp/pip-oWQ8YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:08 INFO - Running setup.py (path:/tmp/pip-hOsHo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:08 INFO - Running setup.py (path:/tmp/pip-IfXAH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:08 INFO - Running setup.py (path:/tmp/pip-OILwGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:08 INFO - Running setup.py (path:/tmp/pip-i6irtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:08 INFO - Running setup.py (path:/tmp/pip-_Bwnhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:08 INFO - Running setup.py (path:/tmp/pip-9QifIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:08 INFO - Running setup.py (path:/tmp/pip-vSgj2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:08 INFO - Running setup.py (path:/tmp/pip-W_xk0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:08 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)) 17:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:08 INFO - Running setup.py (path:/tmp/pip-9jgzd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:09 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)) 17:27:09 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)) 17:27:09 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)) 17:27:09 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)) 17:27:09 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)) 17:27:09 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)) 17:27:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:10 INFO - Downloading blessings-1.6.tar.gz 17:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:10 INFO - Installing collected packages: blessings 17:27:10 INFO - Running setup.py install for blessings 17:27:11 INFO - Successfully installed blessings 17:27:11 INFO - Cleaning up... 17:27:11 INFO - Return code: 0 17:27:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:11 INFO - Reading from file tmpfile_stdout 17:27:11 INFO - Current package versions: 17:27:11 INFO - argparse == 1.2.1 17:27:11 INFO - blessings == 1.6 17:27:11 INFO - blobuploader == 1.2.4 17:27:11 INFO - docopt == 0.6.1 17:27:11 INFO - manifestparser == 1.1 17:27:11 INFO - mozInstall == 1.12 17:27:11 INFO - mozcrash == 0.17 17:27:11 INFO - mozdebug == 0.1 17:27:11 INFO - mozdevice == 0.48 17:27:11 INFO - mozfile == 1.2 17:27:11 INFO - mozhttpd == 0.7 17:27:11 INFO - mozinfo == 0.9 17:27:11 INFO - mozleak == 0.1 17:27:11 INFO - mozlog == 3.1 17:27:11 INFO - moznetwork == 0.27 17:27:11 INFO - mozprocess == 0.22 17:27:11 INFO - mozprofile == 0.28 17:27:11 INFO - mozrunner == 6.11 17:27:11 INFO - mozscreenshot == 0.1 17:27:11 INFO - mozsystemmonitor == 0.0 17:27:11 INFO - moztest == 0.7 17:27:11 INFO - mozversion == 1.4 17:27:11 INFO - psutil == 3.1.1 17:27:11 INFO - requests == 1.2.3 17:27:11 INFO - wsgiref == 0.1.2 17:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:11 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')]} 17:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:11 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')]} 17:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:11 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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:27:11 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 17:27:11 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 17:27:11 INFO - Using env: {'DISPLAY': ':0', 17:27:11 INFO - 'HOME': '/home/cltbld', 17:27:11 INFO - 'LANG': 'en_US.UTF-8', 17:27:11 INFO - 'LANGUAGE': 'en_US:en', 17:27:11 INFO - 'LOGNAME': 'cltbld', 17:27:11 INFO - 'MAIL': '/var/mail/cltbld', 17:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:11 INFO - 'MOZ_NO_REMOTE': '1', 17:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:11 INFO - 'NO_EM_RESTART': '1', 17:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:11 INFO - 'PWD': '/builds/slave/test', 17:27:11 INFO - 'SHELL': '/bin/bash', 17:27:11 INFO - 'SHLVL': '1', 17:27:11 INFO - 'TERM': 'linux', 17:27:11 INFO - 'TMOUT': '86400', 17:27:11 INFO - 'USER': 'cltbld', 17:27:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:11 INFO - '_': '/tools/buildbot/bin/python'} 17:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 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)) 17:27:11 INFO - Cleaning up... 17:27:11 INFO - Return code: 0 17:27:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:11 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')]} 17:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:11 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')]} 17:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:11 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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:27:11 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 17:27:11 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 17:27:11 INFO - Using env: {'DISPLAY': ':0', 17:27:11 INFO - 'HOME': '/home/cltbld', 17:27:11 INFO - 'LANG': 'en_US.UTF-8', 17:27:11 INFO - 'LANGUAGE': 'en_US:en', 17:27:11 INFO - 'LOGNAME': 'cltbld', 17:27:11 INFO - 'MAIL': '/var/mail/cltbld', 17:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:11 INFO - 'MOZ_NO_REMOTE': '1', 17:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:11 INFO - 'NO_EM_RESTART': '1', 17:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:11 INFO - 'PWD': '/builds/slave/test', 17:27:11 INFO - 'SHELL': '/bin/bash', 17:27:11 INFO - 'SHLVL': '1', 17:27:11 INFO - 'TERM': 'linux', 17:27:11 INFO - 'TMOUT': '86400', 17:27:11 INFO - 'USER': 'cltbld', 17:27:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:11 INFO - '_': '/tools/buildbot/bin/python'} 17:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:11 INFO - Downloading/unpacking jsonschema 17:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:27:13 INFO - Downloading/unpacking functools32 (from jsonschema) 17:27:13 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 17:27:13 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 17:27:13 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 17:27:13 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 17:27:13 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 17:27:13 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 17:27:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:27:13 INFO - warning: no files found matching '*.txt' 17:27:13 INFO - no previously-included directories found matching 'build' 17:27:13 INFO - no previously-included directories found matching 'dist' 17:27:13 INFO - no previously-included directories found matching '.git*' 17:27:13 INFO - Installing collected packages: jsonschema, functools32 17:27:14 INFO - Running setup.py install for functools32 17:27:14 INFO - warning: no files found matching '*.txt' 17:27:14 INFO - no previously-included directories found matching 'build' 17:27:14 INFO - no previously-included directories found matching 'dist' 17:27:14 INFO - no previously-included directories found matching '.git*' 17:27:14 INFO - Successfully installed jsonschema functools32 17:27:14 INFO - Cleaning up... 17:27:14 INFO - Return code: 0 17:27:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:27: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')]} 17:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27: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')]} 17:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:14 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 0x7f788b00df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', '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 17:27:14 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 17:27:14 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 17:27:14 INFO - Using env: {'DISPLAY': ':0', 17:27:14 INFO - 'HOME': '/home/cltbld', 17:27:14 INFO - 'LANG': 'en_US.UTF-8', 17:27:14 INFO - 'LANGUAGE': 'en_US:en', 17:27:14 INFO - 'LOGNAME': 'cltbld', 17:27:14 INFO - 'MAIL': '/var/mail/cltbld', 17:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:14 INFO - 'MOZ_NO_REMOTE': '1', 17:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:14 INFO - 'NO_EM_RESTART': '1', 17:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:14 INFO - 'PWD': '/builds/slave/test', 17:27:14 INFO - 'SHELL': '/bin/bash', 17:27:14 INFO - 'SHLVL': '1', 17:27:14 INFO - 'TERM': 'linux', 17:27:14 INFO - 'TMOUT': '86400', 17:27:14 INFO - 'USER': 'cltbld', 17:27:14 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:14 INFO - '_': '/tools/buildbot/bin/python'} 17:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:14 INFO - Downloading/unpacking flake8 17:27:14 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 17:27:14 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 17:27:14 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 17:27:14 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 17:27:14 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 17:27:14 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 17:27:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:27:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:27:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 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 17:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:27:16 INFO - no previously-included directories found matching 'docs/_build' 17:27:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:27:17 INFO - Running setup.py install for pep8 17:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:27:17 INFO - no previously-included directories found matching 'docs/_build' 17:27:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:27:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:27:17 INFO - Cleaning up... 17:27:17 INFO - Return code: 0 17:27:17 INFO - Running post-action listener: _resource_record_post_action 17:27:17 INFO - Running post-action listener: _start_resource_monitoring 17:27:17 INFO - Starting resource monitoring. 17:27:17 INFO - ##### 17:27:17 INFO - ##### Running install step. 17:27:17 INFO - ##### 17:27:17 INFO - Running pre-action listener: _resource_record_pre_action 17:27:17 INFO - Running main action method: install 17:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:17 INFO - Reading from file tmpfile_stdout 17:27:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:17 INFO - Reading from file tmpfile_stdout 17:27:17 INFO - Output received: 17:27:17 INFO - Usage: mozinstall [options] installer 17:27:17 INFO - Options: 17:27:17 INFO - -h, --help show this help message and exit 17:27:17 INFO - -d DEST, --destination=DEST 17:27:17 INFO - Directory to install application into. [default: 17:27:17 INFO - "/builds/slave/test"] 17:27:17 INFO - --app=APP Application being installed. [default: firefox] 17:27:17 INFO - mkdir: /builds/slave/test/build/application 17:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:27:30 INFO - Reading from file tmpfile_stdout 17:27:30 INFO - Output received: 17:27:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:27:30 INFO - Running post-action listener: _resource_record_post_action 17:27:30 INFO - ##### 17:27:30 INFO - ##### Running run-tests step. 17:27:30 INFO - ##### 17:27:30 INFO - Running pre-action listener: _resource_record_pre_action 17:27:30 INFO - Running main action method: run_tests 17:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:30 INFO - Python 2.7.3 17:27:30 INFO - Return code: 0 17:27:30 INFO - grabbing minidump binary from tooltool 17:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:30 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 0x135a160>, '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 0x135b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135b4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:30 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 17:27:30 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 17:27:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:30 INFO - Return code: 0 17:27:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:27:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:27:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:27:31 INFO - Return code: 0 17:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:27:31 INFO - Using env: {'DISPLAY': ':0', 17:27:31 INFO - 'HOME': '/home/cltbld', 17:27:31 INFO - 'LANG': 'en_US.UTF-8', 17:27:31 INFO - 'LANGUAGE': 'en_US:en', 17:27:31 INFO - 'LOGNAME': 'cltbld', 17:27:31 INFO - 'MAIL': '/var/mail/cltbld', 17:27:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:31 INFO - 'MOZ_NO_REMOTE': '1', 17:27:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:31 INFO - 'NO_EM_RESTART': '1', 17:27:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:31 INFO - 'PWD': '/builds/slave/test', 17:27:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:31 INFO - 'SHELL': '/bin/bash', 17:27:31 INFO - 'SHLVL': '1', 17:27:31 INFO - 'TERM': 'linux', 17:27:31 INFO - 'TMOUT': '86400', 17:27:31 INFO - 'USER': 'cltbld', 17:27:31 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514', 17:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:31 INFO - '_': '/tools/buildbot/bin/python'} 17:27:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:27:31 INFO - mozversion application_buildid: 20160504143046 17:27:31 INFO - mozversion application_changeset: 360e0a95af6f0744dbbb84ebcd9cd585893465a4 17:27:31 INFO - mozversion application_display_name: Firefox 17:27:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:31 INFO - mozversion application_name: Firefox 17:27:31 INFO - mozversion application_remotingname: firefox 17:27:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:27:31 INFO - mozversion application_vendor: Mozilla 17:27:31 INFO - mozversion application_version: 47.0 17:27:31 INFO - mozversion platform_buildid: 20160504143046 17:27:31 INFO - mozversion platform_changeset: 360e0a95af6f0744dbbb84ebcd9cd585893465a4 17:27:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:27:31 INFO - mozversion platform_version: 47.0 17:27:31 INFO - using testdate: 1462408051 17:27:31 INFO - actual date: 1462408051 17:27:31 INFO - starting webserver on 'localhost:58613' 17:27:31 INFO - SUITE-START | Running 2 tests 17:27:31 INFO - TEST-START | dromaeo_css 17:27:31 INFO - operating with platform_type : linux_ 17:27:31 INFO - Initialising browser for dromaeo_css test... 17:27:31 INFO - TEST-INFO | started process 3524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJM8fNF/profile http://localhost:58613/getInfo.html) 17:27:36 INFO - PROCESS | 3524 | __metrics Screen width/height:1600/1200 17:27:36 INFO - PROCESS | 3524 | colorDepth:24 17:27:36 INFO - PROCESS | 3524 | Browser inner width/height: 1024/697 17:27:36 INFO - PROCESS | 3524 | __metrics 17:27:37 INFO - PROCESS | 3524 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:38 INFO - TEST-INFO | 3524: exit 0 17:27:38 INFO - Browser initialized. 17:27:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:38 INFO - TEST-INFO | started process 3614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJM8fNF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:50 INFO - PROCESS | 3614 | RSS: Main: 138846208 17:27:50 INFO - PROCESS | 3614 | 17:28:40 INFO - PROCESS | 3614 | 1462408120932 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] 17:30:49 INFO - PROCESS | 3614 | Cycle 1(1): loaded http://localhost:58613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58613/tests/dromaeo/cssquery-ext.html) 17:30:50 INFO - PROCESS | 3614 | RSS: Main: 253792256 17:30:50 INFO - PROCESS | 3614 | 17:33:52 INFO - PROCESS | 3614 | Cycle 1(1): loaded http://localhost:58613/tests/dromaeo/cssquery-ext.html (next: http://localhost:58613/tests/dromaeo/cssquery-jquery.html) 17:33:52 INFO - PROCESS | 3614 | RSS: Main: 222781440 17:33:52 INFO - PROCESS | 3614 | 17:36:54 INFO - PROCESS | 3614 | Cycle 1(1): loaded http://localhost:58613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58613/tests/dromaeo/cssquery-mootools.html) 17:36:55 INFO - PROCESS | 3614 | RSS: Main: 222916608 17:36:55 INFO - PROCESS | 3614 | 17:39:57 INFO - PROCESS | 3614 | Cycle 1(1): loaded http://localhost:58613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58613/tests/dromaeo/cssquery-prototype.html) 17:39:57 INFO - PROCESS | 3614 | RSS: Main: 210092032 17:39:57 INFO - PROCESS | 3614 | 17:42:59 INFO - PROCESS | 3614 | Cycle 1(1): loaded http://localhost:58613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58613/tests/dromaeo/cssquery-yui.html) 17:43:00 INFO - PROCESS | 3614 | RSS: Main: 210477056 17:43:00 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | Cycle 1(1): loaded http://localhost:58613/tests/dromaeo/cssquery-yui.html (next: http://localhost:58613/tests/dromaeo/cssquery-dojo.html) 17:46:02 INFO - PROCESS | 3614 | RSS: Main: 260288512 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | __start_tp_report 17:46:02 INFO - PROCESS | 3614 | _x_x_mozilla_page_load 17:46:02 INFO - PROCESS | 3614 | _x_x_mozilla_page_load_details 17:46:02 INFO - PROCESS | 3614 | |i|pagename|runs| 17:46:02 INFO - PROCESS | 3614 | |0;dojo.html;3287.819169945653;3361.5461912641786;3374.0215337552113;3381.5265862779215;3419.2648580555174;5469.097598896177;5470.425605311445;5481.12302031675;5496.963886225638;5512.283403157584;5478.424765399635;5493.697846618435;5518.751656175472;5520.171974203871;5521;4952.331435256248;4985.302057711914;5005.949940500603;5069.467705890884;5086.77109530072;4926.162552366106;5038.294638750578;5110.872228194287;5196.480351964792;5205.063088644042;5091.1854103343285;5107.974460127694;5116.539511443969;5123.641345105844;5144.125498665236;4946.629002824802;5014.272930425104;5036.395632524084;5045.167547354682;5098.362704661918;4990.950090499085;5008.649394542384;5009.398872135331;5013.5989120870245;5039.496050394968;5363.54409875161;5363.785448582091;5366.731663416853;5375;5418.349798024262;5711.171880077365;5803.245578074823;5916.112583112525;5921.43746344101;5927.110933359987;6052.394760523913;6055.7274922628585;6056.152138700585;6082.726277317532;6093.268807743055;5639.2668953036255;5645.802396916089;5646.322441307028;5660.688662123582;5688;5958.076498142795;6021.608595441282;6091.405965851069;6130.448259656652;6151.753929842756;5870.823875283749;5878.823635290948;5879.970600147058;5881.441263080001;5886.381929897299;5919.993601087739;5965.164876917235;5970.104484327386;5970.58205925581;5984.222051133412;5706.343770466449;5853.180554722342;5940.762369505172;5965.343812180657;5980.55145864062;5864.2083318752275;5897.026990546512;5901.262342207224;5903.203067585821;5912.231409916683;4447.266201076851;4509.413776209072;4513.458384993822;4515.209838278288;4551.45382554089;4003.799810009488;4049.230646177217;4063.593640635972;4065.6950728695465;4090.1615168890307;5603.719814009365;5607.243022192033;5609.915851262234;5610.579206559524;5610.961972035187;5860.501857342174;5930.021546444875;5990;6000.33996260411;6003.519718422603;5501.5323697486165;5546.944530554723;5564.721763911788;5567.3040869891265;5591.692456914909;5085.186370180827;5088.745562721849;5089.51649593288;5093.134167191586;5126.538611524906;6081.908771368433;6088.817335480031;6089.451949324582;6097.725602347905;6098.451139397475;5959.374265702212;5959.851003724942;5960;5973.49225315853;5979.222701048836;6010.248718910137;6056;6061.878762424639;6072.14989901423;6098.9390106100145;5746.310442746897;5795.710214489343;5847.06446968483;5858.5898987070495;5871.031279838779;5922.763089476372;5964.880702385841;5965.135055417027;5983.760649573968;6002.159697642421;5823.7379317929945;5825.3883342248455;5826.184334193132;5829.300483941955;5830.329512105993;5697.7436015380235;5701.258836351248;5778.682172480386;5809.215755872903;5813.680247586423;5691.857703557444;5704.80033198836;5707.372189059283;5707.942920570741;5717.799877004285;5793.507551858139;5818.127280907897;5819.970900145472;5823;5828.562857785768;5588.469095435927;5622.5783066271015;5709.771609135588;5728.455796699307;5739.139129130497 17:46:02 INFO - PROCESS | 3614 | |1;ext.html;540.0791650236346;556.5936866087753;563.6871536297358;574.0041028815008;597.1818608506345;38701.80649096754;39210.03949802513;39234.411483827695;39290;39374.409383859194;42671;42888.14223715524;43096.78451607737;43350.132997340115;43371;9008.68469603564;9187.127222913847;9189.035151309117;9190.172884440399;9191.678291259806;8968.148025937558;9079.636814527412;9099.772505687344;9104.408213466104;9107.590158442887;9101.044390339019;9163.862542061874;9167.312451566158;9185.219256363183;9185.770355741126;8994.595243214038;9048.547572621343;9059.184673379428;9069.818603627924;9070.319726020509;8955.865662015074;9090.090990900922;9090.50002249876;9092;9096.77258068547;41231.1753764926;41477.792611036755;41514.1697166058;41592.1681566367;41715.791421043;3564.750467467278;3644.890653280406;3759.887203383903;3800.8289626966853;4300.591443812864;28920.132396027944;29239.415211695647;29361.706382936325;29394.853025734734;30221.395572088655;4160.979195104035;4209.221294060609;4243.936340954888;4315.8057887394825;4346.826126954918;236488;237268;238868;239240;239576;46149;60353;60389.69805150946;60742;60761.69619151876;44054.779726101166;44163.55836441659;44226.55773442225;44337.556624433986;44362.11275774467;15424.922875385551;15661;15745.425457454392;15748.448804291795;15757.212139392985;12493;12570.622881313393;12577.93711031439;12582.307973061386;12584.433700483318;14982.700345993018;15112.319945602254;15116.773248401283;15122.621934451727;15362.846371536365;5792.304923409218;6023.66869822164;6028.306744724325;6069.544784141207;6125.785597504066;985.5367977050774;997;1009.7677534167036;1033.0495943731785;1084.3764835219781;29975.700242997726;30308.84845575758;30525.542116868266;30947;31316.53025204624;1128.6162704680285;1148.1446322489633;1183.1836033137108;1193.4510125342267;1212.1878341511208;15525.301361438536;15738.370465181264;15884.52346429609;16082.356705731874;16170.838291617169;343225;345439;346095;346568;347433;55748.44251557432;56342.71828640831;56407.43592564022;56542;56572.43427565671;1349.959501214965;1438.4246301479493;1439.0933711761732;1488.3600051977753;1493.6489924867647;28120;30333.696663033086;30455.543166852072;30531.694683052887;31172.220694482818;45781.54218457773;45876.31185532286;46157.30764038609;46240.30639540477;46246;242463;243745;244436;245231;303872;34528;34896.82551587226;35124;35222.8238858804;35491.467627986116;41502.584974149875;41818;42078.36882446827;42569.148617028106;50695.2395714072;36806.815965919996;37065.258694826494;37285.81357093197;37526.62473375232;37745.81127094347;36982.8150859244;37839.62160378471;38766.80616597012;39657.40513892352;39727.60272397239;39445.60554394419;40115.398269025405;40176.99557511086;40246.79876600598;40344.19311613693;33919.321613567095;34998;35223.47164792581;35605.590993621394;35858.46212306766;26590.7340926596;26790.59814102751;26976.595351069358;26998;27089.1873243803 17:46:02 INFO - PROCESS | 3614 | |2;jquery.html;360.9368360536905;375.2064383828204;378.0661765439365;384.27947598253274;384.51273636660176;17330.91334543327;17414.912925435372;18120.81879181208;18127.72808407875;18173.454796356098;16953.3218671253;17524.82475175251;17733.911330443363;17783.28866845328;17788.110594470258;5403.135498320269;5574.526165275936;5603.495685388314;5609.635373700697;5612.719364031782;4297.484301883778;5508.944910550883;5962.463378295953;6198.566100372976;6222.595531290474;6190.628562286277;6191.102290167923;6198.287196972338;6214.440700336969;6216.160818289541;5926.199963004982;6253.656048917308;6260.092286618437;6264.561480696353;6267.780627678032;3875.2830726315724;5260.500252476047;5425.565954723613;5450;5463.562914966793;21145.894270528705;21382.465438364008;21405.46486337854;21784.891075544678;21842.563148737096;2362.7519110493495;2409.7831195192343;2419.0807493152665;2449.8040156787592;2574.768270855613;12769.680757981125;13452.79820802679;13616;13650.93174534121;13992.93003534986;1884.4817675139445;1912.550550620603;1932.5555122321944;1946.2701486942397;1952.8535359848067;55450.72274638641;57071.42928570744;57233.71383143058;57752.71123644397;58631.70684146552;9563.09150630689;9847.75380615476;10426.061654451136;10437.582496700199;10641.5211315491;14187.14877107377;14296.785548216785;14298.499552515612;14312.713745725236;14314.212718300385;7381.261873812576;7594.544327340377;7667.156612772591;7740.187280335596;7764.22357764219;7224.819379515449;7269.89095163573;7299.41604671625;7312.866505691626;7356.889646655304;4520.547945205453;4544.2047641662575;4567.9086418271445;4637.582617564435;4653.813847446064;1769.5929936114765;1832.2121487760392;1848.2329833119375;1930.835878950305;1932.8550358723153;726.7165805335924;978.4716253223322;1022.2858311183819;1024.8462730590322;1029.7528593137592;16594.6681066378;16906.154692265336;17197.57006074833;17339.306427742747;17445.7383139253;962.3696478806393;987.4717026390847;1025.0569476082023;1049.165913099073;1058.9470526473644;9745.366551174151;9796;9841.704748857546;9861.753456163653;10052.296339256329;351543;448133;471843;475501;475517;73672.63163684147;82104;84237.57881210555;85506;86660.13339866647;1039.9116075133547;1053.9051485366354;1055.778286559831;1056.857324261215;1089.7275681079889;15398.769018464507;15441;15555.844441555892;15639.530814075595;15680.764788527953;33663.495047573815;34464.483032754026;36175.81912090423;36720.449193261586;37422.8128859354;51268.23097653613;51347.74326128345;51477;51984.220236697234;52341.7382913083;8412;8445.071042185478;8446.873296900429;8459.619317130868;8544.35917306217;12258.938705306417;12399.442025109072;12406.317652528836;12757;12780.36098195068;10646.520906559068;10664.733381665521;11061.889381106086;11167.720806979565;11338.886611134112;11053.226274160732;11193.72015699614;11249.943750281196;11332.546698131982;11433.742288348441;11183.832242516206;11422.885771142182;11546.653600392001;11628.18602697803;11671.241369311307;8391.622376993171;8470.830583388175;8591.097934716765;8650.653973840976;8735.91264087351;10299.588016479556;11461.942690286494;11511.884881151082;11544.134189935956;11573.594924177612 17:46:02 INFO - PROCESS | 3614 | |3;mootools.html;1480.8815294776418;1586.5795564175492;1609.1954022988502;1852.7128295114253;1963.6072785442907;8250.587470626468;8461.53461559614;8503.574821258935;8510.531920744357;8554.657813687461;8060;8192.54940978246;8207.261346478816;8211.91788082119;8213.13762054983;2417.238569850496;2439.4511234972165;2441.8046556275453;2462.347477918353;2463.2979600813774;2425.3087869957067;2435.9878200608973;2479.1446950802033;2499.0503608628787;2501.199616122832;2436.902523899042;2440.1825388494785;2467.432490527171;2473.579491486452;2476.5666008448447;2372;2383.30884043628;2385.821063420242;2388.9880550597222;2408.3738228060656;2496.2885577610296;2497.1884137655334;2507.3480894967256;2508.109621084507;2536.8097392695436;8324.916750832535;8377.832443351099;8379.748607541784;8379.95810020946;8392.706255281037;5271.156614941629;5377.75800088993;5406.053940560426;5410.56715462766;5415.9458405415835;3199.23218427578;3249.2201871550656;3264.216588018858;3267.9183020424443;3338.8163650999186;1021.9284650074497;1036.9118624916891;1053.2258789789498;1053.7260312318776;1055.0346433013783;12251.754964900741;12271;12279.75440491194;12299.815502767466;12316.322602256962;4708.882277943078;4774.40319960005;4781.450133234653;4796.184648609675;4805.399325084364;10395.94802025985;10449;10452.634157804441;10481.266311358131;10481.633142839964;5435.456454354612;5468.097763868917;5469.890602187934;5471.671699698031;5473.397926228191;4335;4743.407074115736;4880.804767809319;4915.1644220481885;4955.950440495549;3952.26883026641;4002.8598999034893;4027.456293400412;4034.9798251008556;4126.216018956388;1277.8338815954053;1288.9484420623257;1293.5795866343476;1294.851092124399;1331.1414137881013;1201.0631707268344;1413.519403402848;1417.985820141806;1420.5809286260578;1445.8771004464738;7988.80027999293;8004.639791209293;8043.758687239392;8059.597020148969;8084.717034903751;1147.5753971030606;1173.0908545876844;1190.922590031645;1207.5592408770735;1231.7844377233948;6260.843478913063;6291.716872740738;6297.464715499143;6369.490440764727;6379.043143528415;10145.239107067;10480.528376222936;10481.213908956859;10498.947505262426;10505.422201778976;10121.493925303705;10282.485875706185;10327.793444131075;10330.638427654996;10367.94816025915;8188.549629770419;8316.501009939422;8358.414910956297;8409.32725381968;8414.78963025917;7822.295993360625;7825.256600622932;7877.094134174643;7893.329067029367;7929.960350198212;9472.431654100776;9473.857892131762;9563.282753793632;9578.13796758295;9693.079157480028;9591;9898.50507474609;9927.056929591678;9957.452340121074;10057.396556206651;6432.710528026344;6478.190226221723;6544.509161812978;7320.450966177665;7423.851522969619;8199.71301004462;8203.384746143944;8276.834463310579;8284.212999765012;8299.543525106177;7177;7246.565206087441;7272.709091636275;7309.195988441161;7364.815879603053;7232.63836808168;7232.891506627299;7272.490925635155;7353.70585176587;7375.409967202718;7607.4674772765375;7754.8449031017935;7766.456348055582;7774.844503110019;7884.093329266978;7111.359977602041;7112.146542414736;7130.643467826691;7145.892811607726;7170.533915295489;7204.675789589586;7338.229485903903;7341;7343.8531229376185;7362.852742945004 17:46:02 INFO - PROCESS | 3614 | |4;prototype.html;327.1135223544195;330.4695962979418;331.4464843711002;333.71300681413965;337.7686284894846;6008.759649614021;6057.636541807489;6076.331603523615;6102.084687296902;6104.847378815521;5946.43508866657;5949.196858424111;5952.821415357535;5971.761129554823;5996.700164991755;4413.293872980324;4524.140413321475;4605.976970115162;4627.768611569417;4677.672562920597;4666.4400271967415;4670.34615153877;4670.579647831694;4677.579017888389;4677.602403795681;4621.353010578522;4622.514635963209;4627.329037289591;4628.884277893063;4635.049814787961;4437.290033594625;4516.796744146505;4609.285560738091;4610.05493873755;4617;4033.173199494126;4036.2734707752593;4036.3138266494766;4037.7577345359373;4044.6157615026527;5774.220480235156;5785.971070144665;5792.362840087587;5795.565332600029;5801.6519008859605;5387.326584176978;5391.919121213185;5393.406725260218;5394.676319420847;5400.432954539795;6402.455791257702;6419.454346380563;6419.871602567922;6420;6422.935770642281;4395.560443955611;4505.5269196734525;4507.752073635948;4512.796924138422;4527.977360113178;6603.3396660334065;6655.866882662368;6659.034440006172;6676.13210282665;6689.431398331099;4535.523770004102;4566.13243483737;4573.428321459817;4575.24508456101;4576.313552967082;4624.838130665478;4629;4630.259158534685;4631.745254010994;4632.490426053131;5324.227986941949;5345.1714984177515;5353.036453438419;5355.30381050461;5360.0351936650995;6309.842253943596;6415.582987105823;6450.451711604566;6451.903221451682;6473.320301368289;1614.1525699008114;1625.7723918651398;1626.2844348486628;1626.5201765479212;1626.544567521096;1045.3675526306627;1086.940218287986;1092.546593163844;1095.3263742798122;1106.6956586938657;6118.969405152946;6152.138700581922;6172.629642221481;6173.59871608344;6184.288806787187;6611.570247933869;6615.933840661628;6623.668816559153;6625.370589794058;6630.204375474974;6087.178230938855;6140.785072522441;6141.815745527641;6154.3845615438995;6158.1686472326555;3544.3620148373025;3550.1657110578994;3570.8571657133944;3583.122135076923;3590.9461358079648;6664.866702666017;6683.933160668331;6750.35871592198;6804.591724496447;6806.4554835613035;6714.832129196711;6717.865642687118;6718.193816742022;6734.124563806772;6755.1556055493065;6770.086038384854;6785.8642827143185;6788.151481064867;6795.728170873209;6797.456203503708;6619.569727967667;6643.202815662152;6673.733050677918;6685.2646208916;6688.866222675617;6446.29090800021;6467.773627923;6479.546431749733;6607.075009498578;6614.272430032789;6843.931560684528;6855.931440685728;6893.827654308482;6897.689603967733;6906.723731050702;4623.88440288982;4645.721256724607;4658;4659.2312268475325;4664.580187783115;6651.06885036105;6702.832429189114;6702.83242918931;6703.430208432338;6710.63091529951;6398.584092034003;6509.837254068686;6525.314841941527;6531.281559028408;6537;6496.7726129585235;6521.087047813405;6530.542861999615;6535.4444872184495;6536.803895883131;6359.20509936258;6360.77737279193;6361.491080713439;6362.109304697254;6368.936310636835;6558.442532384801;6573.868522629617;6591.934080659324;6627.204735431779;6629.270780214269;6129;6135.171751813448;6215.471684906653;6274.560780745304;6309.905351419824 17:46:02 INFO - PROCESS | 3614 | |5;yui.html;766.1840140250632;780.3978343216389;832.2052439919877;840.6637345061971;891.964321427143;14441.49454769082;14554.19951902645;14613.415463381452;14627.488037918674;14632.195229262386;13772.517961871337;13830.723385532283;13868.029237953348;13869.861301386984;13887.652808679788;742.3022358982566;903.5075883643398;905.1175104273347;924.3113880159291;926.5922993882704;916.7478943290615;921.5392303848076;924.944503329799;924.958376873039;926.0554234680656;964.9662261820838;972.1930797438145;973.1971123822839;973.2214228617113;973.2992245583168;785.3442375616339;950.6387572722356;963.2149797914747;963.2727290895364;964.5177411294353;716.9390601798854;717.8205448637841;717.8384863405744;718.529363267061;718.5724493926106;13821.239831809247;13911.095778774448;13930.37313320903;13932.164070155823;13934.372953217027;13779.517716879962;14397.280135993264;14489.203093829836;14492.058016228912;14760.040597361138;10919.344839309588;11021.504032318566;11029.44852757359;11183.888161118366;11220.326780393203;3901.9804900975314;3924.7448915820664;3952.802359882023;3958.6833053355663;3999.8600048998437;50806.74596626993;50863;51856.740716296554;51941.22088168681;52077.218841717404;10112.342697724624;10212.183025357954;10383.065524102867;10409.323393979366;10479.266451348332;19197;19226.230950762092;20148.194072236947;21099.78900211009;21199.894000530207;7953.920460795433;8034.437589368805;8053.476524025919;8074.192580741878;8419.873701894476;4603.539646035437;4736.8578942631775;4763.857084287408;4810.470848206694;4868.367112275452;3337.349216902681;3357.1103657530775;3368.6631336866117;3371.258323168899;3379.847906844198;549.370970239074;569.9031164701928;593.2613895699882;641.6791604197902;668.5520701130255;570.3554982869331;618.5268269773627;665.1120753793643;715.1882613234017;717.4511498703496;7577.431692623075;7656.464047516621;7820.139784623687;7947.761567152995;8227.54748488827;620.7503718036078;622.5019984012772;664.6444152378455;672.3814091036259;684.5584597934304;3816.4466152407745;3839.884803455901;3981.7810020448574;3987.5414327352146;4016.6184212499766;59248.111278330856;60407;60692.96535173224;61105;61292;51220;52345;52706.73646631742;52920.73539632277;54623;45908;46083.847903802;46845.297320540216;47060.52939470561;48079.038419231416;7665.080190377191;7715;7806.102298235775;7819.530828150329;7915.010623672041;35939.46090808588;36395.45406818953;36939.44590831086;37039.81480092582;38114;41875.7906210467;44019.55980440155;45047;45533.772331138134;45933.77033114813;10574;10713.678589642323;10748.838767418338;10793.19051071157;11155.553777848796;10703.518341674799;10876.12990960737;10925.945370273097;11019.779604408028;12096.75806483883;10004.599816007569;10078.496075196357;10078.596856125967;10130.392176469435;10273.9486302568;11054.944725276322;11128.666140015812;11160.497777599865;11268.492917818554;11400.258983166068;9975.700728978143;10410;10440.008199221062;10469.110125639407;10592.470376481298;8863.556822158995;8891.688790892547;8968.237699795329;9338.626454941726;9396.95301523488;8705.782355441164;9055;9157.633694652139;9180.311476639412;9371.250299975849 17:46:02 INFO - PROCESS | 3614 | __end_tp_report 17:46:02 INFO - PROCESS | 3614 | __start_cc_report 17:46:02 INFO - PROCESS | 3614 | _x_x_mozilla_cycle_collect,902 17:46:02 INFO - PROCESS | 3614 | __end_cc_report 17:46:02 INFO - PROCESS | 3614 | __startTimestamp1462409162847__endTimestamp 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | ------- Summary: start ------- 17:46:02 INFO - PROCESS | 3614 | Number of tests: 6 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | [#0] dojo.html Cycles:165 Average:5507.84 Median:5707.37 stddev:607.68 (10.6%) stddev-sans-first:584.05 17:46:02 INFO - PROCESS | 3614 | Values: 3287.8 3361.5 3374.0 3381.5 3419.3 5469.1 5470.4 5481.1 5497.0 5512.3 5478.4 5493.7 5518.8 5520.2 5521.0 4952.3 4985.3 5005.9 5069.5 5086.8 4926.2 5038.3 5110.9 5196.5 5205.1 5091.2 5108.0 5116.5 5123.6 5144.1 4946.6 5014.3 5036.4 5045.2 5098.4 4991.0 5008.6 5009.4 5013.6 5039.5 5363.5 5363.8 5366.7 5375.0 5418.3 5711.2 5803.2 5916.1 5921.4 5927.1 6052.4 6055.7 6056.2 6082.7 6093.3 5639.3 5645.8 5646.3 5660.7 5688.0 5958.1 6021.6 6091.4 6130.4 6151.8 5870.8 5878.8 5880.0 5881.4 5886.4 5920.0 5965.2 5970.1 5970.6 5984.2 5706.3 5853.2 5940.8 5965.3 5980.6 5864.2 5897.0 5901.3 5903.2 5912.2 4447.3 4509.4 4513.5 4515.2 4551.5 4003.8 4049.2 4063.6 4065.7 4090.2 5603.7 5607.2 5609.9 5610.6 5611.0 5860.5 5930.0 5990.0 6000.3 6003.5 5501.5 5546.9 5564.7 5567.3 5591.7 5085.2 5088.7 5089.5 5093.1 5126.5 6081.9 6088.8 6089.5 6097.7 6098.5 5959.4 5959.9 5960.0 5973.5 5979.2 6010.2 6056.0 6061.9 6072.1 6098.9 5746.3 5795.7 5847.1 5858.6 5871.0 5922.8 5964.9 5965.1 5983.8 6002.2 5823.7 5825.4 5826.2 5829.3 5830.3 5697.7 5701.3 5778.7 5809.2 5813.7 5691.9 5704.8 5707.4 5707.9 5717.8 5793.5 5818.1 5820.0 5823.0 5828.6 5588.5 5622.6 5709.8 5728.5 5739.1 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | [#1] ext.html Cycles:180 Average:45498.89 Median:38988.42 stddev:74235.90 (190.4%) stddev-sans-first:74367.40 17:46:02 INFO - PROCESS | 3614 | Values: 540.1 556.6 563.7 574.0 597.2 38701.8 39210.0 39234.4 39290.0 39374.4 42671.0 42888.1 43096.8 43350.1 43371.0 9008.7 9187.1 9189.0 9190.2 9191.7 8968.1 9079.6 9099.8 9104.4 9107.6 9101.0 9163.9 9167.3 9185.2 9185.8 8994.6 9048.5 9059.2 9069.8 9070.3 8955.9 9090.1 9090.5 9092.0 9096.8 41231.2 41477.8 41514.2 41592.2 41715.8 3564.8 3644.9 3759.9 3800.8 4300.6 28920.1 29239.4 29361.7 29394.9 30221.4 4161.0 4209.2 4243.9 4315.8 4346.8 236488.0 237268.0 238868.0 239240.0 239576.0 46149.0 60353.0 60389.7 60742.0 60761.7 44054.8 44163.6 44226.6 44337.6 44362.1 15424.9 15661.0 15745.4 15748.4 15757.2 12493.0 12570.6 12577.9 12582.3 12584.4 14982.7 15112.3 15116.8 15122.6 15362.8 5792.3 6023.7 6028.3 6069.5 6125.8 985.5 997.0 1009.8 1033.0 1084.4 29975.7 30308.8 30525.5 30947.0 31316.5 1128.6 1148.1 1183.2 1193.5 1212.2 15525.3 15738.4 15884.5 16082.4 16170.8 343225.0 345439.0 346095.0 346568.0 347433.0 55748.4 56342.7 56407.4 56542.0 56572.4 1350.0 1438.4 1439.1 1488.4 1493.6 28120.0 30333.7 30455.5 30531.7 31172.2 45781.5 45876.3 46157.3 46240.3 46246.0 242463.0 243745.0 244436.0 245231.0 303872.0 34528.0 34896.8 35124.0 35222.8 35491.5 41502.6 41818.0 42078.4 42569.1 50695.2 36806.8 37065.3 37285.8 37526.6 37745.8 36982.8 37839.6 38766.8 39657.4 39727.6 39445.6 40115.4 40177.0 40246.8 40344.2 33919.3 34998.0 35223.5 35605.6 35858.5 26590.7 26790.6 26976.6 26998.0 27089.2 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | [#2] jquery.html Cycles:180 Average:26147.04 Median:34063.99 stddev:73350.52 (215.3%) stddev-sans-first:73530.74 17:46:02 INFO - PROCESS | 3614 | Values: 360.9 375.2 378.1 384.3 384.5 17330.9 17414.9 18120.8 18127.7 18173.5 16953.3 17524.8 17733.9 17783.3 17788.1 5403.1 5574.5 5603.5 5609.6 5612.7 4297.5 5508.9 5962.5 6198.6 6222.6 6190.6 6191.1 6198.3 6214.4 6216.2 5926.2 6253.7 6260.1 6264.6 6267.8 3875.3 5260.5 5425.6 5450.0 5463.6 21145.9 21382.5 21405.5 21784.9 21842.6 2362.8 2409.8 2419.1 2449.8 2574.8 12769.7 13452.8 13616.0 13650.9 13992.9 1884.5 1912.6 1932.6 1946.3 1952.9 55450.7 57071.4 57233.7 57752.7 58631.7 9563.1 9847.8 10426.1 10437.6 10641.5 14187.1 14296.8 14298.5 14312.7 14314.2 7381.3 7594.5 7667.2 7740.2 7764.2 7224.8 7269.9 7299.4 7312.9 7356.9 4520.5 4544.2 4567.9 4637.6 4653.8 1769.6 1832.2 1848.2 1930.8 1932.9 726.7 978.5 1022.3 1024.8 1029.8 16594.7 16906.2 17197.6 17339.3 17445.7 962.4 987.5 1025.1 1049.2 1058.9 9745.4 9796.0 9841.7 9861.8 10052.3 351543.0 448133.0 471843.0 475501.0 475517.0 73672.6 82104.0 84237.6 85506.0 86660.1 1039.9 1053.9 1055.8 1056.9 1089.7 15398.8 15441.0 15555.8 15639.5 15680.8 33663.5 34464.5 36175.8 36720.4 37422.8 51268.2 51347.7 51477.0 51984.2 52341.7 8412.0 8445.1 8446.9 8459.6 8544.4 12258.9 12399.4 12406.3 12757.0 12780.4 10646.5 10664.7 11061.9 11167.7 11338.9 11053.2 11193.7 11249.9 11332.5 11433.7 11183.8 11422.9 11546.7 11628.2 11671.2 8391.6 8470.8 8591.1 8650.7 8735.9 10299.6 11461.9 11511.9 11544.1 11573.6 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | [#3] mootools.html Cycles:180 Average:6024.29 Median:5113.55 stddev:3161.30 (61.8%) stddev-sans-first:3151.72 17:46:02 INFO - PROCESS | 3614 | Values: 1480.9 1586.6 1609.2 1852.7 1963.6 8250.6 8461.5 8503.6 8510.5 8554.7 8060.0 8192.5 8207.3 8211.9 8213.1 2417.2 2439.5 2441.8 2462.3 2463.3 2425.3 2436.0 2479.1 2499.1 2501.2 2436.9 2440.2 2467.4 2473.6 2476.6 2372.0 2383.3 2385.8 2389.0 2408.4 2496.3 2497.2 2507.3 2508.1 2536.8 8324.9 8377.8 8379.7 8380.0 8392.7 5271.2 5377.8 5406.1 5410.6 5415.9 3199.2 3249.2 3264.2 3267.9 3338.8 1021.9 1036.9 1053.2 1053.7 1055.0 12251.8 12271.0 12279.8 12299.8 12316.3 4708.9 4774.4 4781.5 4796.2 4805.4 10395.9 10449.0 10452.6 10481.3 10481.6 5435.5 5468.1 5469.9 5471.7 5473.4 4335.0 4743.4 4880.8 4915.2 4956.0 3952.3 4002.9 4027.5 4035.0 4126.2 1277.8 1288.9 1293.6 1294.9 1331.1 1201.1 1413.5 1418.0 1420.6 1445.9 7988.8 8004.6 8043.8 8059.6 8084.7 1147.6 1173.1 1190.9 1207.6 1231.8 6260.8 6291.7 6297.5 6369.5 6379.0 10145.2 10480.5 10481.2 10498.9 10505.4 10121.5 10282.5 10327.8 10330.6 10367.9 8188.5 8316.5 8358.4 8409.3 8414.8 7822.3 7825.3 7877.1 7893.3 7930.0 9472.4 9473.9 9563.3 9578.1 9693.1 9591.0 9898.5 9927.1 9957.5 10057.4 6432.7 6478.2 6544.5 7320.5 7423.9 8199.7 8203.4 8276.8 8284.2 8299.5 7177.0 7246.6 7272.7 7309.2 7364.8 7232.6 7232.9 7272.5 7353.7 7375.4 7607.5 7754.8 7766.5 7774.8 7884.1 7111.4 7112.1 7130.6 7145.9 7170.5 7204.7 7338.2 7341.0 7343.9 7362.9 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | [#4] prototype.html Cycles:180 Average:5377.73 Median:6111.91 stddev:1619.46 (26.5%) stddev-sans-first:1579.02 17:46:02 INFO - PROCESS | 3614 | Values: 327.1 330.5 331.4 333.7 337.8 6008.8 6057.6 6076.3 6102.1 6104.8 5946.4 5949.2 5952.8 5971.8 5996.7 4413.3 4524.1 4606.0 4627.8 4677.7 4666.4 4670.3 4670.6 4677.6 4677.6 4621.4 4622.5 4627.3 4628.9 4635.0 4437.3 4516.8 4609.3 4610.1 4617.0 4033.2 4036.3 4036.3 4037.8 4044.6 5774.2 5786.0 5792.4 5795.6 5801.7 5387.3 5391.9 5393.4 5394.7 5400.4 6402.5 6419.5 6419.9 6420.0 6422.9 4395.6 4505.5 4507.8 4512.8 4528.0 6603.3 6655.9 6659.0 6676.1 6689.4 4535.5 4566.1 4573.4 4575.2 4576.3 4624.8 4629.0 4630.3 4631.7 4632.5 5324.2 5345.2 5353.0 5355.3 5360.0 6309.8 6415.6 6450.5 6451.9 6473.3 1614.2 1625.8 1626.3 1626.5 1626.5 1045.4 1086.9 1092.5 1095.3 1106.7 6119.0 6152.1 6172.6 6173.6 6184.3 6611.6 6615.9 6623.7 6625.4 6630.2 6087.2 6140.8 6141.8 6154.4 6158.2 3544.4 3550.2 3570.9 3583.1 3590.9 6664.9 6683.9 6750.4 6804.6 6806.5 6714.8 6717.9 6718.2 6734.1 6755.2 6770.1 6785.9 6788.2 6795.7 6797.5 6619.6 6643.2 6673.7 6685.3 6688.9 6446.3 6467.8 6479.5 6607.1 6614.3 6843.9 6855.9 6893.8 6897.7 6906.7 4623.9 4645.7 4658.0 4659.2 4664.6 6651.1 6702.8 6702.8 6703.4 6710.6 6398.6 6509.8 6525.3 6531.3 6537.0 6496.8 6521.1 6530.5 6535.4 6536.8 6359.2 6360.8 6361.5 6362.1 6368.9 6558.4 6573.9 6591.9 6627.2 6629.3 6129.0 6135.2 6215.5 6274.6 6309.9 17:46:02 INFO - PROCESS | 3614 | 17:46:02 INFO - PROCESS | 3614 | [#5] yui.html Cycles:180 Average:14165.27 Median:26421.45 stddev:16592.22 (62.8%) stddev-sans-first:16608.26 17:46:02 INFO - PROCESS | 3614 | Values: 766.2 780.4 832.2 840.7 892.0 14441.5 14554.2 14613.4 14627.5 14632.2 13772.5 13830.7 13868.0 13869.9 13887.7 742.3 903.5 905.1 924.3 926.6 916.7 921.5 924.9 925.0 926.1 965.0 972.2 973.2 973.2 973.3 785.3 950.6 963.2 963.3 964.5 716.9 717.8 717.8 718.5 718.6 13821.2 13911.1 13930.4 13932.2 13934.4 13779.5 14397.3 14489.2 14492.1 14760.0 10919.3 11021.5 11029.4 11183.9 11220.3 3902.0 3924.7 3952.8 3958.7 3999.9 50806.7 50863.0 51856.7 51941.2 52077.2 10112.3 10212.2 10383.1 10409.3 10479.3 19197.0 19226.2 20148.2 21099.8 21199.9 7953.9 8034.4 8053.5 8074.2 8419.9 4603.5 4736.9 4763.9 4810.5 4868.4 3337.3 3357.1 3368.7 3371.3 3379.8 549.4 569.9 593.3 641.7 668.6 570.4 618.5 665.1 715.2 717.5 7577.4 7656.5 7820.1 7947.8 8227.5 620.8 622.5 664.6 672.4 684.6 3816.4 3839.9 3981.8 3987.5 4016.6 59248.1 60407.0 60693.0 61105.0 61292.0 51220.0 52345.0 52706.7 52920.7 54623.0 45908.0 46083.8 46845.3 47060.5 48079.0 7665.1 7715.0 7806.1 7819.5 7915.0 35939.5 36395.5 36939.4 37039.8 38114.0 41875.8 44019.6 45047.0 45533.8 45933.8 10574.0 10713.7 10748.8 10793.2 11155.6 10703.5 10876.1 10925.9 11019.8 12096.8 10004.6 10078.5 10078.6 10130.4 10273.9 11054.9 11128.7 11160.5 11268.5 11400.3 9975.7 10410.0 10440.0 10469.1 10592.5 8863.6 8891.7 8968.2 9338.6 9397.0 8705.8 9055.0 9157.6 9180.3 9371.3 17:46:02 INFO - PROCESS | 3614 | -------- Summary: end -------- 17:46:02 INFO - PROCESS | 3614 | 17:46:03 INFO - TEST-INFO | 3614: exit 0 17:46:03 INFO - TEST-OK | dromaeo_css | took 1111996ms 17:46:03 INFO - TEST-START | kraken 17:46:03 INFO - operating with platform_type : linux_ 17:46:03 INFO - Initialising browser for kraken test... 17:46:03 INFO - TEST-INFO | started process 3810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkOzf2/profile http://localhost:58613/getInfo.html) 17:46:07 INFO - PROCESS | 3810 | __metrics Screen width/height:1600/1200 17:46:07 INFO - PROCESS | 3810 | colorDepth:24 17:46:07 INFO - PROCESS | 3810 | Browser inner width/height: 1024/697 17:46:07 INFO - PROCESS | 3810 | __metrics 17:46:08 INFO - PROCESS | 3810 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:09 INFO - TEST-INFO | 3810: exit 0 17:46:09 INFO - Browser initialized. 17:46:09 INFO - Running cycle 1/1 for kraken test... 17:46:09 INFO - TEST-INFO | started process 3899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkOzf2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:21 INFO - PROCESS | 3899 | RSS: Main: 139538432 17:46:21 INFO - PROCESS | 3899 | 17:46:24 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58613/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:24 INFO - PROCESS | 3899 | RSS: Main: 174891008 17:46:24 INFO - PROCESS | 3899 | 17:46:27 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58613/tests/kraken/driver.html?testName=audio-dft) 17:46:27 INFO - PROCESS | 3899 | RSS: Main: 173268992 17:46:27 INFO - PROCESS | 3899 | 17:46:30 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58613/tests/kraken/driver.html?testName=audio-fft) 17:46:31 INFO - PROCESS | 3899 | RSS: Main: 171020288 17:46:31 INFO - PROCESS | 3899 | 17:46:33 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58613/tests/kraken/driver.html?testName=audio-oscillator) 17:46:33 INFO - PROCESS | 3899 | RSS: Main: 171528192 17:46:33 INFO - PROCESS | 3899 | 17:46:36 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:36 INFO - PROCESS | 3899 | RSS: Main: 169648128 17:46:36 INFO - PROCESS | 3899 | 17:46:39 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58613/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:40 INFO - PROCESS | 3899 | RSS: Main: 169291776 17:46:40 INFO - PROCESS | 3899 | 17:46:43 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58613/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:44 INFO - PROCESS | 3899 | RSS: Main: 170147840 17:46:44 INFO - PROCESS | 3899 | 17:46:47 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58613/tests/kraken/driver.html?testName=json-parse-financial) 17:46:47 INFO - PROCESS | 3899 | RSS: Main: 169615360 17:46:47 INFO - PROCESS | 3899 | 17:46:49 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:49 INFO - PROCESS | 3899 | RSS: Main: 177553408 17:46:49 INFO - PROCESS | 3899 | 17:46:51 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:52 INFO - PROCESS | 3899 | RSS: Main: 174268416 17:46:52 INFO - PROCESS | 3899 | 17:46:54 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:54 INFO - PROCESS | 3899 | RSS: Main: 181399552 17:46:54 INFO - PROCESS | 3899 | 17:46:57 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:57 INFO - PROCESS | 3899 | RSS: Main: 186875904 17:46:57 INFO - PROCESS | 3899 | 17:47:00 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:00 INFO - PROCESS | 3899 | RSS: Main: 185024512 17:47:00 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:58613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58613/tests/kraken/driver.html?testName=ai-astar) 17:47:02 INFO - PROCESS | 3899 | RSS: Main: 246996992 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | __start_tp_report 17:47:02 INFO - PROCESS | 3899 | _x_x_mozilla_page_load 17:47:02 INFO - PROCESS | 3899 | _x_x_mozilla_page_load_details 17:47:02 INFO - PROCESS | 3899 | |i|pagename|runs| 17:47:02 INFO - PROCESS | 3899 | |0;ai-astar;110;109;105;108;107;109;98;108;108;108 17:47:02 INFO - PROCESS | 3899 | |1;audio-beat-detection;161;133;154;179;127;155;162;129;168;128 17:47:02 INFO - PROCESS | 3899 | |2;audio-dft;160;161;160;164;160;163;162;165;163;159 17:47:02 INFO - PROCESS | 3899 | |3;audio-fft;77;73;75;160;76;73;75;75;160;74 17:47:02 INFO - PROCESS | 3899 | |4;audio-oscillator;93;93;151;93;94;94;148;92;93;143 17:47:02 INFO - PROCESS | 3899 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;118 17:47:02 INFO - PROCESS | 3899 | |6;imaging-darkroom;146;146;145;145;146;146;145;146;145;146 17:47:02 INFO - PROCESS | 3899 | |7;imaging-desaturate;95;95;95;96;95;96;96;96;96;95 17:47:02 INFO - PROCESS | 3899 | |8;json-parse-financial;54;53;54;54;54;56;55;55;54;53 17:47:02 INFO - PROCESS | 3899 | |9;json-stringify-tinderbox;82;83;83;82;83;83;90;82;83;83 17:47:02 INFO - PROCESS | 3899 | |10;stanford-crypto-aes;78;78;79;77;80;78;78;78;87;78 17:47:02 INFO - PROCESS | 3899 | |11;stanford-crypto-ccm;115;117;112;112;114;108;115;122;109;110 17:47:02 INFO - PROCESS | 3899 | |12;stanford-crypto-pbkdf2;137;156;136;136;138;128;138;136;137;140 17:47:02 INFO - PROCESS | 3899 | |13;stanford-crypto-sha256-iterative;68;68;67;66;65;73;65;66;65;65 17:47:02 INFO - PROCESS | 3899 | __end_tp_report 17:47:02 INFO - PROCESS | 3899 | __start_cc_report 17:47:02 INFO - PROCESS | 3899 | _x_x_mozilla_cycle_collect,1035 17:47:02 INFO - PROCESS | 3899 | __end_cc_report 17:47:02 INFO - PROCESS | 3899 | __startTimestamp1462409222682__endTimestamp 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | ------- Summary: start ------- 17:47:02 INFO - PROCESS | 3899 | Number of tests: 14 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.50 stddev:3.43 (3.2%) stddev-sans-first:3.46 17:47:02 INFO - PROCESS | 3899 | Values: 110.0 109.0 105.0 108.0 107.0 109.0 98.0 108.0 108.0 108.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:158.00 stddev:18.89 (12.0%) stddev-sans-first:19.58 17:47:02 INFO - PROCESS | 3899 | Values: 161.0 133.0 154.0 179.0 127.0 155.0 162.0 129.0 168.0 128.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:2.00 (1.2%) stddev-sans-first:2.03 17:47:02 INFO - PROCESS | 3899 | Values: 160.0 161.0 160.0 164.0 160.0 163.0 162.0 165.0 163.0 159.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#3] audio-fft Cycles:10 Average:91.80 Median:75.00 stddev:35.97 (48.0%) stddev-sans-first:37.75 17:47:02 INFO - PROCESS | 3899 | Values: 77.0 73.0 75.0 160.0 76.0 73.0 75.0 75.0 160.0 74.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:26.25 (28.2%) stddev-sans-first:27.17 17:47:02 INFO - PROCESS | 3899 | Values: 93.0 93.0 151.0 93.0 94.0 94.0 148.0 92.0 93.0 143.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:47:02 INFO - PROCESS | 3899 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:47:02 INFO - PROCESS | 3899 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:47:02 INFO - PROCESS | 3899 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 17:47:02 INFO - PROCESS | 3899 | Values: 54.0 53.0 54.0 54.0 54.0 56.0 55.0 55.0 54.0 53.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#9] json-stringify-tinderbox Cycles:10 Average:83.40 Median:83.00 stddev:2.37 (2.9%) stddev-sans-first:2.46 17:47:02 INFO - PROCESS | 3899 | Values: 82.0 83.0 83.0 82.0 83.0 83.0 90.0 82.0 83.0 83.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.00 stddev:2.88 (3.7%) stddev-sans-first:3.03 17:47:02 INFO - PROCESS | 3899 | Values: 78.0 78.0 79.0 77.0 80.0 78.0 78.0 78.0 87.0 78.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:114.50 stddev:4.17 (3.6%) stddev-sans-first:4.38 17:47:02 INFO - PROCESS | 3899 | Values: 115.0 117.0 112.0 112.0 114.0 108.0 115.0 122.0 109.0 110.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:137.50 stddev:7.00 (5.1%) stddev-sans-first:7.42 17:47:02 INFO - PROCESS | 3899 | Values: 137.0 156.0 136.0 136.0 138.0 128.0 138.0 136.0 137.0 140.0 17:47:02 INFO - PROCESS | 3899 | 17:47:02 INFO - PROCESS | 3899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.49 (3.7%) stddev-sans-first:2.60 17:47:02 INFO - PROCESS | 3899 | Values: 68.0 68.0 67.0 66.0 65.0 73.0 65.0 66.0 65.0 65.0 17:47:02 INFO - PROCESS | 3899 | -------- Summary: end -------- 17:47:02 INFO - PROCESS | 3899 | 17:47:03 INFO - TEST-INFO | 3899: exit 0 17:47:03 INFO - TEST-OK | kraken | took 60092ms 17:47:03 INFO - SUITE-END | took 1172s 17:47:03 INFO - Completed test suite (00:19:32) 17:47:03 INFO - javascript benchmark 17:47:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3287.819169945653, 3361.5461912641786, 3374.0215337552113, 3381.5265862779215, 3419.2648580555174, 5469.097598896177, 5470.425605311445, 5481.12302031675, 5496.963886225638, 5512.283403157584, 5478.424765399635, 5493.697846618435, 5518.751656175472, 5520.171974203871, 5521.0, 4952.331435256248, 4985.302057711914, 5005.949940500603, 5069.467705890884, 5086.77109530072, 4926.162552366106, 5038.294638750578, 5110.872228194287, 5196.480351964792, 5205.063088644042, 5091.1854103343285, 5107.974460127694, 5116.539511443969, 5123.641345105844, 5144.125498665236, 4946.629002824802, 5014.272930425104, 5036.395632524084, 5045.167547354682, 5098.362704661918, 4990.950090499085, 5008.649394542384, 5009.398872135331, 5013.5989120870245, 5039.496050394968, 5363.54409875161, 5363.785448582091, 5366.731663416853, 5375.0, 5418.349798024262, 5711.171880077365, 5803.245578074823, 5916.112583112525, 5921.43746344101, 5927.110933359987, 6052.394760523913, 6055.7274922628585, 6056.152138700585, 6082.726277317532, 6093.268807743055, 5639.2668953036255, 5645.802396916089, 5646.322441307028, 5660.688662123582, 5688.0, 5958.076498142795, 6021.608595441282, 6091.405965851069, 6130.448259656652, 6151.753929842756, 5870.823875283749, 5878.823635290948, 5879.970600147058, 5881.441263080001, 5886.381929897299, 5919.993601087739, 5965.164876917235, 5970.104484327386, 5970.58205925581, 5984.222051133412, 5706.343770466449, 5853.180554722342, 5940.762369505172, 5965.343812180657, 5980.55145864062, 5864.2083318752275, 5897.026990546512, 5901.262342207224, 5903.203067585821, 5912.231409916683, 4447.266201076851, 4509.413776209072, 4513.458384993822, 4515.209838278288, 4551.45382554089, 4003.799810009488, 4049.230646177217, 4063.593640635972, 4065.6950728695465, 4090.1615168890307, 5603.719814009365, 5607.243022192033, 5609.915851262234, 5610.579206559524, 5610.961972035187, 5860.501857342174, 5930.021546444875, 5990.0, 6000.33996260411, 6003.519718422603, 5501.5323697486165, 5546.944530554723, 5564.721763911788, 5567.3040869891265, 5591.692456914909, 5085.186370180827, 5088.745562721849, 5089.51649593288, 5093.134167191586, 5126.538611524906, 6081.908771368433, 6088.817335480031, 6089.451949324582, 6097.725602347905, 6098.451139397475, 5959.374265702212, 5959.851003724942, 5960.0, 5973.49225315853, 5979.222701048836, 6010.248718910137, 6056.0, 6061.878762424639, 6072.14989901423, 6098.9390106100145, 5746.310442746897, 5795.710214489343, 5847.06446968483, 5858.5898987070495, 5871.031279838779, 5922.763089476372, 5964.880702385841, 5965.135055417027, 5983.760649573968, 6002.159697642421, 5823.7379317929945, 5825.3883342248455, 5826.184334193132, 5829.300483941955, 5830.329512105993, 5697.7436015380235, 5701.258836351248, 5778.682172480386, 5809.215755872903, 5813.680247586423, 5691.857703557444, 5704.80033198836, 5707.372189059283, 5707.942920570741, 5717.799877004285, 5793.507551858139, 5818.127280907897, 5819.970900145472, 5823.0, 5828.562857785768, 5588.469095435927, 5622.5783066271015, 5709.771609135588, 5728.455796699307, 5739.139129130497], "unit": "score", "name": "dojo.html", "value": 5468.746875895111}, {"lowerIsBetter": false, "replicates": [540.0791650236346, 556.5936866087753, 563.6871536297358, 574.0041028815008, 597.1818608506345, 38701.80649096754, 39210.03949802513, 39234.411483827695, 39290.0, 39374.409383859194, 42671.0, 42888.14223715524, 43096.78451607737, 43350.132997340115, 43371.0, 9008.68469603564, 9187.127222913847, 9189.035151309117, 9190.172884440399, 9191.678291259806, 8968.148025937558, 9079.636814527412, 9099.772505687344, 9104.408213466104, 9107.590158442887, 9101.044390339019, 9163.862542061874, 9167.312451566158, 9185.219256363183, 9185.770355741126, 8994.595243214038, 9048.547572621343, 9059.184673379428, 9069.818603627924, 9070.319726020509, 8955.865662015074, 9090.090990900922, 9090.50002249876, 9092.0, 9096.77258068547, 41231.1753764926, 41477.792611036755, 41514.1697166058, 41592.1681566367, 41715.791421043, 3564.750467467278, 3644.890653280406, 3759.887203383903, 3800.8289626966853, 4300.591443812864, 28920.132396027944, 29239.415211695647, 29361.706382936325, 29394.853025734734, 30221.395572088655, 4160.979195104035, 4209.221294060609, 4243.936340954888, 4315.8057887394825, 4346.826126954918, 236488.0, 237268.0, 238868.0, 239240.0, 239576.0, 46149.0, 60353.0, 60389.69805150946, 60742.0, 60761.69619151876, 44054.779726101166, 44163.55836441659, 44226.55773442225, 44337.556624433986, 44362.11275774467, 15424.922875385551, 15661.0, 15745.425457454392, 15748.448804291795, 15757.212139392985, 12493.0, 12570.622881313393, 12577.93711031439, 12582.307973061386, 12584.433700483318, 14982.700345993018, 15112.319945602254, 15116.773248401283, 15122.621934451727, 15362.846371536365, 5792.304923409218, 6023.66869822164, 6028.306744724325, 6069.544784141207, 6125.785597504066, 985.5367977050774, 997.0, 1009.7677534167036, 1033.0495943731785, 1084.3764835219781, 29975.700242997726, 30308.84845575758, 30525.542116868266, 30947.0, 31316.53025204624, 1128.6162704680285, 1148.1446322489633, 1183.1836033137108, 1193.4510125342267, 1212.1878341511208, 15525.301361438536, 15738.370465181264, 15884.52346429609, 16082.356705731874, 16170.838291617169, 343225.0, 345439.0, 346095.0, 346568.0, 347433.0, 55748.44251557432, 56342.71828640831, 56407.43592564022, 56542.0, 56572.43427565671, 1349.959501214965, 1438.4246301479493, 1439.0933711761732, 1488.3600051977753, 1493.6489924867647, 28120.0, 30333.696663033086, 30455.543166852072, 30531.694683052887, 31172.220694482818, 45781.54218457773, 45876.31185532286, 46157.30764038609, 46240.30639540477, 46246.0, 242463.0, 243745.0, 244436.0, 245231.0, 303872.0, 34528.0, 34896.82551587226, 35124.0, 35222.8238858804, 35491.467627986116, 41502.584974149875, 41818.0, 42078.36882446827, 42569.148617028106, 50695.2395714072, 36806.815965919996, 37065.258694826494, 37285.81357093197, 37526.62473375232, 37745.81127094347, 36982.8150859244, 37839.62160378471, 38766.80616597012, 39657.40513892352, 39727.60272397239, 39445.60554394419, 40115.398269025405, 40176.99557511086, 40246.79876600598, 40344.19311613693, 33919.321613567095, 34998.0, 35223.47164792581, 35605.590993621394, 35858.46212306766, 26590.7340926596, 26790.59814102751, 26976.595351069358, 26998.0, 27089.1873243803], "unit": "score", "name": "ext.html", "value": 18712.698527644512}, {"lowerIsBetter": false, "replicates": [360.9368360536905, 375.2064383828204, 378.0661765439365, 384.27947598253274, 384.51273636660176, 17330.91334543327, 17414.912925435372, 18120.81879181208, 18127.72808407875, 18173.454796356098, 16953.3218671253, 17524.82475175251, 17733.911330443363, 17783.28866845328, 17788.110594470258, 5403.135498320269, 5574.526165275936, 5603.495685388314, 5609.635373700697, 5612.719364031782, 4297.484301883778, 5508.944910550883, 5962.463378295953, 6198.566100372976, 6222.595531290474, 6190.628562286277, 6191.102290167923, 6198.287196972338, 6214.440700336969, 6216.160818289541, 5926.199963004982, 6253.656048917308, 6260.092286618437, 6264.561480696353, 6267.780627678032, 3875.2830726315724, 5260.500252476047, 5425.565954723613, 5450.0, 5463.562914966793, 21145.894270528705, 21382.465438364008, 21405.46486337854, 21784.891075544678, 21842.563148737096, 2362.7519110493495, 2409.7831195192343, 2419.0807493152665, 2449.8040156787592, 2574.768270855613, 12769.680757981125, 13452.79820802679, 13616.0, 13650.93174534121, 13992.93003534986, 1884.4817675139445, 1912.550550620603, 1932.5555122321944, 1946.2701486942397, 1952.8535359848067, 55450.72274638641, 57071.42928570744, 57233.71383143058, 57752.71123644397, 58631.70684146552, 9563.09150630689, 9847.75380615476, 10426.061654451136, 10437.582496700199, 10641.5211315491, 14187.14877107377, 14296.785548216785, 14298.499552515612, 14312.713745725236, 14314.212718300385, 7381.261873812576, 7594.544327340377, 7667.156612772591, 7740.187280335596, 7764.22357764219, 7224.819379515449, 7269.89095163573, 7299.41604671625, 7312.866505691626, 7356.889646655304, 4520.547945205453, 4544.2047641662575, 4567.9086418271445, 4637.582617564435, 4653.813847446064, 1769.5929936114765, 1832.2121487760392, 1848.2329833119375, 1930.835878950305, 1932.8550358723153, 726.7165805335924, 978.4716253223322, 1022.2858311183819, 1024.8462730590322, 1029.7528593137592, 16594.6681066378, 16906.154692265336, 17197.57006074833, 17339.306427742747, 17445.7383139253, 962.3696478806393, 987.4717026390847, 1025.0569476082023, 1049.165913099073, 1058.9470526473644, 9745.366551174151, 9796.0, 9841.704748857546, 9861.753456163653, 10052.296339256329, 351543.0, 448133.0, 471843.0, 475501.0, 475517.0, 73672.63163684147, 82104.0, 84237.57881210555, 85506.0, 86660.13339866647, 1039.9116075133547, 1053.9051485366354, 1055.778286559831, 1056.857324261215, 1089.7275681079889, 15398.769018464507, 15441.0, 15555.844441555892, 15639.530814075595, 15680.764788527953, 33663.495047573815, 34464.483032754026, 36175.81912090423, 36720.449193261586, 37422.8128859354, 51268.23097653613, 51347.74326128345, 51477.0, 51984.220236697234, 52341.7382913083, 8412.0, 8445.071042185478, 8446.873296900429, 8459.619317130868, 8544.35917306217, 12258.938705306417, 12399.442025109072, 12406.317652528836, 12757.0, 12780.36098195068, 10646.520906559068, 10664.733381665521, 11061.889381106086, 11167.720806979565, 11338.886611134112, 11053.226274160732, 11193.72015699614, 11249.943750281196, 11332.546698131982, 11433.742288348441, 11183.832242516206, 11422.885771142182, 11546.653600392001, 11628.18602697803, 11671.241369311307, 8391.622376993171, 8470.830583388175, 8591.097934716765, 8650.653973840976, 8735.91264087351, 10299.588016479556, 11461.942690286494, 11511.884881151082, 11544.134189935956, 11573.594924177612], "unit": "score", "name": "jquery.html", "value": 8809.260646197545}, {"lowerIsBetter": false, "replicates": [1480.8815294776418, 1586.5795564175492, 1609.1954022988502, 1852.7128295114253, 1963.6072785442907, 8250.587470626468, 8461.53461559614, 8503.574821258935, 8510.531920744357, 8554.657813687461, 8060.0, 8192.54940978246, 8207.261346478816, 8211.91788082119, 8213.13762054983, 2417.238569850496, 2439.4511234972165, 2441.8046556275453, 2462.347477918353, 2463.2979600813774, 2425.3087869957067, 2435.9878200608973, 2479.1446950802033, 2499.0503608628787, 2501.199616122832, 2436.902523899042, 2440.1825388494785, 2467.432490527171, 2473.579491486452, 2476.5666008448447, 2372.0, 2383.30884043628, 2385.821063420242, 2388.9880550597222, 2408.3738228060656, 2496.2885577610296, 2497.1884137655334, 2507.3480894967256, 2508.109621084507, 2536.8097392695436, 8324.916750832535, 8377.832443351099, 8379.748607541784, 8379.95810020946, 8392.706255281037, 5271.156614941629, 5377.75800088993, 5406.053940560426, 5410.56715462766, 5415.9458405415835, 3199.23218427578, 3249.2201871550656, 3264.216588018858, 3267.9183020424443, 3338.8163650999186, 1021.9284650074497, 1036.9118624916891, 1053.2258789789498, 1053.7260312318776, 1055.0346433013783, 12251.754964900741, 12271.0, 12279.75440491194, 12299.815502767466, 12316.322602256962, 4708.882277943078, 4774.40319960005, 4781.450133234653, 4796.184648609675, 4805.399325084364, 10395.94802025985, 10449.0, 10452.634157804441, 10481.266311358131, 10481.633142839964, 5435.456454354612, 5468.097763868917, 5469.890602187934, 5471.671699698031, 5473.397926228191, 4335.0, 4743.407074115736, 4880.804767809319, 4915.1644220481885, 4955.950440495549, 3952.26883026641, 4002.8598999034893, 4027.456293400412, 4034.9798251008556, 4126.216018956388, 1277.8338815954053, 1288.9484420623257, 1293.5795866343476, 1294.851092124399, 1331.1414137881013, 1201.0631707268344, 1413.519403402848, 1417.985820141806, 1420.5809286260578, 1445.8771004464738, 7988.80027999293, 8004.639791209293, 8043.758687239392, 8059.597020148969, 8084.717034903751, 1147.5753971030606, 1173.0908545876844, 1190.922590031645, 1207.5592408770735, 1231.7844377233948, 6260.843478913063, 6291.716872740738, 6297.464715499143, 6369.490440764727, 6379.043143528415, 10145.239107067, 10480.528376222936, 10481.213908956859, 10498.947505262426, 10505.422201778976, 10121.493925303705, 10282.485875706185, 10327.793444131075, 10330.638427654996, 10367.94816025915, 8188.549629770419, 8316.501009939422, 8358.414910956297, 8409.32725381968, 8414.78963025917, 7822.295993360625, 7825.256600622932, 7877.094134174643, 7893.329067029367, 7929.960350198212, 9472.431654100776, 9473.857892131762, 9563.282753793632, 9578.13796758295, 9693.079157480028, 9591.0, 9898.50507474609, 9927.056929591678, 9957.452340121074, 10057.396556206651, 6432.710528026344, 6478.190226221723, 6544.509161812978, 7320.450966177665, 7423.851522969619, 8199.71301004462, 8203.384746143944, 8276.834463310579, 8284.212999765012, 8299.543525106177, 7177.0, 7246.565206087441, 7272.709091636275, 7309.195988441161, 7364.815879603053, 7232.63836808168, 7232.891506627299, 7272.490925635155, 7353.70585176587, 7375.409967202718, 7607.4674772765375, 7754.8449031017935, 7766.456348055582, 7774.844503110019, 7884.093329266978, 7111.359977602041, 7112.146542414736, 7130.643467826691, 7145.892811607726, 7170.533915295489, 7204.675789589586, 7338.229485903903, 7341.0, 7343.8531229376185, 7362.852742945004], "unit": "score", "name": "mootools.html", "value": 4933.709756626393}, {"lowerIsBetter": false, "replicates": [327.1135223544195, 330.4695962979418, 331.4464843711002, 333.71300681413965, 337.7686284894846, 6008.759649614021, 6057.636541807489, 6076.331603523615, 6102.084687296902, 6104.847378815521, 5946.43508866657, 5949.196858424111, 5952.821415357535, 5971.761129554823, 5996.700164991755, 4413.293872980324, 4524.140413321475, 4605.976970115162, 4627.768611569417, 4677.672562920597, 4666.4400271967415, 4670.34615153877, 4670.579647831694, 4677.579017888389, 4677.602403795681, 4621.353010578522, 4622.514635963209, 4627.329037289591, 4628.884277893063, 4635.049814787961, 4437.290033594625, 4516.796744146505, 4609.285560738091, 4610.05493873755, 4617.0, 4033.173199494126, 4036.2734707752593, 4036.3138266494766, 4037.7577345359373, 4044.6157615026527, 5774.220480235156, 5785.971070144665, 5792.362840087587, 5795.565332600029, 5801.6519008859605, 5387.326584176978, 5391.919121213185, 5393.406725260218, 5394.676319420847, 5400.432954539795, 6402.455791257702, 6419.454346380563, 6419.871602567922, 6420.0, 6422.935770642281, 4395.560443955611, 4505.5269196734525, 4507.752073635948, 4512.796924138422, 4527.977360113178, 6603.3396660334065, 6655.866882662368, 6659.034440006172, 6676.13210282665, 6689.431398331099, 4535.523770004102, 4566.13243483737, 4573.428321459817, 4575.24508456101, 4576.313552967082, 4624.838130665478, 4629.0, 4630.259158534685, 4631.745254010994, 4632.490426053131, 5324.227986941949, 5345.1714984177515, 5353.036453438419, 5355.30381050461, 5360.0351936650995, 6309.842253943596, 6415.582987105823, 6450.451711604566, 6451.903221451682, 6473.320301368289, 1614.1525699008114, 1625.7723918651398, 1626.2844348486628, 1626.5201765479212, 1626.544567521096, 1045.3675526306627, 1086.940218287986, 1092.546593163844, 1095.3263742798122, 1106.6956586938657, 6118.969405152946, 6152.138700581922, 6172.629642221481, 6173.59871608344, 6184.288806787187, 6611.570247933869, 6615.933840661628, 6623.668816559153, 6625.370589794058, 6630.204375474974, 6087.178230938855, 6140.785072522441, 6141.815745527641, 6154.3845615438995, 6158.1686472326555, 3544.3620148373025, 3550.1657110578994, 3570.8571657133944, 3583.122135076923, 3590.9461358079648, 6664.866702666017, 6683.933160668331, 6750.35871592198, 6804.591724496447, 6806.4554835613035, 6714.832129196711, 6717.865642687118, 6718.193816742022, 6734.124563806772, 6755.1556055493065, 6770.086038384854, 6785.8642827143185, 6788.151481064867, 6795.728170873209, 6797.456203503708, 6619.569727967667, 6643.202815662152, 6673.733050677918, 6685.2646208916, 6688.866222675617, 6446.29090800021, 6467.773627923, 6479.546431749733, 6607.075009498578, 6614.272430032789, 6843.931560684528, 6855.931440685728, 6893.827654308482, 6897.689603967733, 6906.723731050702, 4623.88440288982, 4645.721256724607, 4658.0, 4659.2312268475325, 4664.580187783115, 6651.06885036105, 6702.832429189114, 6702.83242918931, 6703.430208432338, 6710.63091529951, 6398.584092034003, 6509.837254068686, 6525.314841941527, 6531.281559028408, 6537.0, 6496.7726129585235, 6521.087047813405, 6530.542861999615, 6535.4444872184495, 6536.803895883131, 6359.20509936258, 6360.77737279193, 6361.491080713439, 6362.109304697254, 6368.936310636835, 6558.442532384801, 6573.868522629617, 6591.934080659324, 6627.204735431779, 6629.270780214269, 6129.0, 6135.171751813448, 6215.471684906653, 6274.560780745304, 6309.905351419824], "unit": "score", "name": "prototype.html", "value": 4846.955676383276}, {"lowerIsBetter": false, "replicates": [766.1840140250632, 780.3978343216389, 832.2052439919877, 840.6637345061971, 891.964321427143, 14441.49454769082, 14554.19951902645, 14613.415463381452, 14627.488037918674, 14632.195229262386, 13772.517961871337, 13830.723385532283, 13868.029237953348, 13869.861301386984, 13887.652808679788, 742.3022358982566, 903.5075883643398, 905.1175104273347, 924.3113880159291, 926.5922993882704, 916.7478943290615, 921.5392303848076, 924.944503329799, 924.958376873039, 926.0554234680656, 964.9662261820838, 972.1930797438145, 973.1971123822839, 973.2214228617113, 973.2992245583168, 785.3442375616339, 950.6387572722356, 963.2149797914747, 963.2727290895364, 964.5177411294353, 716.9390601798854, 717.8205448637841, 717.8384863405744, 718.529363267061, 718.5724493926106, 13821.239831809247, 13911.095778774448, 13930.37313320903, 13932.164070155823, 13934.372953217027, 13779.517716879962, 14397.280135993264, 14489.203093829836, 14492.058016228912, 14760.040597361138, 10919.344839309588, 11021.504032318566, 11029.44852757359, 11183.888161118366, 11220.326780393203, 3901.9804900975314, 3924.7448915820664, 3952.802359882023, 3958.6833053355663, 3999.8600048998437, 50806.74596626993, 50863.0, 51856.740716296554, 51941.22088168681, 52077.218841717404, 10112.342697724624, 10212.183025357954, 10383.065524102867, 10409.323393979366, 10479.266451348332, 19197.0, 19226.230950762092, 20148.194072236947, 21099.78900211009, 21199.894000530207, 7953.920460795433, 8034.437589368805, 8053.476524025919, 8074.192580741878, 8419.873701894476, 4603.539646035437, 4736.8578942631775, 4763.857084287408, 4810.470848206694, 4868.367112275452, 3337.349216902681, 3357.1103657530775, 3368.6631336866117, 3371.258323168899, 3379.847906844198, 549.370970239074, 569.9031164701928, 593.2613895699882, 641.6791604197902, 668.5520701130255, 570.3554982869331, 618.5268269773627, 665.1120753793643, 715.1882613234017, 717.4511498703496, 7577.431692623075, 7656.464047516621, 7820.139784623687, 7947.761567152995, 8227.54748488827, 620.7503718036078, 622.5019984012772, 664.6444152378455, 672.3814091036259, 684.5584597934304, 3816.4466152407745, 3839.884803455901, 3981.7810020448574, 3987.5414327352146, 4016.6184212499766, 59248.111278330856, 60407.0, 60692.96535173224, 61105.0, 61292.0, 51220.0, 52345.0, 52706.73646631742, 52920.73539632277, 54623.0, 45908.0, 46083.847903802, 46845.297320540216, 47060.52939470561, 48079.038419231416, 7665.080190377191, 7715.0, 7806.102298235775, 7819.530828150329, 7915.010623672041, 35939.46090808588, 36395.45406818953, 36939.44590831086, 37039.81480092582, 38114.0, 41875.7906210467, 44019.55980440155, 45047.0, 45533.772331138134, 45933.77033114813, 10574.0, 10713.678589642323, 10748.838767418338, 10793.19051071157, 11155.553777848796, 10703.518341674799, 10876.12990960737, 10925.945370273097, 11019.779604408028, 12096.75806483883, 10004.599816007569, 10078.496075196357, 10078.596856125967, 10130.392176469435, 10273.9486302568, 11054.944725276322, 11128.666140015812, 11160.497777599865, 11268.492917818554, 11400.258983166068, 9975.700728978143, 10410.0, 10440.008199221062, 10469.110125639407, 10592.470376481298, 8863.556822158995, 8891.688790892547, 8968.237699795329, 9338.626454941726, 9396.95301523488, 8705.782355441164, 9055.0, 9157.633694652139, 9180.311476639412, 9371.250299975849], "unit": "score", "name": "yui.html", "value": 6506.052997605923}], "name": "dromaeo_css", "value": 7208.1938274567165}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 105.0, 108.0, 107.0, 109.0, 98.0, 108.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [161.0, 133.0, 154.0, 179.0, 127.0, 155.0, 162.0, 129.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 164.0, 160.0, 163.0, 162.0, 165.0, 163.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 75.0, 160.0, 76.0, 73.0, 75.0, 75.0, 160.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 151.0, 93.0, 94.0, 94.0, 148.0, 92.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 56.0, 55.0, 55.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 83.0, 90.0, 82.0, 83.0, 83.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 83.4}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 77.0, 80.0, 78.0, 78.0, 78.0, 87.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [115.0, 117.0, 112.0, 112.0, 114.0, 108.0, 115.0, 122.0, 109.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [137.0, 156.0, 136.0, 136.0, 138.0, 128.0, 138.0, 136.0, 137.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 66.0, 65.0, 73.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1512.6000000000001}]} 17:47:03 INFO - Return code: 0 17:47:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:47:04 INFO - # TBPL SUCCESS # 17:47:04 INFO - Running post-action listener: _resource_record_post_action 17:47:04 INFO - Running post-run listener: _resource_record_post_run 17:47:05 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 458133504; Read time: 40; Write time: 446196 17:47:05 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237228032; Read time: 0; Write time: 309016 17:47:05 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 16384; Write bytes: 220467200; Read time: 40; Write time: 137136 17:47:05 INFO - Running post-run listener: _upload_blobber_files 17:47:05 INFO - Blob upload gear active. 17:47:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47:05 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 17:47:05 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'] 17:47:05 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 17:47:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:06 INFO - (blobuploader) - INFO - Done attempting. 17:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:08 INFO - (blobuploader) - INFO - Done attempting. 17:47:08 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:08 INFO - Return code: 0 17:47:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faf3155b8337f89d8e795827c80295a9d1fb2f6145c53129a6c5282774a7528f99549ae6b8e121d800ce8e09c4058c01f3a8bdc199d8c7fb33d0088f32fcdf96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43eeab4d69c95e736611a18411a0bbbac438744065ea8a0ba9ca8585d0d9f0e7dd45b58b295a67cbc93f899ccfe7ec632c5fdadad9bc4ec83513ebbdb2b9439e"} 17:47:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:08 INFO - Contents: 17:47:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faf3155b8337f89d8e795827c80295a9d1fb2f6145c53129a6c5282774a7528f99549ae6b8e121d800ce8e09c4058c01f3a8bdc199d8c7fb33d0088f32fcdf96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43eeab4d69c95e736611a18411a0bbbac438744065ea8a0ba9ca8585d0d9f0e7dd45b58b295a67cbc93f899ccfe7ec632c5fdadad9bc4ec83513ebbdb2b9439e"} 17:47:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:08 INFO - Copying logs to upload dir... 17:47:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.415478 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-04 17:47:07.949047) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 17:47:07.952154) ========= 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=aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faf3155b8337f89d8e795827c80295a9d1fb2f6145c53129a6c5282774a7528f99549ae6b8e121d800ce8e09c4058c01f3a8bdc199d8c7fb33d0088f32fcdf96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43eeab4d69c95e736611a18411a0bbbac438744065ea8a0ba9ca8585d0d9f0e7dd45b58b295a67cbc93f899ccfe7ec632c5fdadad9bc4ec83513ebbdb2b9439e"} build_url:https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/JDDyevuLR3WiYgBGtWpp2g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faf3155b8337f89d8e795827c80295a9d1fb2f6145c53129a6c5282774a7528f99549ae6b8e121d800ce8e09c4058c01f3a8bdc199d8c7fb33d0088f32fcdf96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43eeab4d69c95e736611a18411a0bbbac438744065ea8a0ba9ca8585d0d9f0e7dd45b58b295a67cbc93f899ccfe7ec632c5fdadad9bc4ec83513ebbdb2b9439e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 17:47:07.976969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:47:07.977334) ========= 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=aa52b8aba932b19cc50b5275000001de-1462403469.535842-664482514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:47:08.060246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 17:47:08.060551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 17:47:08.060858) ========= ========= Total master_lag: 0.20 =========