builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1464278243.33 results: success (0) buildid: 20160526062249 builduid: 8df1aa4730e94644a45d361d889289e6 revision: b0a5f5e149d2fa1aae0fd81801671369100a9580 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.326578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.327049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.327323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.363748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.364045) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 08:57:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.1M=0s 2016-05-26 08:57:23 (87.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.505783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.506086) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014474 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.555989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:23.556335) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b0a5f5e149d2fa1aae0fd81801671369100a9580 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b0a5f5e149d2fa1aae0fd81801671369100a9580 --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=8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 08:57:23,703 truncating revision to first 12 chars 2016-05-26 08:57:23,703 Setting DEBUG logging. 2016-05-26 08:57:23,703 attempt 1/10 2016-05-26 08:57:23,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b0a5f5e149d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 08:57:24,061 unpacking tar archive at: mozilla-aurora-b0a5f5e149d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:24.256980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:24.257284) ========= script_repo_revision: b0a5f5e149d2fa1aae0fd81801671369100a9580 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:24.257770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:24.258036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 08:57:24.271245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-26 08:57:24.271651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:57:24 INFO - MultiFileLogger online at 20160526 08:57:24 in /builds/slave/test 08:57:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:57:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:57:24 INFO - {'append_to_log': False, 08:57:24 INFO - 'base_work_dir': '/builds/slave/test', 08:57:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:57:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:57:24 INFO - 'branch': 'Mozilla-Aurora', 08:57:24 INFO - 'buildbot_json_path': 'buildprops.json', 08:57:24 INFO - 'config_files': ('talos/linux_config.py',), 08:57:24 INFO - 'default_actions': ('clobber', 08:57:24 INFO - 'read-buildbot-config', 08:57:24 INFO - 'download-and-extract', 08:57:24 INFO - 'populate-webroot', 08:57:24 INFO - 'create-virtualenv', 08:57:24 INFO - 'install', 08:57:24 INFO - 'run-tests'), 08:57:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:57:24 INFO - 'download_minidump_stackwalk': True, 08:57:24 INFO - 'download_symbols': 'ondemand', 08:57:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:57:24 INFO - 'tooltool.py': '/tools/tooltool.py', 08:57:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:57:24 INFO - '/tools/misc-python/virtualenv.py')}, 08:57:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:57:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:57:24 INFO - 'installer_path': 'installer.exe', 08:57:24 INFO - 'log_level': 'info', 08:57:24 INFO - 'log_name': 'talos', 08:57:24 INFO - 'log_to_console': True, 08:57:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:57:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:57:24 INFO - 'opt_config_files': (), 08:57:24 INFO - 'pip_index': False, 08:57:24 INFO - 'sps_profile': False, 08:57:24 INFO - 'sps_profile_interval': 0, 08:57:24 INFO - 'suite': 'dromaeojs', 08:57:24 INFO - 'system_bits': '32', 08:57:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:57:24 INFO - 'title': 'talos-linux64-ix-001', 08:57:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:57:24 INFO - 'use_talos_json': True, 08:57:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:57:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:57:24 INFO - 'work_dir': 'build'} 08:57:24 INFO - ##### 08:57:24 INFO - ##### Running clobber step. 08:57:24 INFO - ##### 08:57:24 INFO - Running pre-action listener: _resource_record_pre_action 08:57:24 INFO - Running main action method: clobber 08:57:24 INFO - rmtree: /builds/slave/test/build 08:57:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:57:25 INFO - Running post-action listener: _resource_record_post_action 08:57:25 INFO - ##### 08:57:25 INFO - ##### Running read-buildbot-config step. 08:57:25 INFO - ##### 08:57:25 INFO - Running pre-action listener: _resource_record_pre_action 08:57:25 INFO - Running main action method: read_buildbot_config 08:57:25 INFO - Using buildbot properties: 08:57:25 INFO - { 08:57:25 INFO - "project": "", 08:57:25 INFO - "product": "firefox", 08:57:25 INFO - "script_repo_revision": "production", 08:57:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:57:25 INFO - "repository": "", 08:57:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:57:25 INFO - "buildid": "20160526062249", 08:57:25 INFO - "pgo_build": "True", 08:57:25 INFO - "basedir": "/builds/slave/test", 08:57:25 INFO - "buildnumber": 520, 08:57:25 INFO - "slavename": "talos-linux64-ix-001", 08:57:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:57:25 INFO - "platform": "ubuntu64_hw", 08:57:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:57:25 INFO - "branch": "mozilla-aurora", 08:57:25 INFO - "repo_path": "releases/mozilla-aurora", 08:57:25 INFO - "revision": "b0a5f5e149d2fa1aae0fd81801671369100a9580", 08:57:25 INFO - "stage_platform": "linux64-pgo", 08:57:25 INFO - "builduid": "8df1aa4730e94644a45d361d889289e6", 08:57:25 INFO - "slavebuilddir": "test" 08:57:25 INFO - } 08:57:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 08:57:25 INFO - Running post-action listener: _resource_record_post_action 08:57:25 INFO - ##### 08:57:25 INFO - ##### Running download-and-extract step. 08:57:25 INFO - ##### 08:57:25 INFO - Running pre-action listener: _resource_record_pre_action 08:57:25 INFO - Running main action method: download_and_extract 08:57:25 INFO - mkdir: /builds/slave/test/build/tests 08:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:25 INFO - https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:57:27 INFO - Downloaded 1361 bytes. 08:57:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:57:27 INFO - Using the following test package requirements: 08:57:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:57:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:57:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:57:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'jsshell-linux-x86_64.zip'], 08:57:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:57:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:57:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:57:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:57:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:57:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:57:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:57:27 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')]} 08:57:27 INFO - https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:57:29 INFO - Downloaded 24135241 bytes. 08:57:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:57:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:57:31 INFO - Return code: 0 08:57:31 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:57: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')]} 08:57:31 INFO - https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:57:34 INFO - Downloaded 24135241 bytes. 08:57:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:57:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:57:36 INFO - Return code: 0 08:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:36 INFO - https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:57:37 INFO - Downloaded 10840145 bytes. 08:57:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:57:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:57:37 INFO - Return code: 0 08:57:37 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')]} 08:57:37 INFO - https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:57:38 INFO - Downloaded 62752636 bytes. 08:57:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:57:38 INFO - mkdir: /builds/slave/test/properties 08:57:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:57:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:57:38 INFO - Contents: 08:57:38 INFO - build_url:https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:57:39 INFO - Running post-action listener: _resource_record_post_action 08:57:39 INFO - Running post-action listener: set_extra_try_arguments 08:57:39 INFO - ##### 08:57:39 INFO - ##### Running populate-webroot step. 08:57:39 INFO - ##### 08:57:39 INFO - Running pre-action listener: _resource_record_pre_action 08:57:39 INFO - Running main action method: populate_webroot 08:57:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:57:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:57:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:57:39 INFO - '--tppagecycles', 08:57:39 INFO - '7'], 08:57:39 INFO - 'tests': ['tsvgm']}}, 08:57:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:57:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:57:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:57:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:57:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['damp', 'tps']}, 08:57:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'tests': ['damp', 'tps']}, 08:57:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['dromaeo_dom']}, 08:57:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:57:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['a11yr', 08:57:39 INFO - 'ts_paint', 08:57:39 INFO - 'tpaint', 08:57:39 INFO - 'sessionrestore', 08:57:39 INFO - 'sessionrestore_no_auto_restore', 08:57:39 INFO - 'tabpaint']}, 08:57:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:57:39 INFO - 'ts_paint', 08:57:39 INFO - 'tpaint', 08:57:39 INFO - 'sessionrestore', 08:57:39 INFO - 'sessionrestore_no_auto_restore', 08:57:39 INFO - 'tabpaint']}, 08:57:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:57:39 INFO - 'ts_paint', 08:57:39 INFO - 'tpaint', 08:57:39 INFO - 'sessionrestore', 08:57:39 INFO - 'sessionrestore_no_auto_restore', 08:57:39 INFO - 'tabpaint']}, 08:57:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:57:39 INFO - 'ts_paint', 08:57:39 INFO - 'tpaint', 08:57:39 INFO - 'sessionrestore', 08:57:39 INFO - 'sessionrestore_no_auto_restore', 08:57:39 INFO - 'tabpaint']}, 08:57:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['a11yr', 08:57:39 INFO - 'ts_paint', 08:57:39 INFO - 'tpaint', 08:57:39 INFO - 'sessionrestore', 08:57:39 INFO - 'sessionrestore_no_auto_restore', 08:57:39 INFO - 'tabpaint']}, 08:57:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['a11yr', 08:57:39 INFO - 'ts_paint', 08:57:39 INFO - 'tpaint', 08:57:39 INFO - 'sessionrestore', 08:57:39 INFO - 'sessionrestore_no_auto_restore', 08:57:39 INFO - 'tabpaint']}, 08:57:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['tsvgx', 08:57:39 INFO - 'tsvgr_opacity', 08:57:39 INFO - 'tart', 08:57:39 INFO - 'tscrollx', 08:57:39 INFO - 'cart']}, 08:57:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:57:39 INFO - 'tsvgr_opacity', 08:57:39 INFO - 'tart', 08:57:39 INFO - 'tscrollx', 08:57:39 INFO - 'cart']}, 08:57:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'talos_options': ['--disable-e10s'], 08:57:39 INFO - 'tests': ['tp5o']}, 08:57:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'tests': ['tp5o']}, 08:57:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'talos_options': ['--disable-e10s', 08:57:39 INFO - '--xperf_path', 08:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:39 INFO - 'tests': ['tp5n']}, 08:57:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:39 INFO - 'talos_options': ['--xperf_path', 08:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:39 INFO - 'tests': ['tp5n']}}, 08:57:39 INFO - 'talos.zip': {'path': '', 08:57:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:57:39 INFO - Running post-action listener: _resource_record_post_action 08:57:39 INFO - ##### 08:57:39 INFO - ##### Running create-virtualenv step. 08:57:39 INFO - ##### 08:57:39 INFO - Running pre-action listener: _resource_record_pre_action 08:57:39 INFO - Running main action method: create_virtualenv 08:57:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:57:39 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 08:57:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:57:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:57:39 INFO - Using real prefix '/usr' 08:57:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:57:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:57:42 INFO - Installing pip.................done. 08:57:42 INFO - Return code: 0 08:57:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:57:42 INFO - Using env: {'DISPLAY': ':0', 08:57:42 INFO - 'HOME': '/home/cltbld', 08:57:42 INFO - 'LANG': 'en_US.UTF-8', 08:57:42 INFO - 'LANGUAGE': 'en_US:en', 08:57:42 INFO - 'LOGNAME': 'cltbld', 08:57:42 INFO - 'MAIL': '/var/mail/cltbld', 08:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:42 INFO - 'MOZ_NO_REMOTE': '1', 08:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:42 INFO - 'NO_EM_RESTART': '1', 08:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:42 INFO - 'PWD': '/builds/slave/test', 08:57:42 INFO - 'SHELL': '/bin/bash', 08:57:42 INFO - 'SHLVL': '1', 08:57:42 INFO - 'TERM': 'linux', 08:57:42 INFO - 'TMOUT': '86400', 08:57:42 INFO - 'USER': 'cltbld', 08:57:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:42 INFO - '_': '/tools/buildbot/bin/python'} 08:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:42 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 08:57:42 INFO - Cleaning up... 08:57:42 INFO - Return code: 0 08:57:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:57:42 INFO - Using env: {'DISPLAY': ':0', 08:57:42 INFO - 'HOME': '/home/cltbld', 08:57:42 INFO - 'LANG': 'en_US.UTF-8', 08:57:42 INFO - 'LANGUAGE': 'en_US:en', 08:57:42 INFO - 'LOGNAME': 'cltbld', 08:57:42 INFO - 'MAIL': '/var/mail/cltbld', 08:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:42 INFO - 'MOZ_NO_REMOTE': '1', 08:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:42 INFO - 'NO_EM_RESTART': '1', 08:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:42 INFO - 'PWD': '/builds/slave/test', 08:57:42 INFO - 'SHELL': '/bin/bash', 08:57:42 INFO - 'SHLVL': '1', 08:57:42 INFO - 'TERM': 'linux', 08:57:42 INFO - 'TMOUT': '86400', 08:57:42 INFO - 'USER': 'cltbld', 08:57:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:42 INFO - '_': '/tools/buildbot/bin/python'} 08:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:42 INFO - Downloading/unpacking psutil>=0.7.1 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:44 INFO - Installing collected packages: psutil 08:57:44 INFO - Running setup.py install for psutil 08:57:44 INFO - building 'psutil._psutil_linux' extension 08:57:44 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 08:57:45 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 08:57:45 INFO - building 'psutil._psutil_posix' extension 08:57:45 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 08:57:45 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 08:57:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:45 INFO - Successfully installed psutil 08:57:45 INFO - Cleaning up... 08:57:45 INFO - Return code: 0 08:57:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:57:45 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')]} 08:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:45 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')]} 08:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:45 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 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:45 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 08:57:45 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 08:57:45 INFO - Using env: {'DISPLAY': ':0', 08:57:45 INFO - 'HOME': '/home/cltbld', 08:57:45 INFO - 'LANG': 'en_US.UTF-8', 08:57:45 INFO - 'LANGUAGE': 'en_US:en', 08:57:45 INFO - 'LOGNAME': 'cltbld', 08:57:45 INFO - 'MAIL': '/var/mail/cltbld', 08:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:45 INFO - 'MOZ_NO_REMOTE': '1', 08:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:45 INFO - 'NO_EM_RESTART': '1', 08:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:45 INFO - 'PWD': '/builds/slave/test', 08:57:45 INFO - 'SHELL': '/bin/bash', 08:57:45 INFO - 'SHLVL': '1', 08:57:45 INFO - 'TERM': 'linux', 08:57:45 INFO - 'TMOUT': '86400', 08:57:45 INFO - 'USER': 'cltbld', 08:57:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:45 INFO - '_': '/tools/buildbot/bin/python'} 08:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 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 08:57:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:57:47 INFO - Installing collected packages: mozsystemmonitor 08:57:47 INFO - Running setup.py install for mozsystemmonitor 08:57:47 INFO - Successfully installed mozsystemmonitor 08:57:47 INFO - Cleaning up... 08:57:47 INFO - Return code: 0 08:57:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:47 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 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:47 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 08:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:57:47 INFO - Using env: {'DISPLAY': ':0', 08:57:47 INFO - 'HOME': '/home/cltbld', 08:57:47 INFO - 'LANG': 'en_US.UTF-8', 08:57:47 INFO - 'LANGUAGE': 'en_US:en', 08:57:47 INFO - 'LOGNAME': 'cltbld', 08:57:47 INFO - 'MAIL': '/var/mail/cltbld', 08:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:47 INFO - 'MOZ_NO_REMOTE': '1', 08:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:47 INFO - 'NO_EM_RESTART': '1', 08:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:47 INFO - 'PWD': '/builds/slave/test', 08:57:47 INFO - 'SHELL': '/bin/bash', 08:57:47 INFO - 'SHLVL': '1', 08:57:47 INFO - 'TERM': 'linux', 08:57:47 INFO - 'TMOUT': '86400', 08:57:47 INFO - 'USER': 'cltbld', 08:57:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:47 INFO - '_': '/tools/buildbot/bin/python'} 08:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:57:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:57:49 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 08:57:49 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 08:57:49 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 08:57:49 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 08:57:49 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 08:57:49 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 08:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:57:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:57:50 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 08:57:50 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 08:57:50 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 08:57:50 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 08:57:50 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 08:57:50 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 08:57:50 INFO - Downloading docopt-0.6.1.tar.gz 08:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:57:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:57:50 INFO - Running setup.py install for blobuploader 08:57:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:57:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:57:50 INFO - Running setup.py install for requests 08:57:50 INFO - Running setup.py install for docopt 08:57:51 INFO - Successfully installed blobuploader requests docopt 08:57:51 INFO - Cleaning up... 08:57:51 INFO - Return code: 0 08:57:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:51 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 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:51 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 08:57:51 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 08:57:51 INFO - Using env: {'DISPLAY': ':0', 08:57:51 INFO - 'HOME': '/home/cltbld', 08:57:51 INFO - 'LANG': 'en_US.UTF-8', 08:57:51 INFO - 'LANGUAGE': 'en_US:en', 08:57:51 INFO - 'LOGNAME': 'cltbld', 08:57:51 INFO - 'MAIL': '/var/mail/cltbld', 08:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:51 INFO - 'MOZ_NO_REMOTE': '1', 08:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:51 INFO - 'NO_EM_RESTART': '1', 08:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:51 INFO - 'PWD': '/builds/slave/test', 08:57:51 INFO - 'SHELL': '/bin/bash', 08:57:51 INFO - 'SHLVL': '1', 08:57:51 INFO - 'TERM': 'linux', 08:57:51 INFO - 'TMOUT': '86400', 08:57:51 INFO - 'USER': 'cltbld', 08:57:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:51 INFO - '_': '/tools/buildbot/bin/python'} 08:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:51 INFO - Running setup.py (path:/tmp/pip-lNrJ7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:51 INFO - Running setup.py (path:/tmp/pip-efFT7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:51 INFO - Running setup.py (path:/tmp/pip-2P0CPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:51 INFO - Running setup.py (path:/tmp/pip-JMDvcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:51 INFO - Running setup.py (path:/tmp/pip-NYOd74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:51 INFO - Running setup.py (path:/tmp/pip-rFoHOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:51 INFO - Running setup.py (path:/tmp/pip-MtHrT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:51 INFO - Running setup.py (path:/tmp/pip-zK_IP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:51 INFO - Running setup.py (path:/tmp/pip-odgwcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:52 INFO - Running setup.py (path:/tmp/pip-WKM5mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:52 INFO - Running setup.py (path:/tmp/pip-0XrXVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:52 INFO - Running setup.py (path:/tmp/pip-jm6PDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:52 INFO - Running setup.py (path:/tmp/pip-8CQZDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:52 INFO - Running setup.py (path:/tmp/pip-1SlIfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:52 INFO - Running setup.py (path:/tmp/pip-3XlHUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:52 INFO - Running setup.py (path:/tmp/pip-0HFpHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:52 INFO - Running setup.py (path:/tmp/pip-Kj1A3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:52 INFO - Running setup.py install for manifestparser 08:57:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:52 INFO - Running setup.py install for mozcrash 08:57:52 INFO - Running setup.py install for mozdebug 08:57:52 INFO - Running setup.py install for mozdevice 08:57:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for mozfile 08:57:53 INFO - Running setup.py install for mozhttpd 08:57:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for mozinfo 08:57:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for mozInstall 08:57:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for mozleak 08:57:53 INFO - Running setup.py install for mozlog 08:57:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for moznetwork 08:57:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for mozprocess 08:57:53 INFO - Running setup.py install for mozprofile 08:57:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Running setup.py install for mozrunner 08:57:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:54 INFO - Running setup.py install for mozscreenshot 08:57:54 INFO - Running setup.py install for moztest 08:57:54 INFO - Running setup.py install for mozversion 08:57:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:54 INFO - Cleaning up... 08:57:54 INFO - Return code: 0 08:57:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:54 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')]} 08:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:54 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')]} 08:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:54 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 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:54 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 08:57:54 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 08:57:54 INFO - Using env: {'DISPLAY': ':0', 08:57:54 INFO - 'HOME': '/home/cltbld', 08:57:54 INFO - 'LANG': 'en_US.UTF-8', 08:57:54 INFO - 'LANGUAGE': 'en_US:en', 08:57:54 INFO - 'LOGNAME': 'cltbld', 08:57:54 INFO - 'MAIL': '/var/mail/cltbld', 08:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:54 INFO - 'MOZ_NO_REMOTE': '1', 08:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:54 INFO - 'NO_EM_RESTART': '1', 08:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:54 INFO - 'PWD': '/builds/slave/test', 08:57:54 INFO - 'SHELL': '/bin/bash', 08:57:54 INFO - 'SHLVL': '1', 08:57:54 INFO - 'TERM': 'linux', 08:57:54 INFO - 'TMOUT': '86400', 08:57:54 INFO - 'USER': 'cltbld', 08:57:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:54 INFO - '_': '/tools/buildbot/bin/python'} 08:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:54 INFO - Running setup.py (path:/tmp/pip-zdlEwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:54 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)) 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:54 INFO - Running setup.py (path:/tmp/pip-b5WmLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:54 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)) 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:54 INFO - Running setup.py (path:/tmp/pip-BlcL1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:54 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)) 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:54 INFO - Running setup.py (path:/tmp/pip-RtJfaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:54 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)) 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:54 INFO - Running setup.py (path:/tmp/pip-xVXjsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:54 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)) 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:54 INFO - Running setup.py (path:/tmp/pip-ZIf6MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:55 INFO - Running setup.py (path:/tmp/pip-vw6uoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:55 INFO - Running setup.py (path:/tmp/pip-ihQhGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:55 INFO - Running setup.py (path:/tmp/pip-Klk7tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:55 INFO - Running setup.py (path:/tmp/pip-nJYM3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:55 INFO - Running setup.py (path:/tmp/pip-Bg3LRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:55 INFO - Running setup.py (path:/tmp/pip-iHUw20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:55 INFO - Running setup.py (path:/tmp/pip-zlUmk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:55 INFO - Running setup.py (path:/tmp/pip-wDMlUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:55 INFO - Running setup.py (path:/tmp/pip-2cSCB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:55 INFO - Running setup.py (path:/tmp/pip-KRwQ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:55 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)) 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:55 INFO - Running setup.py (path:/tmp/pip-JbtZAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:55 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)) 08:57:55 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)) 08:57:55 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)) 08:57:55 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)) 08:57:55 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)) 08:57:55 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)) 08:57:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:57 INFO - Downloading blessings-1.6.tar.gz 08:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:57 INFO - Installing collected packages: blessings 08:57:57 INFO - Running setup.py install for blessings 08:57:57 INFO - Successfully installed blessings 08:57:57 INFO - Cleaning up... 08:57:57 INFO - Return code: 0 08:57:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:58 INFO - Reading from file tmpfile_stdout 08:57:58 INFO - Current package versions: 08:57:58 INFO - argparse == 1.2.1 08:57:58 INFO - blessings == 1.6 08:57:58 INFO - blobuploader == 1.2.4 08:57:58 INFO - docopt == 0.6.1 08:57:58 INFO - manifestparser == 1.1 08:57:58 INFO - mozInstall == 1.12 08:57:58 INFO - mozcrash == 0.17 08:57:58 INFO - mozdebug == 0.1 08:57:58 INFO - mozdevice == 0.48 08:57:58 INFO - mozfile == 1.2 08:57:58 INFO - mozhttpd == 0.7 08:57:58 INFO - mozinfo == 0.9 08:57:58 INFO - mozleak == 0.1 08:57:58 INFO - mozlog == 3.1 08:57:58 INFO - moznetwork == 0.27 08:57:58 INFO - mozprocess == 0.22 08:57:58 INFO - mozprofile == 0.28 08:57:58 INFO - mozrunner == 6.11 08:57:58 INFO - mozscreenshot == 0.1 08:57:58 INFO - mozsystemmonitor == 0.0 08:57:58 INFO - moztest == 0.7 08:57:58 INFO - mozversion == 1.4 08:57:58 INFO - psutil == 3.1.1 08:57:58 INFO - requests == 1.2.3 08:57:58 INFO - wsgiref == 0.1.2 08:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:58 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 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57:58 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 08:57:58 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 08:57:58 INFO - Using env: {'DISPLAY': ':0', 08:57:58 INFO - 'HOME': '/home/cltbld', 08:57:58 INFO - 'LANG': 'en_US.UTF-8', 08:57:58 INFO - 'LANGUAGE': 'en_US:en', 08:57:58 INFO - 'LOGNAME': 'cltbld', 08:57:58 INFO - 'MAIL': '/var/mail/cltbld', 08:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:58 INFO - 'MOZ_NO_REMOTE': '1', 08:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:58 INFO - 'NO_EM_RESTART': '1', 08:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:58 INFO - 'PWD': '/builds/slave/test', 08:57:58 INFO - 'SHELL': '/bin/bash', 08:57:58 INFO - 'SHLVL': '1', 08:57:58 INFO - 'TERM': 'linux', 08:57:58 INFO - 'TMOUT': '86400', 08:57:58 INFO - 'USER': 'cltbld', 08:57:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:58 INFO - '_': '/tools/buildbot/bin/python'} 08:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 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)) 08:57:58 INFO - Cleaning up... 08:57:58 INFO - Return code: 0 08:57:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:57: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', 'jsonschema'] in /builds/slave/test/build 08:57: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 jsonschema 08:57:58 INFO - Using env: {'DISPLAY': ':0', 08:57:58 INFO - 'HOME': '/home/cltbld', 08:57:58 INFO - 'LANG': 'en_US.UTF-8', 08:57:58 INFO - 'LANGUAGE': 'en_US:en', 08:57:58 INFO - 'LOGNAME': 'cltbld', 08:57:58 INFO - 'MAIL': '/var/mail/cltbld', 08:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:58 INFO - 'MOZ_NO_REMOTE': '1', 08:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:58 INFO - 'NO_EM_RESTART': '1', 08:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:58 INFO - 'PWD': '/builds/slave/test', 08:57:58 INFO - 'SHELL': '/bin/bash', 08:57:58 INFO - 'SHLVL': '1', 08:57:58 INFO - 'TERM': 'linux', 08:57:58 INFO - 'TMOUT': '86400', 08:57:58 INFO - 'USER': 'cltbld', 08:57:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:58 INFO - '_': '/tools/buildbot/bin/python'} 08:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:58 INFO - Downloading/unpacking jsonschema 08:57: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 08:57: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 08:57: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 08:57: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 08:57: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 08:57: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 08:58:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:58:00 INFO - Downloading/unpacking functools32 (from jsonschema) 08:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:58:00 INFO - warning: no files found matching '*.txt' 08:58:00 INFO - no previously-included directories found matching 'build' 08:58:00 INFO - no previously-included directories found matching 'dist' 08:58:00 INFO - no previously-included directories found matching '.git*' 08:58:00 INFO - Installing collected packages: jsonschema, functools32 08:58:00 INFO - Running setup.py install for functools32 08:58:00 INFO - warning: no files found matching '*.txt' 08:58:00 INFO - no previously-included directories found matching 'build' 08:58:00 INFO - no previously-included directories found matching 'dist' 08:58:00 INFO - no previously-included directories found matching '.git*' 08:58:00 INFO - Successfully installed jsonschema functools32 08:58:00 INFO - Cleaning up... 08:58:00 INFO - Return code: 0 08:58:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ef142cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', '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 08:58: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', 'flake8'] in /builds/slave/test/build 08:58: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 flake8 08:58:00 INFO - Using env: {'DISPLAY': ':0', 08:58:00 INFO - 'HOME': '/home/cltbld', 08:58:00 INFO - 'LANG': 'en_US.UTF-8', 08:58:00 INFO - 'LANGUAGE': 'en_US:en', 08:58:00 INFO - 'LOGNAME': 'cltbld', 08:58:00 INFO - 'MAIL': '/var/mail/cltbld', 08:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:00 INFO - 'MOZ_NO_REMOTE': '1', 08:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:00 INFO - 'NO_EM_RESTART': '1', 08:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:00 INFO - 'PWD': '/builds/slave/test', 08:58:00 INFO - 'SHELL': '/bin/bash', 08:58:00 INFO - 'SHLVL': '1', 08:58:00 INFO - 'TERM': 'linux', 08:58:00 INFO - 'TMOUT': '86400', 08:58:00 INFO - 'USER': 'cltbld', 08:58:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:00 INFO - '_': '/tools/buildbot/bin/python'} 08:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:01 INFO - Downloading/unpacking flake8 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:58:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:58:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:58:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:58:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:58:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:58:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:58:03 INFO - no previously-included directories found matching 'docs/_build' 08:58:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:58:03 INFO - Running setup.py install for pep8 08:58:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:58:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:58:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:58:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:58:03 INFO - no previously-included directories found matching 'docs/_build' 08:58:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:58:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:58:03 INFO - Cleaning up... 08:58:04 INFO - Return code: 0 08:58:04 INFO - Running post-action listener: _resource_record_post_action 08:58:04 INFO - Running post-action listener: _start_resource_monitoring 08:58:04 INFO - Starting resource monitoring. 08:58:04 INFO - ##### 08:58:04 INFO - ##### Running install step. 08:58:04 INFO - ##### 08:58:04 INFO - Running pre-action listener: _resource_record_pre_action 08:58:04 INFO - Running main action method: install 08:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:04 INFO - Reading from file tmpfile_stdout 08:58:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:58:04 INFO - Reading from file tmpfile_stdout 08:58:04 INFO - Output received: 08:58:04 INFO - Usage: mozinstall [options] installer 08:58:04 INFO - Options: 08:58:04 INFO - -h, --help show this help message and exit 08:58:04 INFO - -d DEST, --destination=DEST 08:58:04 INFO - Directory to install application into. [default: 08:58:04 INFO - "/builds/slave/test"] 08:58:04 INFO - --app=APP Application being installed. [default: firefox] 08:58:04 INFO - mkdir: /builds/slave/test/build/application 08:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:58:19 INFO - Reading from file tmpfile_stdout 08:58:19 INFO - Output received: 08:58:19 INFO - /builds/slave/test/build/application/firefox/firefox 08:58:19 INFO - Running post-action listener: _resource_record_post_action 08:58:19 INFO - ##### 08:58:19 INFO - ##### Running run-tests step. 08:58:19 INFO - ##### 08:58:19 INFO - Running pre-action listener: _resource_record_pre_action 08:58:19 INFO - Running main action method: run_tests 08:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:58:19 INFO - Python 2.7.3 08:58:19 INFO - Return code: 0 08:58:19 INFO - grabbing minidump binary from tooltool 08:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:19 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 0x1f75410>, '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 0x1f76310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f767a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:58:19 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 08:58:19 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 08:58:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:58:20 INFO - Return code: 0 08:58:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:58:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:58:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:58:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:58:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:58:20 INFO - Return code: 0 08:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 08:58:20 INFO - Using env: {'DISPLAY': ':0', 08:58:20 INFO - 'HOME': '/home/cltbld', 08:58:20 INFO - 'LANG': 'en_US.UTF-8', 08:58:20 INFO - 'LANGUAGE': 'en_US:en', 08:58:20 INFO - 'LOGNAME': 'cltbld', 08:58:20 INFO - 'MAIL': '/var/mail/cltbld', 08:58:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:58:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:20 INFO - 'MOZ_NO_REMOTE': '1', 08:58:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:20 INFO - 'NO_EM_RESTART': '1', 08:58:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:20 INFO - 'PWD': '/builds/slave/test', 08:58:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:58:20 INFO - 'SHELL': '/bin/bash', 08:58:20 INFO - 'SHLVL': '1', 08:58:20 INFO - 'TERM': 'linux', 08:58:20 INFO - 'TMOUT': '86400', 08:58:20 INFO - 'USER': 'cltbld', 08:58:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111', 08:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:20 INFO - '_': '/tools/buildbot/bin/python'} 08:58:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:58:21 INFO - mozversion application_buildid: 20160526062249 08:58:21 INFO - mozversion application_changeset: b0a5f5e149d2fa1aae0fd81801671369100a9580 08:58:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:58:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:58:21 INFO - mozversion application_name: Firefox 08:58:21 INFO - mozversion application_remotingname: firefox-dev 08:58:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:58:21 INFO - mozversion application_vendor: Mozilla 08:58:21 INFO - mozversion application_version: 48.0a2 08:58:21 INFO - mozversion platform_buildid: 20160526062249 08:58:21 INFO - mozversion platform_changeset: b0a5f5e149d2fa1aae0fd81801671369100a9580 08:58:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:58:21 INFO - mozversion platform_version: 48.0a2 08:58:21 INFO - using testdate: 1464278301 08:58:21 INFO - actual date: 1464278301 08:58:21 INFO - starting webserver on 'localhost:53542' 08:58:21 INFO - SUITE-START | Running 2 tests 08:58:21 INFO - TEST-START | dromaeo_css 08:58:21 INFO - operating with platform_type : linux_ 08:58:21 INFO - Initialising browser for dromaeo_css test... 08:58:21 INFO - TEST-INFO | started process 22846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHahMb/profile http://localhost:53542/getInfo.html) 08:58:25 INFO - PROCESS | 22846 | __metrics Screen width/height:1600/1200 08:58:25 INFO - PROCESS | 22846 | colorDepth:24 08:58:25 INFO - PROCESS | 22846 | Browser inner width/height: 1024/697 08:58:25 INFO - PROCESS | 22846 | __metrics 08:58:26 ERROR - PROCESS | 22846 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:58:26 INFO - TEST-INFO | 22846: exit 0 08:58:26 INFO - Browser initialized. 08:58:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:58:26 INFO - TEST-INFO | started process 22939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHahMb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:38 INFO - PROCESS | 22939 | RSS: Main: 142012416 08:58:38 INFO - PROCESS | 22939 | 08:59:29 INFO - PROCESS | 22939 | 1464278369682 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] 09:01:37 INFO - PROCESS | 22939 | Cycle 1(1): loaded http://localhost:53542/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53542/tests/dromaeo/cssquery-ext.html) 09:01:38 INFO - PROCESS | 22939 | RSS: Main: 252833792 09:01:38 INFO - PROCESS | 22939 | 09:04:40 INFO - PROCESS | 22939 | Cycle 1(1): loaded http://localhost:53542/tests/dromaeo/cssquery-ext.html (next: http://localhost:53542/tests/dromaeo/cssquery-jquery.html) 09:04:41 INFO - PROCESS | 22939 | RSS: Main: 229810176 09:04:41 INFO - PROCESS | 22939 | 09:07:43 INFO - PROCESS | 22939 | Cycle 1(1): loaded http://localhost:53542/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53542/tests/dromaeo/cssquery-mootools.html) 09:07:43 INFO - PROCESS | 22939 | RSS: Main: 220315648 09:07:43 INFO - PROCESS | 22939 | 09:10:45 INFO - PROCESS | 22939 | Cycle 1(1): loaded http://localhost:53542/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53542/tests/dromaeo/cssquery-prototype.html) 09:10:46 INFO - PROCESS | 22939 | RSS: Main: 220676096 09:10:46 INFO - PROCESS | 22939 | 09:13:48 INFO - PROCESS | 22939 | Cycle 1(1): loaded http://localhost:53542/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53542/tests/dromaeo/cssquery-yui.html) 09:13:49 INFO - PROCESS | 22939 | RSS: Main: 185053184 09:13:49 INFO - PROCESS | 22939 | 09:16:51 INFO - PROCESS | 22939 | Cycle 1(1): loaded http://localhost:53542/tests/dromaeo/cssquery-yui.html (next: http://localhost:53542/tests/dromaeo/cssquery-dojo.html) 09:16:52 INFO - PROCESS | 22939 | RSS: Main: 255213568 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | __start_tp_report 09:16:52 INFO - PROCESS | 22939 | _x_x_mozilla_page_load 09:16:52 INFO - PROCESS | 22939 | _x_x_mozilla_page_load_details 09:16:52 INFO - PROCESS | 22939 | |i|pagename|runs| 09:16:52 INFO - PROCESS | 22939 | |0;dojo.html;3323.3851737428577;3388.745844061696;3391.0844072100535;3411.7782344147645;3441.62142164362;5496.560275177986;5525.4474552544725;5533.612647114698;5555.944440555603;5561.6106872518885;5544.805931792388;5569.777208911639;5574;5578.525825304844;5611.523020543248;5007.449180590151;5032.220005899073;5118.872028199287;5156.226566015091;5196.58427325813;5061.746912654371;5166.147585648364;5166.405863325709;5167.7932882684645;5175.120229560984;5093.898122037557;5149.922751158736;5164.741762911858;5181.35233095863;5200.947990520084;5089.312942752755;5109.259157422153;5111.02890450815;5113.1052065888325;5137.101007323741;4981.526754958273;4991.50084991498;5046.924296135561;5049.368828896388;5063.87340316495;5505.834824955257;5533.6403133796175;5549.77800887964;5560.221568980346;5583.609147359686;5980.162777211194;5995.400459954013;6002.309734380515;6002.489788367994;6003.609765365237;6028.608140470899;6049.697515124226;6088.990638077117;6130.938690613081;6143.662098584576;5620.9437905620825;5673.290838645169;5676.801311954062;5680.914786278167;5681.147827825776;5951.166836642873;6168.475679567287;6173.81478555644;6178.073289006595;6180.412860778219;5915;5951.702414879239;5960.523158147338;5974.761009559569;5979.312379076375;5923.200367950271;5923.881522369528;5926.170336152942;5932.0508718604815;5937.168796368512;5806.622569532967;5902.527797776168;5907.261592300963;5917.940820591739;5934.020886553671;5950.732217050243;5958.76164953397;5971.164037034819;5973.522118230531;5993.820185394358;4549.909001819945;4550.840720574764;4551.52209018055;4564.087182563434;4582.404287442611;3933.7443066200603;4022.517297924268;4075.4294398784195;4095.672346212296;4107.0553772631865;5717.799877004285;5739.053056245672;5746.569007324468;5748.827535173951;5759.22250496186;6079.088136779518;6080.361562035922;6080.7567697291615;6091.817245482643;6095.512359011268;5590.24531688225;5618.073017952074;5647.576431767634;5665.093585026459;5667.773289068391;5135.563477104488;5139.434662187156;5166.741662916839;5169.043726910533;5193.506616871391;6235.688215589203;6257.342978987141;6260.530460215502;6261.530385221035;6265.028920517327;5882.23530940975;5936;6005.429484198994;6034.24571928509;6038;6233.594816336924;6258.43674069336;6265.746850629984;6269.435750782452;6277.30949595535;5810.593258471867;5932.881342373042;5939.07944268639;5943.375945525658;5980.910286345621;5992.340842507408;6042.84892877664;6051.273847138372;6060.545459090674;6090.634561926121;5808.21589085485;5822.039363505143;5826.242588463472;5827.59206855533;5827.94172058274;5716.28546431696;5760.33756118035;5823.039198532195;5832.3292821326095;5850.590458668023;5774.0761478163295;5818.214541036906;5819.883602327845;5835.037218858841;5862.618929769551;5936.762529498772;5940.376260492586;5949.762009519571;5956.672383018976;5957.106434034929;5732.7706891723865;5760.395158508296;5828.446297601721;5835.270591176103;5849.444302791228 09:16:52 INFO - PROCESS | 22939 | |1;ext.html;604.6795198544772;655.4625207329989;658.4436151452023;672.4922683374049;735.980666776515;31915;39362;39647.40528892065;39678.40482392767;39686.40470392947;42575.78712106443;43608.56391436085;43610.34584481228;43615.78192109035;43659;8170.101288858221;8310.085890552034;8717.738467845958;8918.108189181095;10242;10242.180625549976;10339.483025848715;10354.17166626668;10368.740781480486;10369.740756481111;10358.27492075555;10362.015608517217;10362.430066346347;10368.06687398134;10372.273940824145;8298.087210406851;10197.13324367426;10270.435126068063;10474.47627618616;10476.1095306899;10517.579296828118;10623.25637205396;10635.149188064936;10637.149028077734;10638.946805265925;39456;39578.60421395778;39702.60297397018;39832.80083599593;39979.60020399788;3768.152165762709;3808.619138086169;3828.1960788234505;3919.7844118573466;4175.269327867642;30502.210521086792;31033.22416939572;31112.222194445094;31345.373092538022;31445.685543144504;3770.453284273765;3805.809709514541;3810.9809450952844;3811.5235595550557;3898.707596930213;322147;324987;325022;325752;326091;40011.199776004316;40488.1902361957;66121;66895.33104668891;67335.32664673291;38144.809275953994;38451.42322865159;38585.614143858205;38590.614093859265;38604.420933686015;15812.288447019911;16032.278547465392;16122.113283769271;16132;16149.59626009359;12571.497140114294;13439.462421503225;13469.797953030713;13487.988400869974;13548.254845983369;9320.347575669774;9344.579493922789;9362.063793620584;9390.342676012613;9439.056094390644;3585.2112535242204;3638.0541059324764;3647.744657873923;3720.9069773255887;3757.7933213672964;1048.2295512798087;1067.2582555124113;1121.2263538158645;1152.4929031226234;1194.0924897078282;33763;34834.65165348365;34875.476867847;34977.825110874284;35042.29915401678;1158.6581958322315;1189.1735244005506;1209.2140108929266;1213.8664746877837;1259.9433025513874;16423.55429620467;16768.916155419145;16955.660886782196;17095.658086838193;17135.74296385555;439452;445926;446218;446674;446873;58883.70558147182;60157;60203.698981504815;60271.09593356103;60287;1398.6922876966848;1407.6973450707942;1410.4217270918873;1474.609228554434;1510.1316742872891;24493.877530612233;30886.382272354876;31081.68918310788;31232.063038108892;31440.528392074593;55691.44308556862;57026.714866425405;57042.42957570371;57051.42948570461;57079;415646;420313;420411;421209;421888;27418.314542136606;27882.58176127319;30348.54477182888;30706.385872282877;30710.23224419318;41306;43160.568394315655;43200;43251.78374108109;43690;35145;35463.86407147399;36392.63607363999;38955.805220973714;39600.40599391069;38177;38246;38867.222655547295;38904;40063.39904901487;40367.39448908327;40975.38536922008;41265;41562.168756624094;41601.58398415977;34136.14659633529;37295.62704372922;38626.80686596549;38673.41989870098;39145.41281880717;26499.735002649726;26559.867200663874;27071.86464067667;28782.280442989093;29097.272568185967 09:16:52 INFO - PROCESS | 22939 | |2;jquery.html;432.3255721075122;432.44214962698123;433.18893702099297;434.545899534986;446.906149708561;19169.712454313198;19259.229630814767;19815.5046123847;20158.395248142544;20193.697094543557;19389.806101938975;19637.214511419563;20497.487562810937;20516.28193013245;20527.486812829688;5425.864353391157;5623.156526521034;5631.465010823965;5637.774489020455;5656.095024796024;4080.5307389650275;5571.470710282537;5595.664260144384;5656.547476201915;5900.793472228473;5828.446297601721;5853.941460585404;5911.704414779266;5912.970435147839;5914.733836977346;5517.917231241535;5618.353889302742;5680.488756011958;5681.829545113653;5806.274215723035;3910.6480416762342;4057.5536690963972;5406.324209473816;5525.281713377235;5556.222128901957;13023.34883255843;13066.673333166651;13106.213627182304;13206;16000.919995399949;2320.524292520029;2401.183597576832;2469.9135530256353;2489.7136829264505;2530.4180038591044;10908.454577271184;11209.943950280196;11277.774444511146;12038.81941770874;14311.35598898052;1995.5510010247724;2018.798120187984;2042.3158241988804;2073.243266207823;2079.8024187702144;75624;80662.59668701678;81219.5939020307;81842.9999999994;83365.58317208375;11072.889271107348;11294.774104517863;11510.48930076318;11534.653960381202;11656.18406711522;16541.172941352885;16626;16639;16643.83356166447;16696.08171550552;8947.3736838422;8966.103389660982;9014.774630634287;9070.460271124095;9160.633574657073;8889.511076890703;8954.552272386354;8962.834831471997;8980.955095224483;9086.772830679285;5047.722375269322;5086.338775959176;5097.923531146962;5165.328507294028;5244.082285600005;1838.5415367733194;1994.1724184463285;2048.9385318440472;2055.7533096028574;2113.7780533044115;1024.882138554061;1063.505469956474;1109.8501702270253;1186.6440067979572;1211.2308683985732;18181.090945452674;18467.261309547466;18659.720104198448;19191.232350705814;19377.51556211106;1042.569944881347;1045.7019749371393;1090.1278976818671;1103.2387652519735;1112.1380929779325;10576.471176441148;10921.12630989519;10948.562057517769;10984.231103822656;11058.447077646086;510197;512844;528130;528541;534138;57073;57166.42833571694;101106.4944675272;102411.4879425598;102512.48743756233;1102.9999999999839;1133.7392399748105;1143.108375467137;1143.1712008793559;1150.5455345138791;17510.649787004444;17588.472345829647;17666.381676641256;17944.551386215448;17950.19224134891;41917.16165676608;43201;43237.135257295304;43370.566294336655;43994.78002610095;62233;63269.36730632819;63481.365186349394;63658.363416365246;63660.68169659307;9321.906780932104;9422.811543769223;9502.382345147544;9526.857097143687;9553.478712357295;12815.487380504675;13683.86316136826;13686.110402823784;13984.720305593628;14087.15477071379;11815.881841181477;11888.167828251939;11905.94047029794;11938.820917686415;12078.939605301917;11935.76128477443;12007.699807504881;12112.091593130373;12324.322162280801;12358.196717213352;12131.636050918487;12159.75680486403;12282.447289871798;12316.322602256962;12394.442250098587;9139.497327647043;9153.679621213225;9267.490288034223;9309.534523273946;9338.626454941726;9349.439033658002;11713.531458741896;11951.94024029909;12166.635000949986;12240.326782026717 09:16:52 INFO - PROCESS | 22939 | |3;mootools.html;1449.3695242569477;1566.9999999999998;1580.0756557413913;1757.6378306812219;1903.7620297462818;7899.328557072648;8561.486310821356;8697.434666746656;8707.042225355213;8709.608067636957;8565.828683426327;8760;8763.211310982011;8763.693270735526;8766;2127.6595744680853;2317.432229103872;2344.0975224538506;2406.566817972764;2470.0737223541173;2428.4285380163533;2436.9512609747794;2453.681021467207;2460.5447992121426;2460.9138680146198;2430.756924307564;2446.107170882624;2470.1848390031337;2478.0707234786955;2479.2562231330617;2041.0713125527923;2358.7169539655265;2405.903763849453;2409.4578719787905;2410.1082599438146;2261.3329067925;2289.9313020609407;2295.517941232343;2300.861948283108;2324.3027091872373;8706.21644052032;8717.171868672465;8738.825223495494;8776.912230877737;8780.078091800397;5424.0236757383655;5500.3949565547755;5525.254090697745;5541.251930989305;5543.6396634218645;3372.763906526544;3373.865045398206;3399.065257054305;3437.1750779812915;3440.552728145325;1068.2575609951086;1072.3780207479642;1075.3547871277249;1084.5607528950788;1091.9344839309588;12938.353082345939;12944.417501212374;12963.481460741465;12993.805092923614;13013.154144980546;4764.976175119103;4806.8223285294625;4830.106430310404;4846.539578740014;4921.975390123026;10737.302075365076;10773.62292319765;10780.083692886035;10782.838257426145;10788.298760580537;4939.506049395103;5404.621676482687;5422.15956526739;5425.348958125051;5428.4842939920645;4461.24158892989;4462.286034234507;4465.419495465569;5040.193569029011;5056.64603477753;4173.353130264813;4185.623293903503;4238.851640192578;4260.893477663021;4264.125854199881;1358.2529608715167;1358.5788405594296;1372.2384076837452;1389.062382891544;1394.8884089272833;976.345848281653;987.3779518903189;989.4904124375952;991.7949691125174;1000.5947591225565;5979.970100149559;6048.818535443856;6055.7274922628585;6087.482563982023;6122.387761223842;480.77884173279983;492.57638430949356;496.5406998526349;497.1101727907006;497.73868718922853;4180.728252663567;4206.558311377261;4225.894352641209;4268.295731204316;4279.97860010698;10691.893081069089;10999.34003959765;11003.284786488852;11025.558977640965;11083.944580277048;11002.50488728009;11007.229493935507;11140.442977851075;11185.384803835866;11207.327560346404;8533.061363250037;8534.701285455103;8580.313574913991;8581.656733730706;8631.395802293904;6050.6369617823075;6057.091436284416;6082.756689732361;6209.96895015522;6224.844378890564;9848.803023939625;9977.850332245167;10174.542145603613;10195.949020254851;10200.693979180636;10092.091711745978;10161.644342447978;10196.909966949495;10266;10359.94820025895;7143.2499587544635;7637.198094200029;7812.3359514439635;7945.48354356965;8089.069756978023;8149;8168.305694016075;8214.548199848827;8225.341972642054;8244.587770611326;7431;7618.200088990576;7754.961225193838;7787.766367008999;7891.131975482577;7620.504667196615;7759.1852855451625;7761.379089672925;7863.646135923783;7891.763247102366;7274.418046556369;7322.340989310987;7325.853482930205;7345.412367010519;7351.228121047213;5176.559992400688;5199.74001299941;5297.761600727899;5344.091504444332;5378.811741589026;5140.068102163222;5183.974080129726;5378.919316210182;5380.542653874308;5409.86475338104 09:16:52 INFO - PROCESS | 22939 | |4;prototype.html;335.01839609942874;344.2048867116959;344.24610103872516;369.2964901861954;373.7365157563918;6269.9373006269925;6273.278572964105;6284.685765711713;6297.464715499176;6331.905021424671;5989.371116032819;6085.2393450818645;6241.344658810827;6243.594166379194;6286.968565157179;4755.833545825897;4783.665143439961;4793.185158523042;4797.736124513151;4805.975970120153;4791.377120974286;4800.015996720664;4805.279208118793;4815.759212039402;4817.51824817519;4565.360849481075;4669.276262179367;4750.21621432465;4780.904381912377;4792.736399498026;4791.832285869978;4803.3995750531185;4817.566419022305;4825.565699087081;4829.251466022772;4269.893252668709;4270.274053410928;4273.807678654437;4275.102228532012;4277.679174061957;6019.578629495937;6022.397760223987;6026.397360263939;6027.60820546663;6037.335893051761;5579.69311687857;5580.190872323531;5591.6365436246515;5600.943990560083;5602.215689803431;6409.551331406803;6540.9861471471995;6545.869082618321;6547.508936829757;6548;4692.859214223578;4708.152532544141;4716.080364328957;4719.528047195287;4721.551452611996;6865;6951.409130223937;6952.895706564405;6958.512904096715;6962;4828.348172996601;4830.033993201304;4830.2513110467935;4833.927491087637;4833.927491087637;4890.779914903838;4895.902081958412;4896.706197628154;4897.4857639947295;4902.4362198346935;5279.39286982002;5522.447755224445;5535.501804837503;5554.666719996813;5574.358948720868;6635.933640663531;6651.33486651331;6658.234303055211;6658.467322614276;6660.60036397808;1575.7478803391632;1626.162526298957;1656.1719140429784;1684.730443129118;1685.3679870048732;1077.5420446310286;1102.3771569063454;1103.9503222355013;1114.8104822180248;1119.92720473169;6442.291347951722;6463.127477790438;6482.124913136666;6500.414962653384;6508.511861610304;6779.0509328694025;6785.558938668971;6786;6796.320367963164;6799.524033317621;6392.26488953767;6397.10440538325;6413.390727880844;6414.166158399378;6421.8073457796345;3626.5829429615933;3662.9816850915577;3664.7434679572707;3665.2669466106886;3665.8350374233223;6989;7089.858202836018;7146.178189508273;7196.820079498055;7245.203027666952;6993.685284162225;7033.437325013987;7038.92961070393;7043.119610048744;7044.189918159374;7228.168760592494;7232;7234.674439650228;7246.818829529198;7257.963710181415;6902.171739391305;6909.343612356818;6923;6923.480738944499;6928;6594.340565943367;6805.081314022544;6820.113385259884;6827.249002609609;6836;7215.098112735908;7226.132864056347;7227.674754636159;7238.493305468777;7239.601821899846;4735.431748190239;4773.236282194832;4773.331733557236;4778.7849546769785;4779.952200477951;6605.933940660532;6891.104156459628;6898.896516552155;6909.965450172717;6911.619860907698;6510.381513756186;6629.138212032405;6632.900506492503;6723.159605049369;6733.595984240961;6639.53523253387;6654.83362915931;6658.334166583303;6670.066190733398;6670.266270710121;6554.14796076507;6554.541182117397;6561.639109849004;6562.376574225441;6578.901316480161;6607.5044371673275;6730.226024007302;6734.259231484435;6734.6632668367365;6756.628385438848;6555.80332590023;6574.671266436755;6576.44100251484;6589.7364105435245;6591.967040164768 09:16:52 INFO - PROCESS | 22939 | |5;yui.html;826.1078035721422;861.14316255326;876.5660997806086;885.3404213860675;916.7662246127237;15168.544943651681;15211.239438028097;15380.461683841067;15389.846101538982;15426.537203883874;13423.194608323507;13430.731385372312;13533.458661653547;13534.120282181651;13553.728925421485;735.7755884455239;750.0212223048919;752.3078767533882;752.7854561449988;877.4866702978733;889.3063410539756;892.7634176943116;893.4282059481936;893.4371346051978;895.2882458445551;930.0838673906197;937.8452555328363;938.2962777916563;940.3182692547882;940.3699521320732;940.5626383731529;941.5151197133482;941.6515889121;941.7127776028309;942.2179590939504;575.0712599152339;678.304737643914;680.4658343200613;681.4820736240443;685.1093578348177;14368.20974846383;14369.78445323321;14374.856251437457;14381.209033503153;14424;14355.210463424508;14849.70300593993;15044.172570508617;15217.239138043164;15270.541883743506;11576.710582235428;11904;12418.75162496745;12612.495500179983;12628.494860205581;3981.422693709425;3997.400389941503;4042.2117687051036;4105.938410923838;4126.216018956388;56655.43344566584;57074.14388784172;57478;58590;58788.70605646945;10239.232057595711;10292.948535257276;10492.483049039904;10547.894521054845;10650.946745266225;19660.70508942367;19668.508287292647;19696.901515492616;19732.60534789296;19735.703964440545;8738.606762695694;8821.823563528822;8822.77943051416;8833.867491987625;9152.816943661222;5202.271681964528;5315.3090098286975;5336.973315133399;5337.973310133424;5426.593005524602;3539.3275277697153;3606.1886075632774;3609.4405367168133;3617.4031284837706;3618.4029635110437;662.2483481248721;673.4713250098649;674.29872932151;680.9080774095434;693.0851276315216;702.6592102830124;711.8256027273351;776.6660336055437;780.4068907630242;785.9803504912309;9293.72118836436;9547.149281518126;9625.278104142217;10006.799864002825;10093.798124037477;686.9175698916162;690.6960937187621;793.305857374797;797.6649807081039;807.3460496997451;4581.060882519076;4624.606908412756;4773.9045219096115;4799.952000479951;4842.491538388418;62950.370496294454;64693.67653161798;66563.33436665668;67131.66434167798;67248.66375668091;54525.72737136289;55389.723051384484;56016.159757603666;56318;59185.70407147937;49719.50280497149;50442.24336634953;50473.49526504761;50820.491795082315;51846.48153518492;9274.489903055397;9440.575174117319;9470.715878523655;9651;9972.404415293518;36580;36738.63261367352;37605;38278.80860595791;38317;45042.32436513389;46268.768656156506;47557.762211188725;47925.520744792106;50360;12598;12765;12768.425420856269;13016.349182541024;13039.478420863059;13392.665183370495;14063.437462501386;14464.349104290543;14724.55826325212;15032.098074115587;12030.15788894769;12306.200096993667;12588.748225035264;13902.721945561234;13932.860671393562;12175.878241217475;12289.262644241375;12389.814152787536;13032.54386096482;13046.41291141882;12895.742085158057;13014.15407998477;13198;13203.207807531579;13426.127301725357;9940.602375904882;10005.499725013866;10341.9482902585;10521;10546.156307495536;10496.370217786956;10627.09669678055;10817;11006.559737610405;11049.392283424168 09:16:52 INFO - PROCESS | 22939 | __end_tp_report 09:16:52 INFO - PROCESS | 22939 | __start_cc_report 09:16:52 INFO - PROCESS | 22939 | _x_x_mozilla_cycle_collect,858 09:16:52 INFO - PROCESS | 22939 | __end_cc_report 09:16:52 INFO - PROCESS | 22939 | __startTimestamp1464279412030__endTimestamp 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | ------- Summary: start ------- 09:16:52 INFO - PROCESS | 22939 | Number of tests: 6 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | [#0] dojo.html Cycles:165 Average:5579.19 Median:5810.59 stddev:625.42 (10.8%) stddev-sans-first:601.79 09:16:52 INFO - PROCESS | 22939 | Values: 3323.4 3388.7 3391.1 3411.8 3441.6 5496.6 5525.4 5533.6 5555.9 5561.6 5544.8 5569.8 5574.0 5578.5 5611.5 5007.4 5032.2 5118.9 5156.2 5196.6 5061.7 5166.1 5166.4 5167.8 5175.1 5093.9 5149.9 5164.7 5181.4 5200.9 5089.3 5109.3 5111.0 5113.1 5137.1 4981.5 4991.5 5046.9 5049.4 5063.9 5505.8 5533.6 5549.8 5560.2 5583.6 5980.2 5995.4 6002.3 6002.5 6003.6 6028.6 6049.7 6089.0 6130.9 6143.7 5620.9 5673.3 5676.8 5680.9 5681.1 5951.2 6168.5 6173.8 6178.1 6180.4 5915.0 5951.7 5960.5 5974.8 5979.3 5923.2 5923.9 5926.2 5932.1 5937.2 5806.6 5902.5 5907.3 5917.9 5934.0 5950.7 5958.8 5971.2 5973.5 5993.8 4549.9 4550.8 4551.5 4564.1 4582.4 3933.7 4022.5 4075.4 4095.7 4107.1 5717.8 5739.1 5746.6 5748.8 5759.2 6079.1 6080.4 6080.8 6091.8 6095.5 5590.2 5618.1 5647.6 5665.1 5667.8 5135.6 5139.4 5166.7 5169.0 5193.5 6235.7 6257.3 6260.5 6261.5 6265.0 5882.2 5936.0 6005.4 6034.2 6038.0 6233.6 6258.4 6265.7 6269.4 6277.3 5810.6 5932.9 5939.1 5943.4 5980.9 5992.3 6042.8 6051.3 6060.5 6090.6 5808.2 5822.0 5826.2 5827.6 5827.9 5716.3 5760.3 5823.0 5832.3 5850.6 5774.1 5818.2 5819.9 5835.0 5862.6 5936.8 5940.4 5949.8 5956.7 5957.1 5732.8 5760.4 5828.4 5835.3 5849.4 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | [#1] ext.html Cycles:180 Average:55390.94 Median:3762.97 stddev:105685.17 (2808.6%) stddev-sans-first:105901.59 09:16:52 INFO - PROCESS | 22939 | Values: 604.7 655.5 658.4 672.5 736.0 31915.0 39362.0 39647.4 39678.4 39686.4 42575.8 43608.6 43610.3 43615.8 43659.0 8170.1 8310.1 8717.7 8918.1 10242.0 10242.2 10339.5 10354.2 10368.7 10369.7 10358.3 10362.0 10362.4 10368.1 10372.3 8298.1 10197.1 10270.4 10474.5 10476.1 10517.6 10623.3 10635.1 10637.1 10638.9 39456.0 39578.6 39702.6 39832.8 39979.6 3768.2 3808.6 3828.2 3919.8 4175.3 30502.2 31033.2 31112.2 31345.4 31445.7 3770.5 3805.8 3811.0 3811.5 3898.7 322147.0 324987.0 325022.0 325752.0 326091.0 40011.2 40488.2 66121.0 66895.3 67335.3 38144.8 38451.4 38585.6 38590.6 38604.4 15812.3 16032.3 16122.1 16132.0 16149.6 12571.5 13439.5 13469.8 13488.0 13548.3 9320.3 9344.6 9362.1 9390.3 9439.1 3585.2 3638.1 3647.7 3720.9 3757.8 1048.2 1067.3 1121.2 1152.5 1194.1 33763.0 34834.7 34875.5 34977.8 35042.3 1158.7 1189.2 1209.2 1213.9 1259.9 16423.6 16768.9 16955.7 17095.7 17135.7 439452.0 445926.0 446218.0 446674.0 446873.0 58883.7 60157.0 60203.7 60271.1 60287.0 1398.7 1407.7 1410.4 1474.6 1510.1 24493.9 30886.4 31081.7 31232.1 31440.5 55691.4 57026.7 57042.4 57051.4 57079.0 415646.0 420313.0 420411.0 421209.0 421888.0 27418.3 27882.6 30348.5 30706.4 30710.2 41306.0 43160.6 43200.0 43251.8 43690.0 35145.0 35463.9 36392.6 38955.8 39600.4 38177.0 38246.0 38867.2 38904.0 40063.4 40367.4 40975.4 41265.0 41562.2 41601.6 34136.1 37295.6 38626.8 38673.4 39145.4 26499.7 26559.9 27071.9 28782.3 29097.3 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | [#2] jquery.html Cycles:180 Average:29879.07 Median:20506.88 stddev:85996.97 (419.4%) stddev-sans-first:86209.79 09:16:52 INFO - PROCESS | 22939 | Values: 432.3 432.4 433.2 434.5 446.9 19169.7 19259.2 19815.5 20158.4 20193.7 19389.8 19637.2 20497.5 20516.3 20527.5 5425.9 5623.2 5631.5 5637.8 5656.1 4080.5 5571.5 5595.7 5656.5 5900.8 5828.4 5853.9 5911.7 5913.0 5914.7 5517.9 5618.4 5680.5 5681.8 5806.3 3910.6 4057.6 5406.3 5525.3 5556.2 13023.3 13066.7 13106.2 13206.0 16000.9 2320.5 2401.2 2469.9 2489.7 2530.4 10908.5 11209.9 11277.8 12038.8 14311.4 1995.6 2018.8 2042.3 2073.2 2079.8 75624.0 80662.6 81219.6 81843.0 83365.6 11072.9 11294.8 11510.5 11534.7 11656.2 16541.2 16626.0 16639.0 16643.8 16696.1 8947.4 8966.1 9014.8 9070.5 9160.6 8889.5 8954.6 8962.8 8981.0 9086.8 5047.7 5086.3 5097.9 5165.3 5244.1 1838.5 1994.2 2048.9 2055.8 2113.8 1024.9 1063.5 1109.9 1186.6 1211.2 18181.1 18467.3 18659.7 19191.2 19377.5 1042.6 1045.7 1090.1 1103.2 1112.1 10576.5 10921.1 10948.6 10984.2 11058.4 510197.0 512844.0 528130.0 528541.0 534138.0 57073.0 57166.4 101106.5 102411.5 102512.5 1103.0 1133.7 1143.1 1143.2 1150.5 17510.6 17588.5 17666.4 17944.6 17950.2 41917.2 43201.0 43237.1 43370.6 43994.8 62233.0 63269.4 63481.4 63658.4 63660.7 9321.9 9422.8 9502.4 9526.9 9553.5 12815.5 13683.9 13686.1 13984.7 14087.2 11815.9 11888.2 11905.9 11938.8 12078.9 11935.8 12007.7 12112.1 12324.3 12358.2 12131.6 12159.8 12282.4 12316.3 12394.4 9139.5 9153.7 9267.5 9309.5 9338.6 9349.4 11713.5 11951.9 12166.6 12240.3 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | [#3] mootools.html Cycles:180 Average:5883.94 Median:4838.32 stddev:3357.68 (69.4%) stddev-sans-first:3350.56 09:16:52 INFO - PROCESS | 22939 | Values: 1449.4 1567.0 1580.1 1757.6 1903.8 7899.3 8561.5 8697.4 8707.0 8709.6 8565.8 8760.0 8763.2 8763.7 8766.0 2127.7 2317.4 2344.1 2406.6 2470.1 2428.4 2437.0 2453.7 2460.5 2460.9 2430.8 2446.1 2470.2 2478.1 2479.3 2041.1 2358.7 2405.9 2409.5 2410.1 2261.3 2289.9 2295.5 2300.9 2324.3 8706.2 8717.2 8738.8 8776.9 8780.1 5424.0 5500.4 5525.3 5541.3 5543.6 3372.8 3373.9 3399.1 3437.2 3440.6 1068.3 1072.4 1075.4 1084.6 1091.9 12938.4 12944.4 12963.5 12993.8 13013.2 4765.0 4806.8 4830.1 4846.5 4922.0 10737.3 10773.6 10780.1 10782.8 10788.3 4939.5 5404.6 5422.2 5425.3 5428.5 4461.2 4462.3 4465.4 5040.2 5056.6 4173.4 4185.6 4238.9 4260.9 4264.1 1358.3 1358.6 1372.2 1389.1 1394.9 976.3 987.4 989.5 991.8 1000.6 5980.0 6048.8 6055.7 6087.5 6122.4 480.8 492.6 496.5 497.1 497.7 4180.7 4206.6 4225.9 4268.3 4280.0 10691.9 10999.3 11003.3 11025.6 11083.9 11002.5 11007.2 11140.4 11185.4 11207.3 8533.1 8534.7 8580.3 8581.7 8631.4 6050.6 6057.1 6082.8 6210.0 6224.8 9848.8 9977.9 10174.5 10195.9 10200.7 10092.1 10161.6 10196.9 10266.0 10359.9 7143.2 7637.2 7812.3 7945.5 8089.1 8149.0 8168.3 8214.5 8225.3 8244.6 7431.0 7618.2 7755.0 7787.8 7891.1 7620.5 7759.2 7761.4 7863.6 7891.8 7274.4 7322.3 7325.9 7345.4 7351.2 5176.6 5199.7 5297.8 5344.1 5378.8 5140.1 5184.0 5378.9 5380.5 5409.9 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | [#4] prototype.html Cycles:180 Average:5584.57 Median:6394.68 stddev:1684.43 (26.3%) stddev-sans-first:1642.42 09:16:52 INFO - PROCESS | 22939 | Values: 335.0 344.2 344.2 369.3 373.7 6269.9 6273.3 6284.7 6297.5 6331.9 5989.4 6085.2 6241.3 6243.6 6287.0 4755.8 4783.7 4793.2 4797.7 4806.0 4791.4 4800.0 4805.3 4815.8 4817.5 4565.4 4669.3 4750.2 4780.9 4792.7 4791.8 4803.4 4817.6 4825.6 4829.3 4269.9 4270.3 4273.8 4275.1 4277.7 6019.6 6022.4 6026.4 6027.6 6037.3 5579.7 5580.2 5591.6 5600.9 5602.2 6409.6 6541.0 6545.9 6547.5 6548.0 4692.9 4708.2 4716.1 4719.5 4721.6 6865.0 6951.4 6952.9 6958.5 6962.0 4828.3 4830.0 4830.3 4833.9 4833.9 4890.8 4895.9 4896.7 4897.5 4902.4 5279.4 5522.4 5535.5 5554.7 5574.4 6635.9 6651.3 6658.2 6658.5 6660.6 1575.7 1626.2 1656.2 1684.7 1685.4 1077.5 1102.4 1104.0 1114.8 1119.9 6442.3 6463.1 6482.1 6500.4 6508.5 6779.1 6785.6 6786.0 6796.3 6799.5 6392.3 6397.1 6413.4 6414.2 6421.8 3626.6 3663.0 3664.7 3665.3 3665.8 6989.0 7089.9 7146.2 7196.8 7245.2 6993.7 7033.4 7038.9 7043.1 7044.2 7228.2 7232.0 7234.7 7246.8 7258.0 6902.2 6909.3 6923.0 6923.5 6928.0 6594.3 6805.1 6820.1 6827.2 6836.0 7215.1 7226.1 7227.7 7238.5 7239.6 4735.4 4773.2 4773.3 4778.8 4780.0 6605.9 6891.1 6898.9 6910.0 6911.6 6510.4 6629.1 6632.9 6723.2 6733.6 6639.5 6654.8 6658.3 6670.1 6670.3 6554.1 6554.5 6561.6 6562.4 6578.9 6607.5 6730.2 6734.3 6734.7 6756.6 6555.8 6574.7 6576.4 6589.7 6592.0 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - PROCESS | 22939 | [#5] yui.html Cycles:180 Average:15440.78 Median:26165.83 stddev:17849.10 (68.2%) stddev-sans-first:17865.43 09:16:52 INFO - PROCESS | 22939 | Values: 826.1 861.1 876.6 885.3 916.8 15168.5 15211.2 15380.5 15389.8 15426.5 13423.2 13430.7 13533.5 13534.1 13553.7 735.8 750.0 752.3 752.8 877.5 889.3 892.8 893.4 893.4 895.3 930.1 937.8 938.3 940.3 940.4 940.6 941.5 941.7 941.7 942.2 575.1 678.3 680.5 681.5 685.1 14368.2 14369.8 14374.9 14381.2 14424.0 14355.2 14849.7 15044.2 15217.2 15270.5 11576.7 11904.0 12418.8 12612.5 12628.5 3981.4 3997.4 4042.2 4105.9 4126.2 56655.4 57074.1 57478.0 58590.0 58788.7 10239.2 10292.9 10492.5 10547.9 10650.9 19660.7 19668.5 19696.9 19732.6 19735.7 8738.6 8821.8 8822.8 8833.9 9152.8 5202.3 5315.3 5337.0 5338.0 5426.6 3539.3 3606.2 3609.4 3617.4 3618.4 662.2 673.5 674.3 680.9 693.1 702.7 711.8 776.7 780.4 786.0 9293.7 9547.1 9625.3 10006.8 10093.8 686.9 690.7 793.3 797.7 807.3 4581.1 4624.6 4773.9 4800.0 4842.5 62950.4 64693.7 66563.3 67131.7 67248.7 54525.7 55389.7 56016.2 56318.0 59185.7 49719.5 50442.2 50473.5 50820.5 51846.5 9274.5 9440.6 9470.7 9651.0 9972.4 36580.0 36738.6 37605.0 38278.8 38317.0 45042.3 46268.8 47557.8 47925.5 50360.0 12598.0 12765.0 12768.4 13016.3 13039.5 13392.7 14063.4 14464.3 14724.6 15032.1 12030.2 12306.2 12588.7 13902.7 13932.9 12175.9 12289.3 12389.8 13032.5 13046.4 12895.7 13014.2 13198.0 13203.2 13426.1 9940.6 10005.5 10341.9 10521.0 10546.2 10496.4 10627.1 10817.0 11006.6 11049.4 09:16:52 INFO - PROCESS | 22939 | -------- Summary: end -------- 09:16:52 INFO - PROCESS | 22939 | 09:16:52 INFO - TEST-INFO | 22939: exit 0 09:16:52 INFO - TEST-OK | dromaeo_css | took 1111590ms 09:16:52 INFO - TEST-START | kraken 09:16:52 INFO - operating with platform_type : linux_ 09:16:52 INFO - Initialising browser for kraken test... 09:16:52 INFO - TEST-INFO | started process 23127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcNJA0Z/profile http://localhost:53542/getInfo.html) 09:16:56 INFO - PROCESS | 23127 | __metrics Screen width/height:1600/1200 09:16:56 INFO - PROCESS | 23127 | colorDepth:24 09:16:56 INFO - PROCESS | 23127 | Browser inner width/height: 1024/697 09:16:56 INFO - PROCESS | 23127 | __metrics 09:16:57 ERROR - PROCESS | 23127 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:16:58 INFO - TEST-INFO | 23127: exit 0 09:16:58 INFO - Browser initialized. 09:16:58 INFO - Running cycle 1/1 for kraken test... 09:16:58 INFO - TEST-INFO | started process 23218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcNJA0Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:10 INFO - PROCESS | 23218 | RSS: Main: 142000128 09:17:10 INFO - PROCESS | 23218 | 09:17:12 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53542/tests/kraken/driver.html?testName=audio-beat-detection) 09:17:13 INFO - PROCESS | 23218 | RSS: Main: 196755456 09:17:13 INFO - PROCESS | 23218 | 09:17:16 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53542/tests/kraken/driver.html?testName=audio-dft) 09:17:16 INFO - PROCESS | 23218 | RSS: Main: 180793344 09:17:16 INFO - PROCESS | 23218 | 09:17:19 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53542/tests/kraken/driver.html?testName=audio-fft) 09:17:20 INFO - PROCESS | 23218 | RSS: Main: 271900672 09:17:20 INFO - PROCESS | 23218 | 09:17:22 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53542/tests/kraken/driver.html?testName=audio-oscillator) 09:17:22 INFO - PROCESS | 23218 | RSS: Main: 177307648 09:17:22 INFO - PROCESS | 23218 | 09:17:25 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53542/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:17:25 INFO - PROCESS | 23218 | RSS: Main: 176721920 09:17:25 INFO - PROCESS | 23218 | 09:17:28 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53542/tests/kraken/driver.html?testName=imaging-darkroom) 09:17:29 INFO - PROCESS | 23218 | RSS: Main: 211492864 09:17:29 INFO - PROCESS | 23218 | 09:17:32 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53542/tests/kraken/driver.html?testName=imaging-desaturate) 09:17:33 INFO - PROCESS | 23218 | RSS: Main: 210087936 09:17:33 INFO - PROCESS | 23218 | 09:17:35 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53542/tests/kraken/driver.html?testName=json-parse-financial) 09:17:36 INFO - PROCESS | 23218 | RSS: Main: 211132416 09:17:36 INFO - PROCESS | 23218 | 09:17:37 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53542/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:38 INFO - PROCESS | 23218 | RSS: Main: 190418944 09:17:38 INFO - PROCESS | 23218 | 09:17:40 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:40 INFO - PROCESS | 23218 | RSS: Main: 194564096 09:17:40 INFO - PROCESS | 23218 | 09:17:42 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:43 INFO - PROCESS | 23218 | RSS: Main: 209035264 09:17:43 INFO - PROCESS | 23218 | 09:17:45 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:46 INFO - PROCESS | 23218 | RSS: Main: 212955136 09:17:46 INFO - PROCESS | 23218 | 09:17:49 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:49 INFO - PROCESS | 23218 | RSS: Main: 210685952 09:17:49 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:53542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53542/tests/kraken/driver.html?testName=ai-astar) 09:17:51 INFO - PROCESS | 23218 | RSS: Main: 273461248 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | __start_tp_report 09:17:51 INFO - PROCESS | 23218 | _x_x_mozilla_page_load 09:17:51 INFO - PROCESS | 23218 | _x_x_mozilla_page_load_details 09:17:51 INFO - PROCESS | 23218 | |i|pagename|runs| 09:17:51 INFO - PROCESS | 23218 | |0;ai-astar;109;109;112;111;111;109;103;110;109;108 09:17:51 INFO - PROCESS | 23218 | |1;audio-beat-detection;154;124;148;179;126;150;149;127;188;133 09:17:51 INFO - PROCESS | 23218 | |2;audio-dft;159;161;160;160;160;161;160;161;159;162 09:17:51 INFO - PROCESS | 23218 | |3;audio-fft;77;76;76;175;76;77;75;76;163;76 09:17:51 INFO - PROCESS | 23218 | |4;audio-oscillator;93;92;159;92;93;92;152;93;92;152 09:17:51 INFO - PROCESS | 23218 | |5;imaging-gaussian-blur;116;118;117;116;117;117;117;117;117;117 09:17:51 INFO - PROCESS | 23218 | |6;imaging-darkroom;145;145;146;145;146;145;145;146;146;145 09:17:51 INFO - PROCESS | 23218 | |7;imaging-desaturate;94;94;95;94;94;95;95;95;95;94 09:17:51 INFO - PROCESS | 23218 | |8;json-parse-financial;55;53;54;58;53;54;55;74;53;53 09:17:51 INFO - PROCESS | 23218 | |9;json-stringify-tinderbox;58;57;58;58;58;59;58;58;58;59 09:17:51 INFO - PROCESS | 23218 | |10;stanford-crypto-aes;72;74;73;73;75;74;81;80;73;73 09:17:51 INFO - PROCESS | 23218 | |11;stanford-crypto-ccm;120;114;114;114;117;115;111;117;127;125 09:17:51 INFO - PROCESS | 23218 | |12;stanford-crypto-pbkdf2;169;160;161;159;162;160;161;158;158;164 09:17:51 INFO - PROCESS | 23218 | |13;stanford-crypto-sha256-iterative;68;66;66;66;66;66;65;65;68;63 09:17:51 INFO - PROCESS | 23218 | __end_tp_report 09:17:51 INFO - PROCESS | 23218 | __start_cc_report 09:17:51 INFO - PROCESS | 23218 | _x_x_mozilla_cycle_collect,1591 09:17:51 INFO - PROCESS | 23218 | __end_cc_report 09:17:51 INFO - PROCESS | 23218 | __startTimestamp1464279471703__endTimestamp 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | ------- Summary: start ------- 09:17:51 INFO - PROCESS | 23218 | Number of tests: 14 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:2.47 (2.3%) stddev-sans-first:2.62 09:17:51 INFO - PROCESS | 23218 | Values: 109.0 109.0 112.0 111.0 111.0 109.0 103.0 110.0 109.0 108.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:149.50 stddev:21.93 (14.7%) stddev-sans-first:23.14 09:17:51 INFO - PROCESS | 23218 | Values: 154.0 124.0 148.0 179.0 126.0 150.0 149.0 127.0 188.0 133.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 09:17:51 INFO - PROCESS | 23218 | Values: 159.0 161.0 160.0 160.0 160.0 161.0 160.0 161.0 159.0 162.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.27 (51.7%) stddev-sans-first:41.12 09:17:51 INFO - PROCESS | 23218 | Values: 77.0 76.0 76.0 175.0 76.0 77.0 75.0 76.0 163.0 76.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:29.97 (32.6%) stddev-sans-first:31.07 09:17:51 INFO - PROCESS | 23218 | Values: 93.0 92.0 159.0 92.0 93.0 92.0 152.0 93.0 92.0 152.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 09:17:51 INFO - PROCESS | 23218 | Values: 116.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:17:51 INFO - PROCESS | 23218 | Values: 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:17:51 INFO - PROCESS | 23218 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.50 stddev:6.44 (11.8%) stddev-sans-first:6.82 09:17:51 INFO - PROCESS | 23218 | Values: 55.0 53.0 54.0 58.0 53.0 54.0 55.0 74.0 53.0 53.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 09:17:51 INFO - PROCESS | 23218 | Values: 58.0 57.0 58.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:3.12 (4.2%) stddev-sans-first:3.14 09:17:51 INFO - PROCESS | 23218 | Values: 72.0 74.0 73.0 73.0 75.0 74.0 81.0 80.0 73.0 73.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.00 stddev:5.15 (4.4%) stddev-sans-first:5.37 09:17:51 INFO - PROCESS | 23218 | Values: 120.0 114.0 114.0 114.0 117.0 115.0 111.0 117.0 127.0 125.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.00 stddev:3.29 (2.0%) stddev-sans-first:1.94 09:17:51 INFO - PROCESS | 23218 | Values: 169.0 160.0 161.0 159.0 162.0 160.0 161.0 158.0 158.0 164.0 09:17:51 INFO - PROCESS | 23218 | 09:17:51 INFO - PROCESS | 23218 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.32 09:17:51 INFO - PROCESS | 23218 | Values: 68.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 68.0 63.0 09:17:51 INFO - PROCESS | 23218 | -------- Summary: end -------- 09:17:51 INFO - PROCESS | 23218 | 09:17:52 INFO - TEST-INFO | 23218: exit 0 09:17:52 INFO - TEST-OK | kraken | took 59924ms 09:17:52 INFO - SUITE-END | took 1171s 09:17:52 INFO - Completed test suite (00:19:31) 09:17:52 INFO - javascript benchmark 09:17:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.3851737428577, 3388.745844061696, 3391.0844072100535, 3411.7782344147645, 3441.62142164362, 5496.560275177986, 5525.4474552544725, 5533.612647114698, 5555.944440555603, 5561.6106872518885, 5544.805931792388, 5569.777208911639, 5574.0, 5578.525825304844, 5611.523020543248, 5007.449180590151, 5032.220005899073, 5118.872028199287, 5156.226566015091, 5196.58427325813, 5061.746912654371, 5166.147585648364, 5166.405863325709, 5167.7932882684645, 5175.120229560984, 5093.898122037557, 5149.922751158736, 5164.741762911858, 5181.35233095863, 5200.947990520084, 5089.312942752755, 5109.259157422153, 5111.02890450815, 5113.1052065888325, 5137.101007323741, 4981.526754958273, 4991.50084991498, 5046.924296135561, 5049.368828896388, 5063.87340316495, 5505.834824955257, 5533.6403133796175, 5549.77800887964, 5560.221568980346, 5583.609147359686, 5980.162777211194, 5995.400459954013, 6002.309734380515, 6002.489788367994, 6003.609765365237, 6028.608140470899, 6049.697515124226, 6088.990638077117, 6130.938690613081, 6143.662098584576, 5620.9437905620825, 5673.290838645169, 5676.801311954062, 5680.914786278167, 5681.147827825776, 5951.166836642873, 6168.475679567287, 6173.81478555644, 6178.073289006595, 6180.412860778219, 5915.0, 5951.702414879239, 5960.523158147338, 5974.761009559569, 5979.312379076375, 5923.200367950271, 5923.881522369528, 5926.170336152942, 5932.0508718604815, 5937.168796368512, 5806.622569532967, 5902.527797776168, 5907.261592300963, 5917.940820591739, 5934.020886553671, 5950.732217050243, 5958.76164953397, 5971.164037034819, 5973.522118230531, 5993.820185394358, 4549.909001819945, 4550.840720574764, 4551.52209018055, 4564.087182563434, 4582.404287442611, 3933.7443066200603, 4022.517297924268, 4075.4294398784195, 4095.672346212296, 4107.0553772631865, 5717.799877004285, 5739.053056245672, 5746.569007324468, 5748.827535173951, 5759.22250496186, 6079.088136779518, 6080.361562035922, 6080.7567697291615, 6091.817245482643, 6095.512359011268, 5590.24531688225, 5618.073017952074, 5647.576431767634, 5665.093585026459, 5667.773289068391, 5135.563477104488, 5139.434662187156, 5166.741662916839, 5169.043726910533, 5193.506616871391, 6235.688215589203, 6257.342978987141, 6260.530460215502, 6261.530385221035, 6265.028920517327, 5882.23530940975, 5936.0, 6005.429484198994, 6034.24571928509, 6038.0, 6233.594816336924, 6258.43674069336, 6265.746850629984, 6269.435750782452, 6277.30949595535, 5810.593258471867, 5932.881342373042, 5939.07944268639, 5943.375945525658, 5980.910286345621, 5992.340842507408, 6042.84892877664, 6051.273847138372, 6060.545459090674, 6090.634561926121, 5808.21589085485, 5822.039363505143, 5826.242588463472, 5827.59206855533, 5827.94172058274, 5716.28546431696, 5760.33756118035, 5823.039198532195, 5832.3292821326095, 5850.590458668023, 5774.0761478163295, 5818.214541036906, 5819.883602327845, 5835.037218858841, 5862.618929769551, 5936.762529498772, 5940.376260492586, 5949.762009519571, 5956.672383018976, 5957.106434034929, 5732.7706891723865, 5760.395158508296, 5828.446297601721, 5835.270591176103, 5849.444302791228], "value": 5538.175550094976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6795198544772, 655.4625207329989, 658.4436151452023, 672.4922683374049, 735.980666776515, 31915.0, 39362.0, 39647.40528892065, 39678.40482392767, 39686.40470392947, 42575.78712106443, 43608.56391436085, 43610.34584481228, 43615.78192109035, 43659.0, 8170.101288858221, 8310.085890552034, 8717.738467845958, 8918.108189181095, 10242.0, 10242.180625549976, 10339.483025848715, 10354.17166626668, 10368.740781480486, 10369.740756481111, 10358.27492075555, 10362.015608517217, 10362.430066346347, 10368.06687398134, 10372.273940824145, 8298.087210406851, 10197.13324367426, 10270.435126068063, 10474.47627618616, 10476.1095306899, 10517.579296828118, 10623.25637205396, 10635.149188064936, 10637.149028077734, 10638.946805265925, 39456.0, 39578.60421395778, 39702.60297397018, 39832.80083599593, 39979.60020399788, 3768.152165762709, 3808.619138086169, 3828.1960788234505, 3919.7844118573466, 4175.269327867642, 30502.210521086792, 31033.22416939572, 31112.222194445094, 31345.373092538022, 31445.685543144504, 3770.453284273765, 3805.809709514541, 3810.9809450952844, 3811.5235595550557, 3898.707596930213, 322147.0, 324987.0, 325022.0, 325752.0, 326091.0, 40011.199776004316, 40488.1902361957, 66121.0, 66895.33104668891, 67335.32664673291, 38144.809275953994, 38451.42322865159, 38585.614143858205, 38590.614093859265, 38604.420933686015, 15812.288447019911, 16032.278547465392, 16122.113283769271, 16132.0, 16149.59626009359, 12571.497140114294, 13439.462421503225, 13469.797953030713, 13487.988400869974, 13548.254845983369, 9320.347575669774, 9344.579493922789, 9362.063793620584, 9390.342676012613, 9439.056094390644, 3585.2112535242204, 3638.0541059324764, 3647.744657873923, 3720.9069773255887, 3757.7933213672964, 1048.2295512798087, 1067.2582555124113, 1121.2263538158645, 1152.4929031226234, 1194.0924897078282, 33763.0, 34834.65165348365, 34875.476867847, 34977.825110874284, 35042.29915401678, 1158.6581958322315, 1189.1735244005506, 1209.2140108929266, 1213.8664746877837, 1259.9433025513874, 16423.55429620467, 16768.916155419145, 16955.660886782196, 17095.658086838193, 17135.74296385555, 439452.0, 445926.0, 446218.0, 446674.0, 446873.0, 58883.70558147182, 60157.0, 60203.698981504815, 60271.09593356103, 60287.0, 1398.6922876966848, 1407.6973450707942, 1410.4217270918873, 1474.609228554434, 1510.1316742872891, 24493.877530612233, 30886.382272354876, 31081.68918310788, 31232.063038108892, 31440.528392074593, 55691.44308556862, 57026.714866425405, 57042.42957570371, 57051.42948570461, 57079.0, 415646.0, 420313.0, 420411.0, 421209.0, 421888.0, 27418.314542136606, 27882.58176127319, 30348.54477182888, 30706.385872282877, 30710.23224419318, 41306.0, 43160.568394315655, 43200.0, 43251.78374108109, 43690.0, 35145.0, 35463.86407147399, 36392.63607363999, 38955.805220973714, 39600.40599391069, 38177.0, 38246.0, 38867.222655547295, 38904.0, 40063.39904901487, 40367.39448908327, 40975.38536922008, 41265.0, 41562.168756624094, 41601.58398415977, 34136.14659633529, 37295.62704372922, 38626.80686596549, 38673.41989870098, 39145.41281880717, 26499.735002649726, 26559.867200663874, 27071.86464067667, 28782.280442989093, 29097.272568185967], "value": 19256.471018409025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.3255721075122, 432.44214962698123, 433.18893702099297, 434.545899534986, 446.906149708561, 19169.712454313198, 19259.229630814767, 19815.5046123847, 20158.395248142544, 20193.697094543557, 19389.806101938975, 19637.214511419563, 20497.487562810937, 20516.28193013245, 20527.486812829688, 5425.864353391157, 5623.156526521034, 5631.465010823965, 5637.774489020455, 5656.095024796024, 4080.5307389650275, 5571.470710282537, 5595.664260144384, 5656.547476201915, 5900.793472228473, 5828.446297601721, 5853.941460585404, 5911.704414779266, 5912.970435147839, 5914.733836977346, 5517.917231241535, 5618.353889302742, 5680.488756011958, 5681.829545113653, 5806.274215723035, 3910.6480416762342, 4057.5536690963972, 5406.324209473816, 5525.281713377235, 5556.222128901957, 13023.34883255843, 13066.673333166651, 13106.213627182304, 13206.0, 16000.919995399949, 2320.524292520029, 2401.183597576832, 2469.9135530256353, 2489.7136829264505, 2530.4180038591044, 10908.454577271184, 11209.943950280196, 11277.774444511146, 12038.81941770874, 14311.35598898052, 1995.5510010247724, 2018.798120187984, 2042.3158241988804, 2073.243266207823, 2079.8024187702144, 75624.0, 80662.59668701678, 81219.5939020307, 81842.9999999994, 83365.58317208375, 11072.889271107348, 11294.774104517863, 11510.48930076318, 11534.653960381202, 11656.18406711522, 16541.172941352885, 16626.0, 16639.0, 16643.83356166447, 16696.08171550552, 8947.3736838422, 8966.103389660982, 9014.774630634287, 9070.460271124095, 9160.633574657073, 8889.511076890703, 8954.552272386354, 8962.834831471997, 8980.955095224483, 9086.772830679285, 5047.722375269322, 5086.338775959176, 5097.923531146962, 5165.328507294028, 5244.082285600005, 1838.5415367733194, 1994.1724184463285, 2048.9385318440472, 2055.7533096028574, 2113.7780533044115, 1024.882138554061, 1063.505469956474, 1109.8501702270253, 1186.6440067979572, 1211.2308683985732, 18181.090945452674, 18467.261309547466, 18659.720104198448, 19191.232350705814, 19377.51556211106, 1042.569944881347, 1045.7019749371393, 1090.1278976818671, 1103.2387652519735, 1112.1380929779325, 10576.471176441148, 10921.12630989519, 10948.562057517769, 10984.231103822656, 11058.447077646086, 510197.0, 512844.0, 528130.0, 528541.0, 534138.0, 57073.0, 57166.42833571694, 101106.4944675272, 102411.4879425598, 102512.48743756233, 1102.9999999999839, 1133.7392399748105, 1143.108375467137, 1143.1712008793559, 1150.5455345138791, 17510.649787004444, 17588.472345829647, 17666.381676641256, 17944.551386215448, 17950.19224134891, 41917.16165676608, 43201.0, 43237.135257295304, 43370.566294336655, 43994.78002610095, 62233.0, 63269.36730632819, 63481.365186349394, 63658.363416365246, 63660.68169659307, 9321.906780932104, 9422.811543769223, 9502.382345147544, 9526.857097143687, 9553.478712357295, 12815.487380504675, 13683.86316136826, 13686.110402823784, 13984.720305593628, 14087.15477071379, 11815.881841181477, 11888.167828251939, 11905.94047029794, 11938.820917686415, 12078.939605301917, 11935.76128477443, 12007.699807504881, 12112.091593130373, 12324.322162280801, 12358.196717213352, 12131.636050918487, 12159.75680486403, 12282.447289871798, 12316.322602256962, 12394.442250098587, 9139.497327647043, 9153.679621213225, 9267.490288034223, 9309.534523273946, 9338.626454941726, 9349.439033658002, 11713.531458741896, 11951.94024029909, 12166.635000949986, 12240.326782026717], "value": 9445.790307186837, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.3695242569477, 1566.9999999999998, 1580.0756557413913, 1757.6378306812219, 1903.7620297462818, 7899.328557072648, 8561.486310821356, 8697.434666746656, 8707.042225355213, 8709.608067636957, 8565.828683426327, 8760.0, 8763.211310982011, 8763.693270735526, 8766.0, 2127.6595744680853, 2317.432229103872, 2344.0975224538506, 2406.566817972764, 2470.0737223541173, 2428.4285380163533, 2436.9512609747794, 2453.681021467207, 2460.5447992121426, 2460.9138680146198, 2430.756924307564, 2446.107170882624, 2470.1848390031337, 2478.0707234786955, 2479.2562231330617, 2041.0713125527923, 2358.7169539655265, 2405.903763849453, 2409.4578719787905, 2410.1082599438146, 2261.3329067925, 2289.9313020609407, 2295.517941232343, 2300.861948283108, 2324.3027091872373, 8706.21644052032, 8717.171868672465, 8738.825223495494, 8776.912230877737, 8780.078091800397, 5424.0236757383655, 5500.3949565547755, 5525.254090697745, 5541.251930989305, 5543.6396634218645, 3372.763906526544, 3373.865045398206, 3399.065257054305, 3437.1750779812915, 3440.552728145325, 1068.2575609951086, 1072.3780207479642, 1075.3547871277249, 1084.5607528950788, 1091.9344839309588, 12938.353082345939, 12944.417501212374, 12963.481460741465, 12993.805092923614, 13013.154144980546, 4764.976175119103, 4806.8223285294625, 4830.106430310404, 4846.539578740014, 4921.975390123026, 10737.302075365076, 10773.62292319765, 10780.083692886035, 10782.838257426145, 10788.298760580537, 4939.506049395103, 5404.621676482687, 5422.15956526739, 5425.348958125051, 5428.4842939920645, 4461.24158892989, 4462.286034234507, 4465.419495465569, 5040.193569029011, 5056.64603477753, 4173.353130264813, 4185.623293903503, 4238.851640192578, 4260.893477663021, 4264.125854199881, 1358.2529608715167, 1358.5788405594296, 1372.2384076837452, 1389.062382891544, 1394.8884089272833, 976.345848281653, 987.3779518903189, 989.4904124375952, 991.7949691125174, 1000.5947591225565, 5979.970100149559, 6048.818535443856, 6055.7274922628585, 6087.482563982023, 6122.387761223842, 480.77884173279983, 492.57638430949356, 496.5406998526349, 497.1101727907006, 497.73868718922853, 4180.728252663567, 4206.558311377261, 4225.894352641209, 4268.295731204316, 4279.97860010698, 10691.893081069089, 10999.34003959765, 11003.284786488852, 11025.558977640965, 11083.944580277048, 11002.50488728009, 11007.229493935507, 11140.442977851075, 11185.384803835866, 11207.327560346404, 8533.061363250037, 8534.701285455103, 8580.313574913991, 8581.656733730706, 8631.395802293904, 6050.6369617823075, 6057.091436284416, 6082.756689732361, 6209.96895015522, 6224.844378890564, 9848.803023939625, 9977.850332245167, 10174.542145603613, 10195.949020254851, 10200.693979180636, 10092.091711745978, 10161.644342447978, 10196.909966949495, 10266.0, 10359.94820025895, 7143.2499587544635, 7637.198094200029, 7812.3359514439635, 7945.48354356965, 8089.069756978023, 8149.0, 8168.305694016075, 8214.548199848827, 8225.341972642054, 8244.587770611326, 7431.0, 7618.200088990576, 7754.961225193838, 7787.766367008999, 7891.131975482577, 7620.504667196615, 7759.1852855451625, 7761.379089672925, 7863.646135923783, 7891.763247102366, 7274.418046556369, 7322.340989310987, 7325.853482930205, 7345.412367010519, 7351.228121047213, 5176.559992400688, 5199.74001299941, 5297.761600727899, 5344.091504444332, 5378.811741589026, 5140.068102163222, 5183.974080129726, 5378.919316210182, 5380.542653874308, 5409.86475338104], "value": 4644.658783474731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.01839609942874, 344.2048867116959, 344.24610103872516, 369.2964901861954, 373.7365157563918, 6269.9373006269925, 6273.278572964105, 6284.685765711713, 6297.464715499176, 6331.905021424671, 5989.371116032819, 6085.2393450818645, 6241.344658810827, 6243.594166379194, 6286.968565157179, 4755.833545825897, 4783.665143439961, 4793.185158523042, 4797.736124513151, 4805.975970120153, 4791.377120974286, 4800.015996720664, 4805.279208118793, 4815.759212039402, 4817.51824817519, 4565.360849481075, 4669.276262179367, 4750.21621432465, 4780.904381912377, 4792.736399498026, 4791.832285869978, 4803.3995750531185, 4817.566419022305, 4825.565699087081, 4829.251466022772, 4269.893252668709, 4270.274053410928, 4273.807678654437, 4275.102228532012, 4277.679174061957, 6019.578629495937, 6022.397760223987, 6026.397360263939, 6027.60820546663, 6037.335893051761, 5579.69311687857, 5580.190872323531, 5591.6365436246515, 5600.943990560083, 5602.215689803431, 6409.551331406803, 6540.9861471471995, 6545.869082618321, 6547.508936829757, 6548.0, 4692.859214223578, 4708.152532544141, 4716.080364328957, 4719.528047195287, 4721.551452611996, 6865.0, 6951.409130223937, 6952.895706564405, 6958.512904096715, 6962.0, 4828.348172996601, 4830.033993201304, 4830.2513110467935, 4833.927491087637, 4833.927491087637, 4890.779914903838, 4895.902081958412, 4896.706197628154, 4897.4857639947295, 4902.4362198346935, 5279.39286982002, 5522.447755224445, 5535.501804837503, 5554.666719996813, 5574.358948720868, 6635.933640663531, 6651.33486651331, 6658.234303055211, 6658.467322614276, 6660.60036397808, 1575.7478803391632, 1626.162526298957, 1656.1719140429784, 1684.730443129118, 1685.3679870048732, 1077.5420446310286, 1102.3771569063454, 1103.9503222355013, 1114.8104822180248, 1119.92720473169, 6442.291347951722, 6463.127477790438, 6482.124913136666, 6500.414962653384, 6508.511861610304, 6779.0509328694025, 6785.558938668971, 6786.0, 6796.320367963164, 6799.524033317621, 6392.26488953767, 6397.10440538325, 6413.390727880844, 6414.166158399378, 6421.8073457796345, 3626.5829429615933, 3662.9816850915577, 3664.7434679572707, 3665.2669466106886, 3665.8350374233223, 6989.0, 7089.858202836018, 7146.178189508273, 7196.820079498055, 7245.203027666952, 6993.685284162225, 7033.437325013987, 7038.92961070393, 7043.119610048744, 7044.189918159374, 7228.168760592494, 7232.0, 7234.674439650228, 7246.818829529198, 7257.963710181415, 6902.171739391305, 6909.343612356818, 6923.0, 6923.480738944499, 6928.0, 6594.340565943367, 6805.081314022544, 6820.113385259884, 6827.249002609609, 6836.0, 7215.098112735908, 7226.132864056347, 7227.674754636159, 7238.493305468777, 7239.601821899846, 4735.431748190239, 4773.236282194832, 4773.331733557236, 4778.7849546769785, 4779.952200477951, 6605.933940660532, 6891.104156459628, 6898.896516552155, 6909.965450172717, 6911.619860907698, 6510.381513756186, 6629.138212032405, 6632.900506492503, 6723.159605049369, 6733.595984240961, 6639.53523253387, 6654.83362915931, 6658.334166583303, 6670.066190733398, 6670.266270710121, 6554.14796076507, 6554.541182117397, 6561.639109849004, 6562.376574225441, 6578.901316480161, 6607.5044371673275, 6730.226024007302, 6734.259231484435, 6734.6632668367365, 6756.628385438848, 6555.80332590023, 6574.671266436755, 6576.44100251484, 6589.7364105435245, 6591.967040164768], "value": 5032.306107598851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.1078035721422, 861.14316255326, 876.5660997806086, 885.3404213860675, 916.7662246127237, 15168.544943651681, 15211.239438028097, 15380.461683841067, 15389.846101538982, 15426.537203883874, 13423.194608323507, 13430.731385372312, 13533.458661653547, 13534.120282181651, 13553.728925421485, 735.7755884455239, 750.0212223048919, 752.3078767533882, 752.7854561449988, 877.4866702978733, 889.3063410539756, 892.7634176943116, 893.4282059481936, 893.4371346051978, 895.2882458445551, 930.0838673906197, 937.8452555328363, 938.2962777916563, 940.3182692547882, 940.3699521320732, 940.5626383731529, 941.5151197133482, 941.6515889121, 941.7127776028309, 942.2179590939504, 575.0712599152339, 678.304737643914, 680.4658343200613, 681.4820736240443, 685.1093578348177, 14368.20974846383, 14369.78445323321, 14374.856251437457, 14381.209033503153, 14424.0, 14355.210463424508, 14849.70300593993, 15044.172570508617, 15217.239138043164, 15270.541883743506, 11576.710582235428, 11904.0, 12418.75162496745, 12612.495500179983, 12628.494860205581, 3981.422693709425, 3997.400389941503, 4042.2117687051036, 4105.938410923838, 4126.216018956388, 56655.43344566584, 57074.14388784172, 57478.0, 58590.0, 58788.70605646945, 10239.232057595711, 10292.948535257276, 10492.483049039904, 10547.894521054845, 10650.946745266225, 19660.70508942367, 19668.508287292647, 19696.901515492616, 19732.60534789296, 19735.703964440545, 8738.606762695694, 8821.823563528822, 8822.77943051416, 8833.867491987625, 9152.816943661222, 5202.271681964528, 5315.3090098286975, 5336.973315133399, 5337.973310133424, 5426.593005524602, 3539.3275277697153, 3606.1886075632774, 3609.4405367168133, 3617.4031284837706, 3618.4029635110437, 662.2483481248721, 673.4713250098649, 674.29872932151, 680.9080774095434, 693.0851276315216, 702.6592102830124, 711.8256027273351, 776.6660336055437, 780.4068907630242, 785.9803504912309, 9293.72118836436, 9547.149281518126, 9625.278104142217, 10006.799864002825, 10093.798124037477, 686.9175698916162, 690.6960937187621, 793.305857374797, 797.6649807081039, 807.3460496997451, 4581.060882519076, 4624.606908412756, 4773.9045219096115, 4799.952000479951, 4842.491538388418, 62950.370496294454, 64693.67653161798, 66563.33436665668, 67131.66434167798, 67248.66375668091, 54525.72737136289, 55389.723051384484, 56016.159757603666, 56318.0, 59185.70407147937, 49719.50280497149, 50442.24336634953, 50473.49526504761, 50820.491795082315, 51846.48153518492, 9274.489903055397, 9440.575174117319, 9470.715878523655, 9651.0, 9972.404415293518, 36580.0, 36738.63261367352, 37605.0, 38278.80860595791, 38317.0, 45042.32436513389, 46268.768656156506, 47557.762211188725, 47925.520744792106, 50360.0, 12598.0, 12765.0, 12768.425420856269, 13016.349182541024, 13039.478420863059, 13392.665183370495, 14063.437462501386, 14464.349104290543, 14724.55826325212, 15032.098074115587, 12030.15788894769, 12306.200096993667, 12588.748225035264, 13902.721945561234, 13932.860671393562, 12175.878241217475, 12289.262644241375, 12389.814152787536, 13032.54386096482, 13046.41291141882, 12895.742085158057, 13014.15407998477, 13198.0, 13203.207807531579, 13426.127301725357, 9940.602375904882, 10005.499725013866, 10341.9482902585, 10521.0, 10546.156307495536, 10496.370217786956, 10627.09669678055, 10817.0, 11006.559737610405, 11049.392283424168], "value": 7073.954199022271, "unit": "score"}], "name": "dromaeo_css", "value": 7417.66038739364, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 112.0, 111.0, 111.0, 109.0, 103.0, 110.0, 109.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 148.0, 179.0, 126.0, 150.0, 149.0, 127.0, 188.0, 133.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 175.0, 76.0, 77.0, 75.0, 76.0, 163.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 159.0, 92.0, 93.0, 92.0, 152.0, 93.0, 92.0, 152.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 58.0, 53.0, 54.0, 55.0, 74.0, 53.0, 53.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 73.0, 75.0, 74.0, 81.0, 80.0, 73.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 114.0, 114.0, 114.0, 117.0, 115.0, 111.0, 117.0, 127.0, 125.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 160.0, 161.0, 159.0, 162.0, 160.0, 161.0, 158.0, 158.0, 164.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 68.0, 63.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1513.3, "alertThreshold": 2.0}]} 09:17:52 INFO - Return code: 0 09:17:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:17:52 ERROR - # TBPL SUCCESS # 09:17:52 INFO - Running post-action listener: _resource_record_post_action 09:17:52 INFO - Running post-run listener: _resource_record_post_run 09:17:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 500649984; Read time: 12; Write time: 371632 09:17:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249180160; Read time: 0; Write time: 228408 09:17:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 251469824; Read time: 12; Write time: 143224 09:17:54 INFO - Running post-run listener: _upload_blobber_files 09:17:54 INFO - Blob upload gear active. 09:17:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:54 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 09:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:17:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:56 INFO - (blobuploader) - INFO - Done attempting. 09:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:57 INFO - (blobuploader) - INFO - Done attempting. 09:17:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:57 INFO - Return code: 0 09:17:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da3e9dac2e28947e44724f0d4c833c890fee931fc63f6b34f63dbd7152578f94a5a73555bdd968a365ef9b2a3e26e7ab91995b64b8a579e021a86239e9c3d6f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2071f4c6930dbf3eda25a3cebd35e25eeb9452a47733980dfc07d4a45b1d28f5422f9c1701eb3396787d3b3012de87a82c766a012350a74bc6526b71caee0bb"} 09:17:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:57 INFO - Contents: 09:17:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da3e9dac2e28947e44724f0d4c833c890fee931fc63f6b34f63dbd7152578f94a5a73555bdd968a365ef9b2a3e26e7ab91995b64b8a579e021a86239e9c3d6f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2071f4c6930dbf3eda25a3cebd35e25eeb9452a47733980dfc07d4a45b1d28f5422f9c1701eb3396787d3b3012de87a82c766a012350a74bc6526b71caee0bb"} 09:17:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:57 INFO - Copying logs to upload dir... 09:17:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.852416 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-26 09:17:57.148018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 09:17:57.151126) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111 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-Aurora/sha512/da3e9dac2e28947e44724f0d4c833c890fee931fc63f6b34f63dbd7152578f94a5a73555bdd968a365ef9b2a3e26e7ab91995b64b8a579e021a86239e9c3d6f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2071f4c6930dbf3eda25a3cebd35e25eeb9452a47733980dfc07d4a45b1d28f5422f9c1701eb3396787d3b3012de87a82c766a012350a74bc6526b71caee0bb"} build_url:https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/UkdVRkGVSxuOaLuJCgalng/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da3e9dac2e28947e44724f0d4c833c890fee931fc63f6b34f63dbd7152578f94a5a73555bdd968a365ef9b2a3e26e7ab91995b64b8a579e021a86239e9c3d6f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2071f4c6930dbf3eda25a3cebd35e25eeb9452a47733980dfc07d4a45b1d28f5422f9c1701eb3396787d3b3012de87a82c766a012350a74bc6526b71caee0bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 09:17:57.178220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:17:57.178557) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464278242.204595-382332111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:17:57.231215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 09:17:57.231969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 09:17:57.232577) ========= ========= Total master_lag: 0.15 =========