builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1472898104.5 results: success (0) buildid: 20160902160050 builduid: b954e943d60047298c8c718863c8a0b0 revision: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.502539) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.502997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.503322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.517709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.517965) ========= 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=ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 03:21:45-- 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% 38.3M=0s 2016-09-03 03:21:45 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.652082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.652528) ========= 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=ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016315 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:44.703587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 03:21:44.704025) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd --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 d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd --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=ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 03:21:45,905 truncating revision to first 12 chars 2016-09-03 03:21:45,905 Setting DEBUG logging. 2016-09-03 03:21:45,905 attempt 1/10 2016-09-03 03:21:45,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d35ac86c5271?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 03:21:47,197 unpacking tar archive at: mozilla-aurora-d35ac86c5271/testing/mozharness/ program finished with exit code 0 elapsedTime=1.731252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 03:21:46.448502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:46.448827) ========= script_repo_revision: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:46.449200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:46.449459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 03:21:46.458589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-03 03:21:46.458864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:47 INFO - MultiFileLogger online at 20160903 03:21:47 in /builds/slave/test 03:21:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:47 INFO - {'append_to_log': False, 03:21:47 INFO - 'base_work_dir': '/builds/slave/test', 03:21:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:47 INFO - 'branch': 'Mozilla-Aurora', 03:21:47 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:47 INFO - 'config_files': ('talos/linux_config.py',), 03:21:47 INFO - 'default_actions': ('clobber', 03:21:47 INFO - 'read-buildbot-config', 03:21:47 INFO - 'download-and-extract', 03:21:47 INFO - 'populate-webroot', 03:21:47 INFO - 'create-virtualenv', 03:21:47 INFO - 'install', 03:21:47 INFO - 'run-tests'), 03:21:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:47 INFO - 'download_minidump_stackwalk': True, 03:21:47 INFO - 'download_symbols': 'ondemand', 03:21:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:47 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:47 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:47 INFO - 'installer_path': 'installer.exe', 03:21:47 INFO - 'log_level': 'info', 03:21:47 INFO - 'log_name': 'talos', 03:21:47 INFO - 'log_to_console': True, 03:21:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:47 INFO - 'opt_config_files': (), 03:21:47 INFO - 'pip_index': False, 03:21:47 INFO - 'sps_profile': False, 03:21:47 INFO - 'sps_profile_interval': 0, 03:21:47 INFO - 'suite': 'dromaeojs-e10s', 03:21:47 INFO - 'system_bits': '32', 03:21:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:47 INFO - 'title': 'talos-linux64-ix-035', 03:21:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:47 INFO - 'use_talos_json': True, 03:21:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:47 INFO - 'work_dir': 'build'} 03:21:47 INFO - [mozharness: 2016-09-03 10:21:47.748385Z] Running clobber step. 03:21:47 INFO - Running pre-action listener: _resource_record_pre_action 03:21:47 INFO - Running main action method: clobber 03:21:47 INFO - rmtree: /builds/slave/test/build 03:21:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:48 INFO - Running post-action listener: _resource_record_post_action 03:21:48 INFO - [mozharness: 2016-09-03 10:21:48.195130Z] Finished clobber step (success) 03:21:48 INFO - [mozharness: 2016-09-03 10:21:48.195230Z] Running read-buildbot-config step. 03:21:48 INFO - Running pre-action listener: _resource_record_pre_action 03:21:48 INFO - Running main action method: read_buildbot_config 03:21:48 INFO - Using buildbot properties: 03:21:48 INFO - { 03:21:48 INFO - "project": "", 03:21:48 INFO - "product": "firefox", 03:21:48 INFO - "script_repo_revision": "production", 03:21:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:21:48 INFO - "repository": "", 03:21:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:21:48 INFO - "buildid": "20160902160050", 03:21:48 INFO - "pgo_build": "True", 03:21:48 INFO - "basedir": "/builds/slave/test", 03:21:48 INFO - "buildnumber": 530, 03:21:48 INFO - "slavename": "talos-linux64-ix-035", 03:21:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:21:48 INFO - "platform": "ubuntu64_hw", 03:21:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:48 INFO - "branch": "mozilla-aurora", 03:21:48 INFO - "repo_path": "releases/mozilla-aurora", 03:21:48 INFO - "revision": "d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd", 03:21:48 INFO - "stage_platform": "linux64-pgo", 03:21:48 INFO - "builduid": "b954e943d60047298c8c718863c8a0b0", 03:21:48 INFO - "slavebuilddir": "test" 03:21:48 INFO - } 03:21:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:21:48 INFO - Running post-action listener: _resource_record_post_action 03:21:48 INFO - [mozharness: 2016-09-03 10:21:48.197654Z] Finished read-buildbot-config step (success) 03:21:48 INFO - [mozharness: 2016-09-03 10:21:48.197743Z] Running download-and-extract step. 03:21:48 INFO - Running pre-action listener: _resource_record_pre_action 03:21:48 INFO - Running main action method: download_and_extract 03:21:48 INFO - mkdir: /builds/slave/test/build/tests 03:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:48 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:21:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:21:48 INFO - retry: Failed, sleeping 30 seconds before retrying 03:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:22:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:22:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:22:18 INFO - retry: Failed, sleeping 60 seconds before retrying 03:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:23:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:23:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:23:18 INFO - Caught exception: HTTP Error 404: Not Found 03:23:18 INFO - Caught exception: HTTP Error 404: Not Found 03:23:18 INFO - Caught exception: HTTP Error 404: Not Found 03:23:18 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:18 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:23:18 INFO - Downloaded 1361 bytes. 03:23:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:18 INFO - Using the following test package requirements: 03:23:18 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:18 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:23:18 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:23:18 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'jsshell-linux-x86_64.zip'], 03:23:18 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:23:18 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:18 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:23:18 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:23:18 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:23:18 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:18 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:23:18 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:18 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:23:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:23:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:23:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:24:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:24:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:24:49 INFO - Caught exception: HTTP Error 404: Not Found 03:24:49 INFO - Caught exception: HTTP Error 404: Not Found 03:24:49 INFO - Caught exception: HTTP Error 404: Not Found 03:24:49 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:49 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:49 INFO - Downloaded 21839364 bytes. 03:24:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:24:51 INFO - Return code: 0 03:24:51 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:51 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:24:51 INFO - retry: Failed, sleeping 30 seconds before retrying 03:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:25:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:25:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:25:21 INFO - retry: Failed, sleeping 60 seconds before retrying 03:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:26:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:26:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:26:21 INFO - Caught exception: HTTP Error 404: Not Found 03:26:21 INFO - Caught exception: HTTP Error 404: Not Found 03:26:21 INFO - Caught exception: HTTP Error 404: Not Found 03:26:21 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:21 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:26:21 INFO - Downloaded 21839364 bytes. 03:26:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:26:23 INFO - Return code: 0 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:26:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:26:23 INFO - retry: Failed, sleeping 30 seconds before retrying 03:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:26:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:26:53 INFO - retry: Failed, sleeping 60 seconds before retrying 03:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:27:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:27:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:27:53 INFO - Caught exception: HTTP Error 404: Not Found 03:27:53 INFO - Caught exception: HTTP Error 404: Not Found 03:27:53 INFO - Caught exception: HTTP Error 404: Not Found 03:27:53 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:27:54 INFO - Downloaded 14413740 bytes. 03:27:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:27:54 INFO - Return code: 0 03:27: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')]} 03:27:54 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:27:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:27:54 INFO - retry: Failed, sleeping 30 seconds before retrying 03:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:28:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:28:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:28:24 INFO - retry: Failed, sleeping 60 seconds before retrying 03:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:29:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:29:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:29:24 INFO - Caught exception: HTTP Error 404: Not Found 03:29:24 INFO - Caught exception: HTTP Error 404: Not Found 03:29:24 INFO - Caught exception: HTTP Error 404: Not Found 03:29:24 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:24 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:29:25 INFO - Downloaded 63899078 bytes. 03:29:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:25 INFO - mkdir: /builds/slave/test/properties 03:29:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:25 INFO - Contents: 03:29:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:26 INFO - Running post-action listener: _resource_record_post_action 03:29:26 INFO - Running post-action listener: set_extra_try_arguments 03:29:26 INFO - [mozharness: 2016-09-03 10:29:26.523144Z] Finished download-and-extract step (success) 03:29:26 INFO - [mozharness: 2016-09-03 10:29:26.523376Z] Running populate-webroot step. 03:29:26 INFO - Running pre-action listener: _resource_record_pre_action 03:29:26 INFO - Running main action method: populate_webroot 03:29:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:26 INFO - '--tppagecycles', 03:29:26 INFO - '7'], 03:29:26 INFO - 'tests': ['tsvgm']}}, 03:29:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['damp', 'tps']}, 03:29:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'tests': ['damp', 'tps']}, 03:29:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['dromaeo_dom']}, 03:29:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['basic_compositor_video']}, 03:29:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:29:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['a11yr', 03:29:26 INFO - 'ts_paint', 03:29:26 INFO - 'tpaint', 03:29:26 INFO - 'sessionrestore', 03:29:26 INFO - 'sessionrestore_no_auto_restore', 03:29:26 INFO - 'tabpaint']}, 03:29:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:26 INFO - 'ts_paint', 03:29:26 INFO - 'tpaint', 03:29:26 INFO - 'sessionrestore', 03:29:26 INFO - 'sessionrestore_no_auto_restore', 03:29:26 INFO - 'tabpaint']}, 03:29:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:29:26 INFO - 'ts_paint', 03:29:26 INFO - 'tpaint', 03:29:26 INFO - 'sessionrestore', 03:29:26 INFO - 'sessionrestore_no_auto_restore', 03:29:26 INFO - 'tabpaint']}, 03:29:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:29:26 INFO - 'ts_paint', 03:29:26 INFO - 'tpaint', 03:29:26 INFO - 'sessionrestore', 03:29:26 INFO - 'sessionrestore_no_auto_restore', 03:29:26 INFO - 'tabpaint']}, 03:29:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['a11yr', 03:29:26 INFO - 'ts_paint', 03:29:26 INFO - 'tpaint', 03:29:26 INFO - 'sessionrestore', 03:29:26 INFO - 'sessionrestore_no_auto_restore', 03:29:26 INFO - 'tabpaint']}, 03:29:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['a11yr', 03:29:26 INFO - 'ts_paint', 03:29:26 INFO - 'tpaint', 03:29:26 INFO - 'sessionrestore', 03:29:26 INFO - 'sessionrestore_no_auto_restore', 03:29:26 INFO - 'tabpaint']}, 03:29:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['tsvgx', 03:29:26 INFO - 'tsvgr_opacity', 03:29:26 INFO - 'tart', 03:29:26 INFO - 'tscrollx', 03:29:26 INFO - 'cart']}, 03:29:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:26 INFO - 'tsvgr_opacity', 03:29:26 INFO - 'tart', 03:29:26 INFO - 'tscrollx', 03:29:26 INFO - 'cart']}, 03:29:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'talos_options': ['--disable-e10s'], 03:29:26 INFO - 'tests': ['tp5o']}, 03:29:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'tests': ['tp5o']}, 03:29:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'talos_options': ['--disable-e10s', 03:29:26 INFO - '--xperf_path', 03:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:26 INFO - 'tests': ['tp5n']}, 03:29:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:26 INFO - 'talos_options': ['--xperf_path', 03:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:26 INFO - 'tests': ['tp5n']}}, 03:29:26 INFO - 'talos.zip': {'path': '', 03:29:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:26 INFO - Running post-action listener: _resource_record_post_action 03:29:26 INFO - [mozharness: 2016-09-03 10:29:26.539465Z] Finished populate-webroot step (success) 03:29:26 INFO - [mozharness: 2016-09-03 10:29:26.539553Z] Running create-virtualenv step. 03:29:26 INFO - Running pre-action listener: _resource_record_pre_action 03:29:26 INFO - Running main action method: create_virtualenv 03:29:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:26 INFO - Using real prefix '/usr' 03:29:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:29 INFO - Installing pip.................done. 03:29:29 INFO - Return code: 0 03:29:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:29 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 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:29 INFO - Using env: {'DISPLAY': ':0', 03:29:29 INFO - 'HOME': '/home/cltbld', 03:29:29 INFO - 'LANG': 'en_US.UTF-8', 03:29:29 INFO - 'LANGUAGE': 'en_US:en', 03:29:29 INFO - 'LOGNAME': 'cltbld', 03:29:29 INFO - 'MAIL': '/var/mail/cltbld', 03:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:29 INFO - 'MOZ_NO_REMOTE': '1', 03:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:29 INFO - 'NO_EM_RESTART': '1', 03:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:29 INFO - 'PWD': '/builds/slave/test', 03:29:29 INFO - 'SHELL': '/bin/bash', 03:29:29 INFO - 'SHLVL': '1', 03:29:29 INFO - 'TERM': 'linux', 03:29:29 INFO - 'TMOUT': '86400', 03:29:29 INFO - 'USER': 'cltbld', 03:29:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:29 INFO - '_': '/tools/buildbot/bin/python'} 03:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:29:29 INFO - Cleaning up... 03:29:29 INFO - Return code: 0 03:29:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:29 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:29 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>=3.1.1'] in /builds/slave/test/build 03:29:29 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>=3.1.1 03:29:29 INFO - Using env: {'DISPLAY': ':0', 03:29:29 INFO - 'HOME': '/home/cltbld', 03:29:29 INFO - 'LANG': 'en_US.UTF-8', 03:29:29 INFO - 'LANGUAGE': 'en_US:en', 03:29:29 INFO - 'LOGNAME': 'cltbld', 03:29:29 INFO - 'MAIL': '/var/mail/cltbld', 03:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:29 INFO - 'MOZ_NO_REMOTE': '1', 03:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:29 INFO - 'NO_EM_RESTART': '1', 03:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:29 INFO - 'PWD': '/builds/slave/test', 03:29:29 INFO - 'SHELL': '/bin/bash', 03:29:29 INFO - 'SHLVL': '1', 03:29:29 INFO - 'TERM': 'linux', 03:29:29 INFO - 'TMOUT': '86400', 03:29:29 INFO - 'USER': 'cltbld', 03:29:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:29 INFO - '_': '/tools/buildbot/bin/python'} 03:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:29 INFO - Downloading/unpacking psutil>=3.1.1 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:31 INFO - Installing collected packages: psutil 03:29:31 INFO - Running setup.py install for psutil 03:29:31 INFO - building 'psutil._psutil_linux' extension 03:29:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:31 INFO - building 'psutil._psutil_posix' extension 03:29:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:32 INFO - Successfully installed psutil 03:29:32 INFO - Cleaning up... 03:29:32 INFO - Return code: 0 03:29:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:32 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:32 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.3'] in /builds/slave/test/build 03:29:32 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.3 03:29:32 INFO - Using env: {'DISPLAY': ':0', 03:29:32 INFO - 'HOME': '/home/cltbld', 03:29:32 INFO - 'LANG': 'en_US.UTF-8', 03:29:32 INFO - 'LANGUAGE': 'en_US:en', 03:29:32 INFO - 'LOGNAME': 'cltbld', 03:29:32 INFO - 'MAIL': '/var/mail/cltbld', 03:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:32 INFO - 'MOZ_NO_REMOTE': '1', 03:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:32 INFO - 'NO_EM_RESTART': '1', 03:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:32 INFO - 'PWD': '/builds/slave/test', 03:29:32 INFO - 'SHELL': '/bin/bash', 03:29:32 INFO - 'SHLVL': '1', 03:29:32 INFO - 'TERM': 'linux', 03:29:32 INFO - 'TMOUT': '86400', 03:29:32 INFO - 'USER': 'cltbld', 03:29:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:32 INFO - '_': '/tools/buildbot/bin/python'} 03:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:34 INFO - Installing collected packages: mozsystemmonitor 03:29:34 INFO - Running setup.py install for mozsystemmonitor 03:29:34 INFO - Successfully installed mozsystemmonitor 03:29:34 INFO - Cleaning up... 03:29:34 INFO - Return code: 0 03:29:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:34 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:34 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==2.5.1'] in /builds/slave/test/build 03:29:34 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==2.5.1 03:29:34 INFO - Using env: {'DISPLAY': ':0', 03:29:34 INFO - 'HOME': '/home/cltbld', 03:29:34 INFO - 'LANG': 'en_US.UTF-8', 03:29:34 INFO - 'LANGUAGE': 'en_US:en', 03:29:34 INFO - 'LOGNAME': 'cltbld', 03:29:34 INFO - 'MAIL': '/var/mail/cltbld', 03:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:34 INFO - 'MOZ_NO_REMOTE': '1', 03:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:34 INFO - 'NO_EM_RESTART': '1', 03:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:34 INFO - 'PWD': '/builds/slave/test', 03:29:34 INFO - 'SHELL': '/bin/bash', 03:29:34 INFO - 'SHLVL': '1', 03:29:34 INFO - 'TERM': 'linux', 03:29:34 INFO - 'TMOUT': '86400', 03:29:34 INFO - 'USER': 'cltbld', 03:29:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:34 INFO - '_': '/tools/buildbot/bin/python'} 03:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:36 INFO - warning: no files found matching '*.txt' 03:29:36 INFO - no previously-included directories found matching 'build' 03:29:36 INFO - no previously-included directories found matching 'dist' 03:29:36 INFO - no previously-included directories found matching '.git*' 03:29:36 INFO - Installing collected packages: jsonschema, functools32 03:29:36 INFO - Running setup.py install for functools32 03:29:36 INFO - warning: no files found matching '*.txt' 03:29:36 INFO - no previously-included directories found matching 'build' 03:29:36 INFO - no previously-included directories found matching 'dist' 03:29:36 INFO - no previously-included directories found matching '.git*' 03:29:36 INFO - Successfully installed jsonschema functools32 03:29:36 INFO - Cleaning up... 03:29:36 INFO - Return code: 0 03:29:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:36 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:36 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29:36 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 functools32==3.2.3-2 03:29:36 INFO - Using env: {'DISPLAY': ':0', 03:29:36 INFO - 'HOME': '/home/cltbld', 03:29:36 INFO - 'LANG': 'en_US.UTF-8', 03:29:36 INFO - 'LANGUAGE': 'en_US:en', 03:29:36 INFO - 'LOGNAME': 'cltbld', 03:29:36 INFO - 'MAIL': '/var/mail/cltbld', 03:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:36 INFO - 'MOZ_NO_REMOTE': '1', 03:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:36 INFO - 'NO_EM_RESTART': '1', 03:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:36 INFO - 'PWD': '/builds/slave/test', 03:29:36 INFO - 'SHELL': '/bin/bash', 03:29:36 INFO - 'SHLVL': '1', 03:29:36 INFO - 'TERM': 'linux', 03:29:36 INFO - 'TMOUT': '86400', 03:29:36 INFO - 'USER': 'cltbld', 03:29:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:36 INFO - '_': '/tools/buildbot/bin/python'} 03:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:37 INFO - Cleaning up... 03:29:37 INFO - Return code: 0 03:29:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:37 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 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:37 INFO - Using env: {'DISPLAY': ':0', 03:29:37 INFO - 'HOME': '/home/cltbld', 03:29:37 INFO - 'LANG': 'en_US.UTF-8', 03:29:37 INFO - 'LANGUAGE': 'en_US:en', 03:29:37 INFO - 'LOGNAME': 'cltbld', 03:29:37 INFO - 'MAIL': '/var/mail/cltbld', 03:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:37 INFO - 'MOZ_NO_REMOTE': '1', 03:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:37 INFO - 'NO_EM_RESTART': '1', 03:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:37 INFO - 'PWD': '/builds/slave/test', 03:29:37 INFO - 'SHELL': '/bin/bash', 03:29:37 INFO - 'SHLVL': '1', 03:29:37 INFO - 'TERM': 'linux', 03:29:37 INFO - 'TMOUT': '86400', 03:29:37 INFO - 'USER': 'cltbld', 03:29:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:37 INFO - '_': '/tools/buildbot/bin/python'} 03:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:40 INFO - Downloading docopt-0.6.1.tar.gz 03:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:40 INFO - Running setup.py install for blobuploader 03:29:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:40 INFO - Running setup.py install for requests 03:29:40 INFO - Running setup.py install for docopt 03:29:40 INFO - Successfully installed blobuploader requests docopt 03:29:40 INFO - Cleaning up... 03:29:40 INFO - Return code: 0 03:29:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:40 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 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:40 INFO - Using env: {'DISPLAY': ':0', 03:29:40 INFO - 'HOME': '/home/cltbld', 03:29:40 INFO - 'LANG': 'en_US.UTF-8', 03:29:40 INFO - 'LANGUAGE': 'en_US:en', 03:29:40 INFO - 'LOGNAME': 'cltbld', 03:29:40 INFO - 'MAIL': '/var/mail/cltbld', 03:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:40 INFO - 'MOZ_NO_REMOTE': '1', 03:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:40 INFO - 'NO_EM_RESTART': '1', 03:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:40 INFO - 'PWD': '/builds/slave/test', 03:29:40 INFO - 'SHELL': '/bin/bash', 03:29:40 INFO - 'SHLVL': '1', 03:29:40 INFO - 'TERM': 'linux', 03:29:40 INFO - 'TMOUT': '86400', 03:29:40 INFO - 'USER': 'cltbld', 03:29:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:40 INFO - '_': '/tools/buildbot/bin/python'} 03:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:41 INFO - Running setup.py (path:/tmp/pip-RsX6j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:41 INFO - Running setup.py (path:/tmp/pip-JcI4lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:41 INFO - Running setup.py (path:/tmp/pip-U01Usa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:41 INFO - Running setup.py (path:/tmp/pip-y6f0sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:41 INFO - Running setup.py (path:/tmp/pip-1e3tY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:41 INFO - Running setup.py (path:/tmp/pip-NAERqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:41 INFO - Running setup.py (path:/tmp/pip-25epuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:41 INFO - Running setup.py (path:/tmp/pip-nL4kM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:41 INFO - Running setup.py (path:/tmp/pip-qPXjIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:41 INFO - Running setup.py (path:/tmp/pip-QpFTIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:41 INFO - Running setup.py (path:/tmp/pip-4fxHGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:41 INFO - Running setup.py (path:/tmp/pip-vuy4Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:41 INFO - Running setup.py (path:/tmp/pip-rD5sF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:42 INFO - Running setup.py (path:/tmp/pip-M_CMzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:42 INFO - Running setup.py (path:/tmp/pip-fqnEbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:42 INFO - Running setup.py (path:/tmp/pip-E8F6Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:42 INFO - Running setup.py (path:/tmp/pip-yQoaJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:42 INFO - Running setup.py install for manifestparser 03:29:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:42 INFO - Running setup.py install for mozcrash 03:29:42 INFO - Running setup.py install for mozdebug 03:29:42 INFO - Running setup.py install for mozdevice 03:29:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:29:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:42 INFO - Running setup.py install for mozfile 03:29:42 INFO - Running setup.py install for mozhttpd 03:29:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:42 INFO - Running setup.py install for mozinfo 03:29:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Running setup.py install for mozInstall 03:29:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Running setup.py install for mozleak 03:29:43 INFO - Running setup.py install for mozlog 03:29:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Running setup.py install for moznetwork 03:29:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Running setup.py install for mozprocess 03:29:43 INFO - Running setup.py install for mozprofile 03:29:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Running setup.py install for mozrunner 03:29:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:43 INFO - Running setup.py install for mozscreenshot 03:29:43 INFO - Running setup.py install for moztest 03:29:43 INFO - Running setup.py install for mozversion 03:29:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:44 INFO - Cleaning up... 03:29:44 INFO - Return code: 0 03:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:44 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 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:44 INFO - Using env: {'DISPLAY': ':0', 03:29:44 INFO - 'HOME': '/home/cltbld', 03:29:44 INFO - 'LANG': 'en_US.UTF-8', 03:29:44 INFO - 'LANGUAGE': 'en_US:en', 03:29:44 INFO - 'LOGNAME': 'cltbld', 03:29:44 INFO - 'MAIL': '/var/mail/cltbld', 03:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:44 INFO - 'MOZ_NO_REMOTE': '1', 03:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:44 INFO - 'NO_EM_RESTART': '1', 03:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:44 INFO - 'PWD': '/builds/slave/test', 03:29:44 INFO - 'SHELL': '/bin/bash', 03:29:44 INFO - 'SHLVL': '1', 03:29:44 INFO - 'TERM': 'linux', 03:29:44 INFO - 'TMOUT': '86400', 03:29:44 INFO - 'USER': 'cltbld', 03:29:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:44 INFO - '_': '/tools/buildbot/bin/python'} 03:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:44 INFO - Running setup.py (path:/tmp/pip-KAmazB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:44 INFO - Running setup.py (path:/tmp/pip-T3e8up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:44 INFO - Running setup.py (path:/tmp/pip-FIHigt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:44 INFO - Running setup.py (path:/tmp/pip-MZXZxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:44 INFO - Running setup.py (path:/tmp/pip-5IRe09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:44 INFO - Running setup.py (path:/tmp/pip-Z4Nz_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:44 INFO - Running setup.py (path:/tmp/pip-FSbTyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:44 INFO - Running setup.py (path:/tmp/pip-JfwFBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:44 INFO - Running setup.py (path:/tmp/pip-VbUfCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:44 INFO - Running setup.py (path:/tmp/pip-OswWZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:45 INFO - Running setup.py (path:/tmp/pip-9O2Csw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:45 INFO - Running setup.py (path:/tmp/pip-eDaZwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:45 INFO - Running setup.py (path:/tmp/pip-VDGMYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:45 INFO - Running setup.py (path:/tmp/pip-s14TKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:45 INFO - Running setup.py (path:/tmp/pip-NWtfNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:45 INFO - Running setup.py (path:/tmp/pip-5IEyf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:45 INFO - Running setup.py (path:/tmp/pip-BYbUmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:47 INFO - Downloading blessings-1.6.tar.gz 03:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:47 INFO - Installing collected packages: blessings 03:29:47 INFO - Running setup.py install for blessings 03:29:47 INFO - Successfully installed blessings 03:29:47 INFO - Cleaning up... 03:29:47 INFO - Return code: 0 03:29:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:47 INFO - Reading from file tmpfile_stdout 03:29:47 INFO - Current package versions: 03:29:47 INFO - argparse == 1.2.1 03:29:47 INFO - blessings == 1.6 03:29:47 INFO - blobuploader == 1.2.4 03:29:47 INFO - docopt == 0.6.1 03:29:47 INFO - functools32 == 3.2.3-2 03:29:47 INFO - jsonschema == 2.5.1 03:29:47 INFO - manifestparser == 1.1 03:29:47 INFO - mozInstall == 1.12 03:29:47 INFO - mozcrash == 0.17 03:29:47 INFO - mozdebug == 0.1 03:29:47 INFO - mozdevice == 0.48 03:29:47 INFO - mozfile == 1.2 03:29:47 INFO - mozhttpd == 0.7 03:29:47 INFO - mozinfo == 0.9 03:29:47 INFO - mozleak == 0.1 03:29:47 INFO - mozlog == 3.3 03:29:47 INFO - moznetwork == 0.27 03:29:47 INFO - mozprocess == 0.23 03:29:47 INFO - mozprofile == 0.28 03:29:47 INFO - mozrunner == 6.12 03:29:47 INFO - mozscreenshot == 0.1 03:29:47 INFO - mozsystemmonitor == 0.3 03:29:47 INFO - moztest == 0.7 03:29:47 INFO - mozversion == 1.4 03:29:47 INFO - psutil == 3.1.1 03:29:47 INFO - requests == 1.2.3 03:29:47 INFO - wsgiref == 0.1.2 03:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:47 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 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:47 INFO - Using env: {'DISPLAY': ':0', 03:29:47 INFO - 'HOME': '/home/cltbld', 03:29:47 INFO - 'LANG': 'en_US.UTF-8', 03:29:47 INFO - 'LANGUAGE': 'en_US:en', 03:29:47 INFO - 'LOGNAME': 'cltbld', 03:29:47 INFO - 'MAIL': '/var/mail/cltbld', 03:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:47 INFO - 'MOZ_NO_REMOTE': '1', 03:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:47 INFO - 'NO_EM_RESTART': '1', 03:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:47 INFO - 'PWD': '/builds/slave/test', 03:29:47 INFO - 'SHELL': '/bin/bash', 03:29:47 INFO - 'SHLVL': '1', 03:29:47 INFO - 'TERM': 'linux', 03:29:47 INFO - 'TMOUT': '86400', 03:29:47 INFO - 'USER': 'cltbld', 03:29:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:47 INFO - '_': '/tools/buildbot/bin/python'} 03:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:48 INFO - Cleaning up... 03:29:48 INFO - Return code: 0 03:29:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:48 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 0x2478030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, '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': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:48 INFO - Using env: {'DISPLAY': ':0', 03:29:48 INFO - 'HOME': '/home/cltbld', 03:29:48 INFO - 'LANG': 'en_US.UTF-8', 03:29:48 INFO - 'LANGUAGE': 'en_US:en', 03:29:48 INFO - 'LOGNAME': 'cltbld', 03:29:48 INFO - 'MAIL': '/var/mail/cltbld', 03:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:48 INFO - 'MOZ_NO_REMOTE': '1', 03:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:48 INFO - 'NO_EM_RESTART': '1', 03:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:48 INFO - 'PWD': '/builds/slave/test', 03:29:48 INFO - 'SHELL': '/bin/bash', 03:29:48 INFO - 'SHLVL': '1', 03:29:48 INFO - 'TERM': 'linux', 03:29:48 INFO - 'TMOUT': '86400', 03:29:48 INFO - 'USER': 'cltbld', 03:29:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:48 INFO - '_': '/tools/buildbot/bin/python'} 03:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:48 INFO - Cleaning up... 03:29:48 INFO - Return code: 0 03:29:48 INFO - Running post-action listener: _resource_record_post_action 03:29:48 INFO - Running post-action listener: _start_resource_monitoring 03:29:48 INFO - Starting resource monitoring. 03:29:48 INFO - [mozharness: 2016-09-03 10:29:48.347733Z] Finished create-virtualenv step (success) 03:29:48 INFO - [mozharness: 2016-09-03 10:29:48.348176Z] Running install step. 03:29:48 INFO - Running pre-action listener: _resource_record_pre_action 03:29:48 INFO - Running main action method: install 03:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:48 INFO - Reading from file tmpfile_stdout 03:29:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:48 INFO - Reading from file tmpfile_stdout 03:29:48 INFO - Output received: 03:29:48 INFO - Usage: mozinstall [options] installer 03:29:48 INFO - Options: 03:29:48 INFO - -h, --help show this help message and exit 03:29:48 INFO - -d DEST, --destination=DEST 03:29:48 INFO - Directory to install application into. [default: 03:29:48 INFO - "/builds/slave/test"] 03:29:48 INFO - --app=APP Application being installed. [default: firefox] 03:29:48 INFO - mkdir: /builds/slave/test/build/application 03:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:30:05 INFO - Reading from file tmpfile_stdout 03:30:05 INFO - Output received: 03:30:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:05 INFO - Running post-action listener: _resource_record_post_action 03:30:05 INFO - [mozharness: 2016-09-03 10:30:05.203073Z] Finished install step (success) 03:30:05 INFO - [mozharness: 2016-09-03 10:30:05.203346Z] Running run-tests step. 03:30:05 INFO - Running pre-action listener: _resource_record_pre_action 03:30:05 INFO - Running main action method: run_tests 03:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:05 INFO - Python 2.7.3 03:30:05 INFO - Return code: 0 03:30:05 INFO - grabbing minidump binary from tooltool 03:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:05 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2736570>, '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 0x2737470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2737900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:05 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 03:30:05 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 03:30:05 INFO - Calling ['/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'] with output_timeout 600 03:30:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:05 INFO - Return code: 0 03:30:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:05 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:30:05 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:30:05 INFO - Using env: {'DISPLAY': ':0', 03:30:05 INFO - 'HOME': '/home/cltbld', 03:30:05 INFO - 'LANG': 'en_US.UTF-8', 03:30:05 INFO - 'LANGUAGE': 'en_US:en', 03:30:05 INFO - 'LOGNAME': 'cltbld', 03:30:05 INFO - 'MAIL': '/var/mail/cltbld', 03:30:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:05 INFO - 'MOZ_NO_REMOTE': '1', 03:30:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:05 INFO - 'NO_EM_RESTART': '1', 03:30:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:05 INFO - 'PWD': '/builds/slave/test', 03:30:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:05 INFO - 'SHELL': '/bin/bash', 03:30:05 INFO - 'SHLVL': '1', 03:30:05 INFO - 'TERM': 'linux', 03:30:05 INFO - 'TMOUT': '86400', 03:30:05 INFO - 'USER': 'cltbld', 03:30:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134', 03:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:05 INFO - '_': '/tools/buildbot/bin/python'} 03:30:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:30:05 INFO - mozversion application_buildid: 20160902160050 03:30:05 INFO - mozversion application_changeset: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd 03:30:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:30:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:05 INFO - mozversion application_name: Firefox 03:30:05 INFO - mozversion application_remotingname: firefox-dev 03:30:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:05 INFO - mozversion application_vendor: Mozilla 03:30:05 INFO - mozversion application_version: 50.0a2 03:30:05 INFO - mozversion platform_buildid: 20160902160050 03:30:05 INFO - mozversion platform_changeset: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd 03:30:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:05 INFO - mozversion platform_version: 50.0a2 03:30:05 INFO - using testdate: 1472898605 03:30:05 INFO - actual date: 1472898605 03:30:05 INFO - starting webserver on 'localhost:57226' 03:30:05 INFO - SUITE-START | Running 2 tests 03:30:05 INFO - TEST-START | dromaeo_css 03:30:05 INFO - operating with platform_type : linux_ 03:30:05 INFO - Initialising browser for dromaeo_css test... 03:30:05 INFO - TEST-INFO | started process 17986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8gYa_n/profile http://localhost:57226/getInfo.html) 03:30:09 INFO - PROCESS | 17986 | __metrics Screen width/height:1600/1200 03:30:09 INFO - PROCESS | 17986 | colorDepth:24 03:30:09 INFO - PROCESS | 17986 | Browser inner width/height: 1024/697 03:30:09 INFO - PROCESS | 17986 | __metrics 03:30:10 ERROR - PROCESS | 17986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:30:11 INFO - TEST-INFO | 17986: exit 0 03:30:11 INFO - Browser initialized. 03:30:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:11 INFO - TEST-INFO | started process 18113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8gYa_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:23 INFO - PROCESS | 18113 | RSS: Main: 152838144 03:30:23 INFO - PROCESS | 18113 | 03:31:12 INFO - PROCESS | 18113 | 1472898672650 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] 03:33:21 INFO - PROCESS | 18113 | Cycle 1(1): loaded http://localhost:57226/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57226/tests/dromaeo/cssquery-ext.html) 03:33:22 INFO - PROCESS | 18113 | RSS: Main: 157573120 03:33:22 INFO - PROCESS | 18113 | 03:36:24 INFO - PROCESS | 18113 | Cycle 1(1): loaded http://localhost:57226/tests/dromaeo/cssquery-ext.html (next: http://localhost:57226/tests/dromaeo/cssquery-jquery.html) 03:36:25 INFO - PROCESS | 18113 | RSS: Main: 154267648 03:36:25 INFO - PROCESS | 18113 | 03:39:26 INFO - PROCESS | 18113 | Cycle 1(1): loaded http://localhost:57226/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57226/tests/dromaeo/cssquery-mootools.html) 03:39:27 INFO - PROCESS | 18113 | RSS: Main: 154865664 03:39:27 INFO - PROCESS | 18113 | 03:42:29 INFO - PROCESS | 18113 | Cycle 1(1): loaded http://localhost:57226/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57226/tests/dromaeo/cssquery-prototype.html) 03:42:30 INFO - PROCESS | 18113 | RSS: Main: 152928256 03:42:30 INFO - PROCESS | 18113 | 03:45:32 INFO - PROCESS | 18113 | Cycle 1(1): loaded http://localhost:57226/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57226/tests/dromaeo/cssquery-yui.html) 03:45:33 INFO - PROCESS | 18113 | RSS: Main: 155246592 03:45:33 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | Cycle 1(1): loaded http://localhost:57226/tests/dromaeo/cssquery-yui.html (next: http://localhost:57226/tests/dromaeo/cssquery-dojo.html) 03:48:35 INFO - PROCESS | 18113 | RSS: Main: 156405760 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | __start_tp_report 03:48:35 INFO - PROCESS | 18113 | _x_x_mozilla_page_load 03:48:35 INFO - PROCESS | 18113 | _x_x_mozilla_page_load_details 03:48:35 INFO - PROCESS | 18113 | |i|pagename|runs| 03:48:35 INFO - PROCESS | 18113 | |0;dojo.html;3253.0891350421884;3255.706986371227;3256.918577035574;3268.9673103268974;3292.094673964661;5726.856828579288;5773.191753154557;5787.363390027093;5809.912851307228;5813.5349172066235;5811.564132690044;5818.621789583674;5830.008898487256;5847.532197424206;5853.180554722342;5259.789608415668;5274.997750427407;5304.496072873071;5315.309009828717;5328.8401347959625;5149;5155;5194.065068287707;5235.921461178085;5262.4474430184855;5214.817481388133;5252.474752524736;5263.315768950031;5295.285136506561;5356.892862142755;5294.894102117974;5310;5313.601479889024;5313.920291195615;5314.654547454442;4958.9752051239875;5126.512981266774;5172.793088276464;5203.557697595671;5245.082110630662;5697.6296540724725;5792.507636850873;5795.420457954213;5798.362180160179;5831.037878750044;6232.594881332744;6240.656763878031;6243.812685619393;6277.340879207663;6294.968525157345;5888.38171991939;6091.482224010964;6283.277423096357;6286.528510361695;6316.399942005502;5721.284839395075;5863.2670916135485;5871.383504732027;5897.262842144732;5900.498457631106;6342.5560210785725;6367.267764207083;6392.936070639327;6395.232572091379;6396.136521569621;5960.970195149083;5975.52195824333;5995.820125396245;6044.274687037584;6054.606450580698;6111.633302001894;6196.225471816023;6209.9068513972325;6211.09939058834;6225.564210505312;6118.3269840317525;6179.412955769285;6181.412765787243;6183.938160618426;6185.134081228632;5916.3787802281;6076.787312444043;6145.631262124287;6148.815535533941;6163.537734669918;4666.696664716783;4735.715857048588;4736;4756.21522448799;4765.642576806753;4188.701292864529;4210.810513526899;4220.345846393814;4238.766867822299;4244.0663054128045;5609.046462101453;5827.155062515996;5971.253593300838;5988.880222395528;5990.880182396415;6047.969760151259;6145.293291271471;6194.411530904647;6204.410580994799;6207.937920620736;5920.911186332209;5930.406959304121;5934.851628709317;5935.495482884004;5956.791512297049;5124.103281925648;5236.266922630834;5297.231901374356;5305.761240744098;5306.893862122736;6286.654234017082;6393.744250230032;6413.935860641333;6431.485481161496;6442.838929026718;6167.475764560063;6189.226346706661;6204;6204.038374052029;6214.9067763982675;6135.875804921915;6244;6358.841028974312;6420.390062944013;6426.807195784134;5986.910196346971;6046.606970546901;6068.362821903636;6071.089336599545;6108.175396321618;6158.753649853956;6158.938410615837;6177.135201071944;6179.752809887555;6196.721147548461;5822.854428639318;5987.221661184019;5997.490213331916;6033.577649564489;6042.1843051187525;6055.848603784941;6066.090086486885;6072.240969878765;6090.634561926298;6108.08378743192;5929.792457263975;5966.612170208922;5976.432238937294;5992.460678538952;5995.070764031408;5836;5972.5520585955355;5992.910106348321;6047.244094488189;6091.817245482643;5851.239338886088;5917.704114794157;5953.047512397996;5957.076653118774;5987.072003839412 03:48:35 INFO - PROCESS | 18113 | |1;ext.html;554.3014675278253;588.3087372337503;614.6066517428847;665.4875745675832;685.263341907449;36194;40179.59820401795;40372.79813600932;40390.79804600973;40406.79796601013;39748.602513974925;39872.80063599678;39893.800530997374;40135.79932100335;40242.59757402425;9000.909990900089;9206.723798286028;9208.401453905508;9210.861837072449;9220.077992200793;9060.954695226548;9135.17783399494;9153.130452606993;9177.311701622371;9189.632414703405;8986.550672466383;9015.413998090104;9016.819663606724;9032.32257580684;9035.096490350978;9194.862077068816;9221.077892210793;9231.123043310909;9256.166944974917;9294.256459483226;9193.908060919372;9198.724038278862;9227.907720922773;9237;9262.444253344753;44454;44651;44652.55347446517;44669.77665111654;44914;3747.3254814133447;3776.8736211473147;3789.7915614641183;3841.3661745811905;3865.381538953754;35100.64899351025;35511.28977420437;35609;35728.46407303892;35810.64189358099;4386.144701783153;4458.974435879766;4493.370928070073;4506.301523263866;4543.227651299287;376428;378445;379709;380491;380536;63909.68045159744;64037.35962640407;64541.67729161324;64615.353846461876;64702;34425.483617745755;35174.824125879204;35514.46728299077;36289.45565816515;36428.45357319642;16466.588335291715;16718.41485548;16740.49778506647;16846.747298790528;16852;12368.505259789508;12445.62663120108;12446.31545265001;12536.686582835502;12566.81149782754;21168.25911093135;21196.576068478545;21239.362819115453;21246.150153993975;21386.572268554854;7555.6977720890545;7647.197044310378;7753.302202801775;7758.495697779626;7786.610669466504;1063.2982231727024;1083.6207327435493;1119.0208567503435;1147.2485521983115;1188.762247550476;34449.31101378008;34593.308133837185;34799;34897.12757181091;35005.299894001975;1005.582683186484;1015.3400289811682;1189.7739429508365;1198.7353342224037;1226.969325766863;17174.570635733955;17334;17351.13244337778;17490.65018699619;17492.5626859327;658689;659276;661062;661179;664601;67811;68188.3181168192;68898.65550672315;68959;68992.31007689859;1422.0133239063657;1452.4408102880468;1474.7336874276532;1476.4463326252655;1486.2865824404346;32806.83596582002;32883.34233315368;33095.834520827244;33445.66554334426;33879.49180762241;57107.14339284831;57452.13821792593;57801;58075.419245807;58096;430160;430542;431581;432248;432448;30713.232169195948;31054.84472577713;31508.527372089895;31614.841925790224;31799.205019874687;50584.24123638222;50801;51045.74477127591;51183;51838.740806295726;43068.35397468978;43454.78272608617;45108;45648;46271.537284628066;42780;43317;44079;44610.55389446064;45200.547994519635;36383.636163638024;37803.810980944916;41899.58100418957;42402;43067.56932430636;37527;37595;38532;38568.80715596404;39295.41056884092;29672.258193545335;29763.404731904808;30173.69826301709;32390;32585.348293033534 03:48:35 INFO - PROCESS | 18113 | |2;jquery.html;392.2351414741255;400.93785463253187;407.9306517891958;411.8846722917584;423.78175239751516;15387.923060384683;19148.90425547872;20881;20936.581268374623;21396.8930155349;20031.59936801263;20082.49793755157;21088.68366974493;21202.469938251514;21237.15051397942;5848.327442344143;5980.372060933604;5987.191729116557;5995.340512543617;6018.368071352511;5502.5597952163735;5911.704414779266;5935.73289201987;6044.365341639131;6077.24034495688;5680.573956953224;5750.856228594277;5755.338136114337;5773.624714393572;5776.942230577703;5811.941880581204;6393.648349340784;6440.194975628046;6441.066045423434;6457.192850893614;5069.695818250917;5294.867628309285;5347.4919882611475;5879.52963762898;6007.128966299906;14029.368678409495;14213.715725685532;14282.928585357007;25019;25046;2494.48862983088;2582.7029891562524;2723.9591406128925;2890.8554572271514;3064.2033071401597;10279;10727.302725322907;10769.676909692644;10848.783024339547;14612.991420759969;1933.236371633211;1945.231633504772;1977.6637971544872;1978.881267123977;1991.3229501969256;76933;90568.54715726379;90687.54656226677;91349.54325228398;91659;10807.621733239455;11072.114230861513;11103.333799972028;11208.775824483628;11214.831777523344;15278;15315.387384504718;15328.923355383375;15345.846541534665;15358.692826143415;8153.510789352539;8234.135415781377;8316.501009939422;8389.161083891562;8437.282830959315;7804.921950780533;7856.803579910434;7886.692379489688;8045.597720113971;8082.393820463371;4497.8425755098415;4638.582527572535;4656.767161641905;4703.717776933395;4709.434867815884;1929.5851391950798;1993.1230258686132;2027.6552985992416;2053.671412573981;2086.5201003769216;1000.7548150702979;1018.4469674453725;1103.7516558774373;1111.5664890692635;1139.7492551638627;20633.277835275694;21298;21367.431785627094;21414.357569272634;21504.78495215028;1066.6000249906285;1072.4744875011345;1084.6854412220368;1094.4637127807475;1119.261287550213;10246.846297305547;11864;11882.524699012116;11946.163768536118;12024.579139730067;535104;540876;552146;553260;553791;97973.5101324503;100202.4989875046;102411.4879425598;102970.48514757378;103668;1004.3170643962176;1034.715453250347;1056;1105.9447027648746;1117.6591139702468;15707.842921570638;18023.549411264823;18665.346712864986;18748.531286717942;18832.62334753325;33014.66985330116;37736.433953490174;44142.77928610337;44392;44525;61222.69388653028;62433.375666244574;64883.35116648962;66429.66785166043;66465.33534664591;8908.242799362128;8933.19601235892;8989.685361012333;8989.730308090768;9143.588538515916;10199.796004080024;14441;14578.416863325348;14736.705265894836;14941.626459338604;12553.748925021631;12595.874041259836;12926.870731292944;12934.159279646792;12979.41592628315;12343.07426942965;12608.432620531914;12609.747805044031;12643.120948758871;12763.234205947672;12383.69040773988;12553;12757.53288371812;12799.232046077264;12972.740545189232;7621.733239336819;8127.2279133482225;8338.24955753985;8906.465612063297;9090.772730681785;8803.515806630441;12513.687157821127;12725.490980361052;13021.544245951347;13137.474501019853 03:48:35 INFO - PROCESS | 18113 | |3;mootools.html;1339.2366351179828;1342.7985802129683;1488.7469130247857;1792.7131658934572;1806.4129158023638;8631.611577479012;9228.86156707649;9298.535073246345;9879.851802222964;9946.055124763145;9353.67262145825;9628.277879159055;9765.2187824974;9779;9803.117719405253;2490.576601977664;2534.708508521516;2539.3270783242456;2540.5681034224226;2544.8727563621837;2498.0757119865675;2579.66464359633;2591.8056145789046;2592.222333300012;2597.5324441600505;2505.649209110726;2510.046182450666;2561.398071453207;2562.052040744927;2562.4362640219124;2518.7481251874756;2526.936826579341;2535.2647732157743;2536.88584013718;2538.669972903529;2490.464550121714;2498.3254521279337;2499.1128149506844;2499.6750422444966;2523.104297974229;9764.365316254492;9809.656662016867;9814.950925245399;9841.950790246074;9862.408255504693;5645.661260324394;5762.135679648044;5782.768689252425;5815.185873977646;5820.941790582082;3568.4825700273573;3646.1613828819254;3655.981720091409;3699.8335074921692;3715.8142092895246;1182.8757980412106;1202;1210.7154818617619;1301.3233118778278;1338.6586420462818;12809.807852882213;13004.284764337957;13206.141600796014;13682.384292706853;13741.931290343584;4884.584810291165;4907.190313598217;4929.728864912464;5018;5068.493150684976;10694.144468442506;10769.62306319275;10771;10818.134549236041;10821.729456763487;5717.656940583578;5742.885142297214;5771.971140144273;5780.16187652788;5780.566457515703;4788.521147885253;5218.8956220876125;5326.094563924142;5365.382980957162;5369.087255166631;4166.33338665812;4191.937120943188;4218.198542276958;4254.085371645111;4290.914181716348;1258.930758808256;1269.041873385588;1273.7579859826603;1278.5397256987662;1283.525095714573;954.346272803132;1041.182671602788;1063.5107850388908;1069.1286601419818;1078.2506158219962;6408.17505453025;6658.234303055114;6675.86648267032;6701.29636388182;6889.173299204027;492.0356102040042;500.82306579537794;1052.9262951593314;1156.1964434717959;1167.0197034491068;4498.6626003049905;4598.632109431237;4650.348951146842;4790.736509491941;4876.244182151772;11950.103742219195;12271.386430678609;12423.875761242452;12424.316662583644;12448.439820208112;11396.943015285036;11869.050475961902;11950.820737688942;12362.38188090592;12398.504059837685;8493.150684931581;8659.870101948476;8682.565871706389;8728.432651877607;8752.299816014704;6567.113439685581;6700.66496675174;6769.559978601375;6771.559848609824;6788.558743681645;10421.322614030063;10899.618513352312;11242;11250.7749845001;11302.717432064264;10954.507047182737;11278.887211128113;11279.266847654877;11304.547818087512;11373.033292170257;7864.252895974873;8360.331173506227;8624.913750862663;8634.309255259439;8850.38047336706;9540.809183816424;9569.808603828023;9585.137337639646;9623.518824058629;9633.566489507848;8257.83484330322;8332.666693332441;8367.205115514016;8443.831123377375;8596.613152408281;8049.074356448849;8137.267645911897;8192.83614327722;8204.876926846222;8316.584170791557;7673.079230492377;7844.333231675371;7859.60701964888;7977.162397948364;8033.11635720082;5593.416228279969;5639.520640745583;5779.7110144493445;5796.884062318814;5825.271841019872;5751.626144300607;5756.280464941882;5930.614510056833;6020.247469066367;6093.482054025458 03:48:35 INFO - PROCESS | 18113 | |4;prototype.html;346.7382126494497;351.04865813645023;352.4660139888068;353.11896817440476;358.7273672009275;5786.971065144674;5838.883222335551;5866;5896;5926.377730338317;5763.481286684198;5783.855403614902;5786.264120763775;5816.371416003515;5852.151438041481;4387.890302742441;4439.778011099448;4478.619317358029;4483.820647174109;4499.865004049884;4474;4476.985356589532;4501.212287849629;4512.503624601291;4515.480719717241;4449.777511124447;4458.3535387368975;4487.887802804923;4489.483709373415;4516.728996260234;4318.309070548713;4425.513193548707;4428.601425871655;4440.24515832306;4453.910921781546;3925.8233379497706;3933.606639336072;3935.134270460494;3945.842166313344;3949.723519353646;5639.887202255932;5662.546996240291;5690.829275121753;5694.914576281318;5700.201971723962;5043.747812609392;5089.694618322913;5124.1801311790305;5141.38303403594;5189.091908915962;6025.517958563304;6026.8493287667725;6040.456358927718;6046.486048685867;6117.113018612321;4336.436263285784;4348.21732088224;4357.7385356878685;4358.975640724428;4364.759938203398;6033.577649564532;6103.87792244157;6308.905366419507;6353.174087368612;6365.904511432333;4410.911781764346;4449.755263460541;4458.665600080007;4474.172278128557;4479.731216126977;4508.887277818015;4514.6614003949835;4520.61574766142;4522.570355816192;4523.163214805271;4946.431160416526;5144.790974121079;5171.224316352502;5192.7403629818355;5193.870153246199;6061.909071363933;6069.119977603311;6129.272473749228;6150.261968563712;6212.502999760009;1536.4929573240804;1553.3631211203578;1554.5414102839688;1556.6808804195339;1566.2403734188908;926.2775035472342;972.397113789455;984.6996666016934;990.9058639429243;991.940483570988;5227.504346262212;5270.262163297141;5321.840344789663;5353.866153346197;5356.91964620531;5589.469000445032;5597.328320601554;5636.239107720406;5652;5652.18043383707;5059.898802024012;5249.527542521115;5266.0257852297445;5347.224652425377;5423.566114710814;2950.5131653276967;2961.067263811892;2963.3776906849803;2975.9851200743856;2992.38656075504;5499.560035197254;5703.857403564944;5723.6851973141875;5740.937926483614;5773.740181691834;5572.247746554244;5588.776448941997;5591.664500130005;5610.4670056344585;5661.943380566142;5715.656580801851;5751.338596061423;5770.336411312753;5812.6221795584;5845.398797535141;5462.9726851365485;5524.033294173423;5530.668159910419;5654.0210926175505;5694.914576281442;5364.90019546;5484.533814625802;5503.917441238465;5508.697021663686;5532.834014979557;6212.844678883064;6380.491898263837;6479.416852483299;6591.87938050523;6593.736250549924;4356.673249506236;4359.215341238608;4374.534530932174;4380.890477738082;4381.868543943687;6156.384361563808;6267.2479302484;6290.49676025926;6294.527910406646;6338.0809782580345;6099.268087829489;6115.84710382244;6146.832101900624;6152.569320147726;6160.383961603804;5841.678707671119;6127.234095738033;6140.785072522441;6168.568200225941;6198.783042593487;5987.520998320211;6043.516518678407;6053.878922421439;6077.05805600115;6084.817455476343;6136.539759518143;6163.753449862134;6168.845778855564;6179.320274769681;6218.378162183745;5840.561957853263;6003.898635477548;6008.24896887889;6018.849528761816;6033.849153771191 03:48:35 INFO - PROCESS | 18113 | |5;yui.html;857.9270761985235;868.6308318964439;898.4474548152884;908.6138391183745;924.2144177449173;16583;17371.565710857234;17486.912565437156;17522.82477175228;17627.559311017216;15714.528564143066;16021.439249626266;16055.598610034755;16091.908171609764;16224.75662865055;884.1467983396005;899.3974037394928;901.9278457723399;902.5577467041136;904.2043002158092;585.7071464267866;602.442740465068;607.9392060793907;742.4172024960408;891.5809569502356;928.1739252065667;932.1936524905941;933.6218831373304;934.7896723237285;935.7941252924346;921.7326975177191;928.7585227840742;928.9303302252358;931.4225180388203;933.2394098809483;680.9216940051908;682.5290549520814;683.596677960006;685.1948959972013;687.7489716253582;15810.604734881605;15816.920915395465;15860.36558537657;15891.36434542617;15922.920385398114;14975.475858344906;16338.183090845529;16577.91711041449;17128.57178570533;17274.654506909916;12782.488700452064;12804.423800928887;12889.613311600668;12922.547710830077;12934.935325323408;4082.12234369609;4127.9174416511805;4165.354370072643;4167.562405947392;4238.91522169558;87215.12784872134;87246.56376718139;87356;87365;88534.5573272136;12187.329696866758;12206.511739530497;12221.938890305491;12271.815922761165;12500.124991250525;23944.7605523946;23947.760522394903;24004.63993040106;24089.277321680376;24743.133990310253;8321.375896807764;8389.874151887727;8404.243618074403;9176.908230917605;9352.345335826427;5138.075146473596;5141.074606570854;5175.585953123741;5191.299174611455;5335.1730481775385;3720.813959302024;3891.105045839473;3894.7078969077434;3906.4921560197563;3909.100906791454;665.723724654263;672.8082496488478;674.3795707948699;685.2325395557008;714.8927660850914;708.3589351636776;721.3543878228955;726.4841962206892;736.8268456912622;755.1165136789969;9724;10525.789484210272;10731.946340268405;10813;10998.34009959405;753.8718417868976;769.7870949205865;781.1017330070464;781.386611509962;784.9097353804385;5151.891102773753;5153.1497302945345;5174.172132458789;5196.792128314901;5228.111221092423;130828;133295;134336;137098.31450842883;137479.31260343635;76366.61816690992;115191.42404287925;116282;117270.41364793121;121062;103284.48357758163;103799;104025.95974040314;105772.47113764382;105995.47002264939;9706.9029309706;9828.397783471268;9869.309148359833;9949.9473652849;9977.950110249401;59585;60105.699471504115;60294.39705602888;60358.39641603528;61451.692741536004;83128.16871831204;84875;86453.56773216346;86602.56698716467;87091.12908871083;12318.568850090203;12353.581385640535;12363.443645035815;12683.365831708563;12869.22784632925;13327.133736307109;13330.200187988752;13518.188908665512;13685;14227.573172804832;12821;13174.275414852274;13253.86746132565;13564.593062208149;13965.930170349084;12722.427490763122;13016.15394999322;13416.195028298333;13680.110792798436;13761.931190343985;12863.356832158543;13080;13354.198748075147;13561.321933903067;14138.08102473336;11213.383263920563;11323.886761132284;11504.769904602028;11913.52345906154;11944.76110477803;11651.825222621837;12265;13012.036208096859;13396.665083372995;13663.38514766818 03:48:35 INFO - PROCESS | 18113 | __end_tp_report 03:48:35 INFO - PROCESS | 18113 | __start_cc_report 03:48:35 INFO - PROCESS | 18113 | _x_x_mozilla_cycle_collect,321 03:48:35 INFO - PROCESS | 18113 | __end_cc_report 03:48:35 INFO - PROCESS | 18113 | __startTimestamp1472899715811__endTimestamp 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | ------- Summary: start ------- 03:48:35 INFO - PROCESS | 18113 | Number of tests: 6 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | [#0] dojo.html Cycles:165 Average:5735.44 Median:5966.61 stddev:661.31 (11.1%) stddev-sans-first:634.02 03:48:35 INFO - PROCESS | 18113 | Values: 3253.1 3255.7 3256.9 3269.0 3292.1 5726.9 5773.2 5787.4 5809.9 5813.5 5811.6 5818.6 5830.0 5847.5 5853.2 5259.8 5275.0 5304.5 5315.3 5328.8 5149.0 5155.0 5194.1 5235.9 5262.4 5214.8 5252.5 5263.3 5295.3 5356.9 5294.9 5310.0 5313.6 5313.9 5314.7 4959.0 5126.5 5172.8 5203.6 5245.1 5697.6 5792.5 5795.4 5798.4 5831.0 6232.6 6240.7 6243.8 6277.3 6295.0 5888.4 6091.5 6283.3 6286.5 6316.4 5721.3 5863.3 5871.4 5897.3 5900.5 6342.6 6367.3 6392.9 6395.2 6396.1 5961.0 5975.5 5995.8 6044.3 6054.6 6111.6 6196.2 6209.9 6211.1 6225.6 6118.3 6179.4 6181.4 6183.9 6185.1 5916.4 6076.8 6145.6 6148.8 6163.5 4666.7 4735.7 4736.0 4756.2 4765.6 4188.7 4210.8 4220.3 4238.8 4244.1 5609.0 5827.2 5971.3 5988.9 5990.9 6048.0 6145.3 6194.4 6204.4 6207.9 5920.9 5930.4 5934.9 5935.5 5956.8 5124.1 5236.3 5297.2 5305.8 5306.9 6286.7 6393.7 6413.9 6431.5 6442.8 6167.5 6189.2 6204.0 6204.0 6214.9 6135.9 6244.0 6358.8 6420.4 6426.8 5986.9 6046.6 6068.4 6071.1 6108.2 6158.8 6158.9 6177.1 6179.8 6196.7 5822.9 5987.2 5997.5 6033.6 6042.2 6055.8 6066.1 6072.2 6090.6 6108.1 5929.8 5966.6 5976.4 5992.5 5995.1 5836.0 5972.6 5992.9 6047.2 6091.8 5851.2 5917.7 5953.0 5957.1 5987.1 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | [#1] ext.html Cycles:180 Average:64998.63 Median:40398.80 stddev:134754.73 (333.6%) stddev-sans-first:135045.89 03:48:35 INFO - PROCESS | 18113 | Values: 554.3 588.3 614.6 665.5 685.3 36194.0 40179.6 40372.8 40390.8 40406.8 39748.6 39872.8 39893.8 40135.8 40242.6 9000.9 9206.7 9208.4 9210.9 9220.1 9061.0 9135.2 9153.1 9177.3 9189.6 8986.6 9015.4 9016.8 9032.3 9035.1 9194.9 9221.1 9231.1 9256.2 9294.3 9193.9 9198.7 9227.9 9237.0 9262.4 44454.0 44651.0 44652.6 44669.8 44914.0 3747.3 3776.9 3789.8 3841.4 3865.4 35100.6 35511.3 35609.0 35728.5 35810.6 4386.1 4459.0 4493.4 4506.3 4543.2 376428.0 378445.0 379709.0 380491.0 380536.0 63909.7 64037.4 64541.7 64615.4 64702.0 34425.5 35174.8 35514.5 36289.5 36428.5 16466.6 16718.4 16740.5 16846.7 16852.0 12368.5 12445.6 12446.3 12536.7 12566.8 21168.3 21196.6 21239.4 21246.2 21386.6 7555.7 7647.2 7753.3 7758.5 7786.6 1063.3 1083.6 1119.0 1147.2 1188.8 34449.3 34593.3 34799.0 34897.1 35005.3 1005.6 1015.3 1189.8 1198.7 1227.0 17174.6 17334.0 17351.1 17490.7 17492.6 658689.0 659276.0 661062.0 661179.0 664601.0 67811.0 68188.3 68898.7 68959.0 68992.3 1422.0 1452.4 1474.7 1476.4 1486.3 32806.8 32883.3 33095.8 33445.7 33879.5 57107.1 57452.1 57801.0 58075.4 58096.0 430160.0 430542.0 431581.0 432248.0 432448.0 30713.2 31054.8 31508.5 31614.8 31799.2 50584.2 50801.0 51045.7 51183.0 51838.7 43068.4 43454.8 45108.0 45648.0 46271.5 42780.0 43317.0 44079.0 44610.6 45200.5 36383.6 37803.8 41899.6 42402.0 43067.6 37527.0 37595.0 38532.0 38568.8 39295.4 29672.3 29763.4 30173.7 32390.0 32585.3 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | [#2] jquery.html Cycles:180 Average:31423.72 Median:21267.58 stddev:90251.97 (424.4%) stddev-sans-first:90475.08 03:48:35 INFO - PROCESS | 18113 | Values: 392.2 400.9 407.9 411.9 423.8 15387.9 19148.9 20881.0 20936.6 21396.9 20031.6 20082.5 21088.7 21202.5 21237.2 5848.3 5980.4 5987.2 5995.3 6018.4 5502.6 5911.7 5935.7 6044.4 6077.2 5680.6 5750.9 5755.3 5773.6 5776.9 5811.9 6393.6 6440.2 6441.1 6457.2 5069.7 5294.9 5347.5 5879.5 6007.1 14029.4 14213.7 14282.9 25019.0 25046.0 2494.5 2582.7 2724.0 2890.9 3064.2 10279.0 10727.3 10769.7 10848.8 14613.0 1933.2 1945.2 1977.7 1978.9 1991.3 76933.0 90568.5 90687.5 91349.5 91659.0 10807.6 11072.1 11103.3 11208.8 11214.8 15278.0 15315.4 15328.9 15345.8 15358.7 8153.5 8234.1 8316.5 8389.2 8437.3 7804.9 7856.8 7886.7 8045.6 8082.4 4497.8 4638.6 4656.8 4703.7 4709.4 1929.6 1993.1 2027.7 2053.7 2086.5 1000.8 1018.4 1103.8 1111.6 1139.7 20633.3 21298.0 21367.4 21414.4 21504.8 1066.6 1072.5 1084.7 1094.5 1119.3 10246.8 11864.0 11882.5 11946.2 12024.6 535104.0 540876.0 552146.0 553260.0 553791.0 97973.5 100202.5 102411.5 102970.5 103668.0 1004.3 1034.7 1056.0 1105.9 1117.7 15707.8 18023.5 18665.3 18748.5 18832.6 33014.7 37736.4 44142.8 44392.0 44525.0 61222.7 62433.4 64883.4 66429.7 66465.3 8908.2 8933.2 8989.7 8989.7 9143.6 10199.8 14441.0 14578.4 14736.7 14941.6 12553.7 12595.9 12926.9 12934.2 12979.4 12343.1 12608.4 12609.7 12643.1 12763.2 12383.7 12553.0 12757.5 12799.2 12972.7 7621.7 8127.2 8338.2 8906.5 9090.8 8803.5 12513.7 12725.5 13021.5 13137.5 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | [#3] mootools.html Cycles:180 Average:6350.98 Median:4789.63 stddev:3621.37 (75.6%) stddev-sans-first:3611.93 03:48:35 INFO - PROCESS | 18113 | Values: 1339.2 1342.8 1488.7 1792.7 1806.4 8631.6 9228.9 9298.5 9879.9 9946.1 9353.7 9628.3 9765.2 9779.0 9803.1 2490.6 2534.7 2539.3 2540.6 2544.9 2498.1 2579.7 2591.8 2592.2 2597.5 2505.6 2510.0 2561.4 2562.1 2562.4 2518.7 2526.9 2535.3 2536.9 2538.7 2490.5 2498.3 2499.1 2499.7 2523.1 9764.4 9809.7 9815.0 9842.0 9862.4 5645.7 5762.1 5782.8 5815.2 5820.9 3568.5 3646.2 3656.0 3699.8 3715.8 1182.9 1202.0 1210.7 1301.3 1338.7 12809.8 13004.3 13206.1 13682.4 13741.9 4884.6 4907.2 4929.7 5018.0 5068.5 10694.1 10769.6 10771.0 10818.1 10821.7 5717.7 5742.9 5772.0 5780.2 5780.6 4788.5 5218.9 5326.1 5365.4 5369.1 4166.3 4191.9 4218.2 4254.1 4290.9 1258.9 1269.0 1273.8 1278.5 1283.5 954.3 1041.2 1063.5 1069.1 1078.3 6408.2 6658.2 6675.9 6701.3 6889.2 492.0 500.8 1052.9 1156.2 1167.0 4498.7 4598.6 4650.3 4790.7 4876.2 11950.1 12271.4 12423.9 12424.3 12448.4 11396.9 11869.1 11950.8 12362.4 12398.5 8493.2 8659.9 8682.6 8728.4 8752.3 6567.1 6700.7 6769.6 6771.6 6788.6 10421.3 10899.6 11242.0 11250.8 11302.7 10954.5 11278.9 11279.3 11304.5 11373.0 7864.3 8360.3 8624.9 8634.3 8850.4 9540.8 9569.8 9585.1 9623.5 9633.6 8257.8 8332.7 8367.2 8443.8 8596.6 8049.1 8137.3 8192.8 8204.9 8316.6 7673.1 7844.3 7859.6 7977.2 8033.1 5593.4 5639.5 5779.7 5796.9 5825.3 5751.6 5756.3 5930.6 6020.2 6093.5 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | [#4] prototype.html Cycles:180 Average:4966.89 Median:5589.12 stddev:1452.45 (26.0%) stddev-sans-first:1414.52 03:48:35 INFO - PROCESS | 18113 | Values: 346.7 351.0 352.5 353.1 358.7 5787.0 5838.9 5866.0 5896.0 5926.4 5763.5 5783.9 5786.3 5816.4 5852.2 4387.9 4439.8 4478.6 4483.8 4499.9 4474.0 4477.0 4501.2 4512.5 4515.5 4449.8 4458.4 4487.9 4489.5 4516.7 4318.3 4425.5 4428.6 4440.2 4453.9 3925.8 3933.6 3935.1 3945.8 3949.7 5639.9 5662.5 5690.8 5694.9 5700.2 5043.7 5089.7 5124.2 5141.4 5189.1 6025.5 6026.8 6040.5 6046.5 6117.1 4336.4 4348.2 4357.7 4359.0 4364.8 6033.6 6103.9 6308.9 6353.2 6365.9 4410.9 4449.8 4458.7 4474.2 4479.7 4508.9 4514.7 4520.6 4522.6 4523.2 4946.4 5144.8 5171.2 5192.7 5193.9 6061.9 6069.1 6129.3 6150.3 6212.5 1536.5 1553.4 1554.5 1556.7 1566.2 926.3 972.4 984.7 990.9 991.9 5227.5 5270.3 5321.8 5353.9 5356.9 5589.5 5597.3 5636.2 5652.0 5652.2 5059.9 5249.5 5266.0 5347.2 5423.6 2950.5 2961.1 2963.4 2976.0 2992.4 5499.6 5703.9 5723.7 5740.9 5773.7 5572.2 5588.8 5591.7 5610.5 5661.9 5715.7 5751.3 5770.3 5812.6 5845.4 5463.0 5524.0 5530.7 5654.0 5694.9 5364.9 5484.5 5503.9 5508.7 5532.8 6212.8 6380.5 6479.4 6591.9 6593.7 4356.7 4359.2 4374.5 4380.9 4381.9 6156.4 6267.2 6290.5 6294.5 6338.1 6099.3 6115.8 6146.8 6152.6 6160.4 5841.7 6127.2 6140.8 6168.6 6198.8 5987.5 6043.5 6053.9 6077.1 6084.8 6136.5 6163.8 6168.8 6179.3 6218.4 5840.6 6003.9 6008.2 6018.8 6033.8 03:48:35 INFO - PROCESS | 18113 | 03:48:35 INFO - PROCESS | 18113 | [#5] yui.html Cycles:180 Average:23395.76 Median:3900.60 stddev:34953.79 (896.1%) stddev-sans-first:35010.88 03:48:35 INFO - PROCESS | 18113 | Values: 857.9 868.6 898.4 908.6 924.2 16583.0 17371.6 17486.9 17522.8 17627.6 15714.5 16021.4 16055.6 16091.9 16224.8 884.1 899.4 901.9 902.6 904.2 585.7 602.4 607.9 742.4 891.6 928.2 932.2 933.6 934.8 935.8 921.7 928.8 928.9 931.4 933.2 680.9 682.5 683.6 685.2 687.7 15810.6 15816.9 15860.4 15891.4 15922.9 14975.5 16338.2 16577.9 17128.6 17274.7 12782.5 12804.4 12889.6 12922.5 12934.9 4082.1 4127.9 4165.4 4167.6 4238.9 87215.1 87246.6 87356.0 87365.0 88534.6 12187.3 12206.5 12221.9 12271.8 12500.1 23944.8 23947.8 24004.6 24089.3 24743.1 8321.4 8389.9 8404.2 9176.9 9352.3 5138.1 5141.1 5175.6 5191.3 5335.2 3720.8 3891.1 3894.7 3906.5 3909.1 665.7 672.8 674.4 685.2 714.9 708.4 721.4 726.5 736.8 755.1 9724.0 10525.8 10731.9 10813.0 10998.3 753.9 769.8 781.1 781.4 784.9 5151.9 5153.1 5174.2 5196.8 5228.1 130828.0 133295.0 134336.0 137098.3 137479.3 76366.6 115191.4 116282.0 117270.4 121062.0 103284.5 103799.0 104026.0 105772.5 105995.5 9706.9 9828.4 9869.3 9949.9 9978.0 59585.0 60105.7 60294.4 60358.4 61451.7 83128.2 84875.0 86453.6 86602.6 87091.1 12318.6 12353.6 12363.4 12683.4 12869.2 13327.1 13330.2 13518.2 13685.0 14227.6 12821.0 13174.3 13253.9 13564.6 13965.9 12722.4 13016.2 13416.2 13680.1 13761.9 12863.4 13080.0 13354.2 13561.3 14138.1 11213.4 11323.9 11504.8 11913.5 11944.8 11651.8 12265.0 13012.0 13396.7 13663.4 03:48:35 INFO - PROCESS | 18113 | -------- Summary: end -------- 03:48:35 INFO - PROCESS | 18113 | 03:48:36 INFO - TEST-INFO | 18113: exit 0 03:48:36 INFO - TEST-OK | dromaeo_css | took 1111014ms 03:48:36 INFO - TEST-START | kraken 03:48:36 INFO - operating with platform_type : linux_ 03:48:36 INFO - Initialising browser for kraken test... 03:48:36 INFO - TEST-INFO | started process 18379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaeTU69/profile http://localhost:57226/getInfo.html) 03:48:40 INFO - PROCESS | 18379 | __metrics Screen width/height:1600/1200 03:48:40 INFO - PROCESS | 18379 | colorDepth:24 03:48:40 INFO - PROCESS | 18379 | Browser inner width/height: 1024/697 03:48:40 INFO - PROCESS | 18379 | __metrics 03:48:41 ERROR - PROCESS | 18379 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:48:41 INFO - TEST-INFO | 18379: exit 0 03:48:41 INFO - Browser initialized. 03:48:41 INFO - Running cycle 1/1 for kraken test... 03:48:41 INFO - TEST-INFO | started process 18503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaeTU69/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:53 INFO - PROCESS | 18503 | RSS: Main: 152780800 03:48:53 INFO - PROCESS | 18503 | 03:48:56 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57226/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:57 INFO - PROCESS | 18503 | RSS: Main: 158056448 03:48:57 INFO - PROCESS | 18503 | 03:48:59 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57226/tests/kraken/driver.html?testName=audio-dft) 03:49:00 INFO - PROCESS | 18503 | RSS: Main: 156311552 03:49:00 INFO - PROCESS | 18503 | 03:49:03 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57226/tests/kraken/driver.html?testName=audio-fft) 03:49:03 INFO - PROCESS | 18503 | RSS: Main: 156921856 03:49:03 INFO - PROCESS | 18503 | 03:49:05 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57226/tests/kraken/driver.html?testName=audio-oscillator) 03:49:06 INFO - PROCESS | 18503 | RSS: Main: 157003776 03:49:06 INFO - PROCESS | 18503 | 03:49:08 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57226/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:09 INFO - PROCESS | 18503 | RSS: Main: 157032448 03:49:09 INFO - PROCESS | 18503 | 03:49:12 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57226/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:12 INFO - PROCESS | 18503 | RSS: Main: 156033024 03:49:12 INFO - PROCESS | 18503 | 03:49:16 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57226/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:17 INFO - PROCESS | 18503 | RSS: Main: 155615232 03:49:17 INFO - PROCESS | 18503 | 03:49:19 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57226/tests/kraken/driver.html?testName=json-parse-financial) 03:49:20 INFO - PROCESS | 18503 | RSS: Main: 156790784 03:49:20 INFO - PROCESS | 18503 | 03:49:22 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57226/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:22 INFO - PROCESS | 18503 | RSS: Main: 156966912 03:49:22 INFO - PROCESS | 18503 | 03:49:24 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:25 INFO - PROCESS | 18503 | RSS: Main: 157028352 03:49:25 INFO - PROCESS | 18503 | 03:49:26 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:27 INFO - PROCESS | 18503 | RSS: Main: 156741632 03:49:27 INFO - PROCESS | 18503 | 03:49:30 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:30 INFO - PROCESS | 18503 | RSS: Main: 157331456 03:49:30 INFO - PROCESS | 18503 | 03:49:33 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:34 INFO - PROCESS | 18503 | RSS: Main: 157761536 03:49:34 INFO - PROCESS | 18503 | 03:49:35 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:57226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57226/tests/kraken/driver.html?testName=ai-astar) 03:49:36 INFO - PROCESS | 18503 | RSS: Main: 158494720 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | __start_tp_report 03:49:36 INFO - PROCESS | 18503 | _x_x_mozilla_page_load 03:49:36 INFO - PROCESS | 18503 | _x_x_mozilla_page_load_details 03:49:36 INFO - PROCESS | 18503 | |i|pagename|runs| 03:49:36 INFO - PROCESS | 18503 | |0;ai-astar;99;110;104;115;111;111;110;110;109;109 03:49:36 INFO - PROCESS | 18503 | |1;audio-beat-detection;141;118;143;167;120;147;141;118;171;122 03:49:36 INFO - PROCESS | 18503 | |2;audio-dft;163;164;163;161;164;161;162;164;163;162 03:49:36 INFO - PROCESS | 18503 | |3;audio-fft;75;76;75;180;77;75;75;76;159;76 03:49:36 INFO - PROCESS | 18503 | |4;audio-oscillator;84;82;146;84;84;82;145;84;82;143 03:49:36 INFO - PROCESS | 18503 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;117;118;117 03:49:36 INFO - PROCESS | 18503 | |6;imaging-darkroom;147;149;147;147;147;149;147;148;146;148 03:49:36 INFO - PROCESS | 18503 | |7;imaging-desaturate;95;96;96;96;95;96;95;96;95;96 03:49:36 INFO - PROCESS | 18503 | |8;json-parse-financial;54;53;54;50;51;50;51;51;50;52 03:49:36 INFO - PROCESS | 18503 | |9;json-stringify-tinderbox;62;59;58;59;59;58;57;59;59;59 03:49:36 INFO - PROCESS | 18503 | |10;stanford-crypto-aes;74;72;73;72;74;73;74;76;73;73 03:49:36 INFO - PROCESS | 18503 | |11;stanford-crypto-ccm;119;131;134;120;130;128;126;120;159;124 03:49:36 INFO - PROCESS | 18503 | |12;stanford-crypto-pbkdf2;157;153;157;154;155;158;150;151;154;150 03:49:36 INFO - PROCESS | 18503 | |13;stanford-crypto-sha256-iterative;68;67;61;62;65;66;62;61;61;61 03:49:36 INFO - PROCESS | 18503 | __end_tp_report 03:49:36 INFO - PROCESS | 18503 | __start_cc_report 03:49:36 INFO - PROCESS | 18503 | _x_x_mozilla_cycle_collect,856 03:49:36 INFO - PROCESS | 18503 | __end_cc_report 03:49:36 INFO - PROCESS | 18503 | __startTimestamp1472899776034__endTimestamp 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | ------- Summary: start ------- 03:49:36 INFO - PROCESS | 18503 | Number of tests: 14 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:4.37 (4.0%) stddev-sans-first:2.85 03:49:36 INFO - PROCESS | 18503 | Values: 99.0 110.0 104.0 115.0 111.0 111.0 110.0 110.0 109.0 109.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:142.00 stddev:19.52 (13.7%) stddev-sans-first:20.68 03:49:36 INFO - PROCESS | 18503 | Values: 141.0 118.0 143.0 167.0 120.0 147.0 141.0 118.0 171.0 122.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 03:49:36 INFO - PROCESS | 18503 | Values: 163.0 164.0 163.0 161.0 164.0 161.0 162.0 164.0 163.0 162.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.89 (52.8%) stddev-sans-first:41.69 03:49:36 INFO - PROCESS | 18503 | Values: 75.0 76.0 75.0 180.0 77.0 75.0 75.0 76.0 159.0 76.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:83.00 stddev:29.74 (35.8%) stddev-sans-first:30.85 03:49:36 INFO - PROCESS | 18503 | Values: 84.0 82.0 146.0 84.0 84.0 82.0 145.0 84.0 82.0 143.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:49:36 INFO - PROCESS | 18503 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:49:36 INFO - PROCESS | 18503 | Values: 147.0 149.0 147.0 147.0 147.0 149.0 147.0 148.0 146.0 148.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:49:36 INFO - PROCESS | 18503 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.58 (3.1%) stddev-sans-first:1.41 03:49:36 INFO - PROCESS | 18503 | Values: 54.0 53.0 54.0 50.0 51.0 50.0 51.0 51.0 50.0 52.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:1.29 (2.2%) stddev-sans-first:0.73 03:49:36 INFO - PROCESS | 18503 | Values: 62.0 59.0 58.0 59.0 59.0 58.0 57.0 59.0 59.0 59.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.50 stddev:1.17 (1.6%) stddev-sans-first:1.22 03:49:36 INFO - PROCESS | 18503 | Values: 74.0 72.0 73.0 72.0 74.0 73.0 74.0 76.0 73.0 73.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:129.00 stddev:11.68 (9.1%) stddev-sans-first:11.80 03:49:36 INFO - PROCESS | 18503 | Values: 119.0 131.0 134.0 120.0 130.0 128.0 126.0 120.0 159.0 124.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.50 stddev:2.92 (1.9%) stddev-sans-first:2.88 03:49:36 INFO - PROCESS | 18503 | Values: 157.0 153.0 157.0 154.0 155.0 158.0 150.0 151.0 154.0 150.0 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - PROCESS | 18503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.80 (4.4%) stddev-sans-first:2.42 03:49:36 INFO - PROCESS | 18503 | Values: 68.0 67.0 61.0 62.0 65.0 66.0 62.0 61.0 61.0 61.0 03:49:36 INFO - PROCESS | 18503 | -------- Summary: end -------- 03:49:36 INFO - PROCESS | 18503 | 03:49:36 INFO - TEST-INFO | 18503: exit 0 03:49:36 INFO - TEST-OK | kraken | took 60488ms 03:49:36 INFO - SUITE-END | took 1171s 03:49:37 INFO - Completed test suite (00:19:31) 03:49:37 INFO - javascript benchmark 03:49:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7715.719564582482, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.0891350421884, 3255.706986371227, 3256.918577035574, 3268.9673103268974, 3292.094673964661, 5726.856828579288, 5773.191753154557, 5787.363390027093, 5809.912851307228, 5813.5349172066235, 5811.564132690044, 5818.621789583674, 5830.008898487256, 5847.532197424206, 5853.180554722342, 5259.789608415668, 5274.997750427407, 5304.496072873071, 5315.309009828717, 5328.8401347959625, 5149.0, 5155.0, 5194.065068287707, 5235.921461178085, 5262.4474430184855, 5214.817481388133, 5252.474752524736, 5263.315768950031, 5295.285136506561, 5356.892862142755, 5294.894102117974, 5310.0, 5313.601479889024, 5313.920291195615, 5314.654547454442, 4958.9752051239875, 5126.512981266774, 5172.793088276464, 5203.557697595671, 5245.082110630662, 5697.6296540724725, 5792.507636850873, 5795.420457954213, 5798.362180160179, 5831.037878750044, 6232.594881332744, 6240.656763878031, 6243.812685619393, 6277.340879207663, 6294.968525157345, 5888.38171991939, 6091.482224010964, 6283.277423096357, 6286.528510361695, 6316.399942005502, 5721.284839395075, 5863.2670916135485, 5871.383504732027, 5897.262842144732, 5900.498457631106, 6342.5560210785725, 6367.267764207083, 6392.936070639327, 6395.232572091379, 6396.136521569621, 5960.970195149083, 5975.52195824333, 5995.820125396245, 6044.274687037584, 6054.606450580698, 6111.633302001894, 6196.225471816023, 6209.9068513972325, 6211.09939058834, 6225.564210505312, 6118.3269840317525, 6179.412955769285, 6181.412765787243, 6183.938160618426, 6185.134081228632, 5916.3787802281, 6076.787312444043, 6145.631262124287, 6148.815535533941, 6163.537734669918, 4666.696664716783, 4735.715857048588, 4736.0, 4756.21522448799, 4765.642576806753, 4188.701292864529, 4210.810513526899, 4220.345846393814, 4238.766867822299, 4244.0663054128045, 5609.046462101453, 5827.155062515996, 5971.253593300838, 5988.880222395528, 5990.880182396415, 6047.969760151259, 6145.293291271471, 6194.411530904647, 6204.410580994799, 6207.937920620736, 5920.911186332209, 5930.406959304121, 5934.851628709317, 5935.495482884004, 5956.791512297049, 5124.103281925648, 5236.266922630834, 5297.231901374356, 5305.761240744098, 5306.893862122736, 6286.654234017082, 6393.744250230032, 6413.935860641333, 6431.485481161496, 6442.838929026718, 6167.475764560063, 6189.226346706661, 6204.0, 6204.038374052029, 6214.9067763982675, 6135.875804921915, 6244.0, 6358.841028974312, 6420.390062944013, 6426.807195784134, 5986.910196346971, 6046.606970546901, 6068.362821903636, 6071.089336599545, 6108.175396321618, 6158.753649853956, 6158.938410615837, 6177.135201071944, 6179.752809887555, 6196.721147548461, 5822.854428639318, 5987.221661184019, 5997.490213331916, 6033.577649564489, 6042.1843051187525, 6055.848603784941, 6066.090086486885, 6072.240969878765, 6090.634561926298, 6108.08378743192, 5929.792457263975, 5966.612170208922, 5976.432238937294, 5992.460678538952, 5995.070764031408, 5836.0, 5972.5520585955355, 5992.910106348321, 6047.244094488189, 6091.817245482643, 5851.239338886088, 5917.704114794157, 5953.047512397996, 5957.076653118774, 5987.072003839412], "value": 5689.674736229519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3014675278253, 588.3087372337503, 614.6066517428847, 665.4875745675832, 685.263341907449, 36194.0, 40179.59820401795, 40372.79813600932, 40390.79804600973, 40406.79796601013, 39748.602513974925, 39872.80063599678, 39893.800530997374, 40135.79932100335, 40242.59757402425, 9000.909990900089, 9206.723798286028, 9208.401453905508, 9210.861837072449, 9220.077992200793, 9060.954695226548, 9135.17783399494, 9153.130452606993, 9177.311701622371, 9189.632414703405, 8986.550672466383, 9015.413998090104, 9016.819663606724, 9032.32257580684, 9035.096490350978, 9194.862077068816, 9221.077892210793, 9231.123043310909, 9256.166944974917, 9294.256459483226, 9193.908060919372, 9198.724038278862, 9227.907720922773, 9237.0, 9262.444253344753, 44454.0, 44651.0, 44652.55347446517, 44669.77665111654, 44914.0, 3747.3254814133447, 3776.8736211473147, 3789.7915614641183, 3841.3661745811905, 3865.381538953754, 35100.64899351025, 35511.28977420437, 35609.0, 35728.46407303892, 35810.64189358099, 4386.144701783153, 4458.974435879766, 4493.370928070073, 4506.301523263866, 4543.227651299287, 376428.0, 378445.0, 379709.0, 380491.0, 380536.0, 63909.68045159744, 64037.35962640407, 64541.67729161324, 64615.353846461876, 64702.0, 34425.483617745755, 35174.824125879204, 35514.46728299077, 36289.45565816515, 36428.45357319642, 16466.588335291715, 16718.41485548, 16740.49778506647, 16846.747298790528, 16852.0, 12368.505259789508, 12445.62663120108, 12446.31545265001, 12536.686582835502, 12566.81149782754, 21168.25911093135, 21196.576068478545, 21239.362819115453, 21246.150153993975, 21386.572268554854, 7555.6977720890545, 7647.197044310378, 7753.302202801775, 7758.495697779626, 7786.610669466504, 1063.2982231727024, 1083.6207327435493, 1119.0208567503435, 1147.2485521983115, 1188.762247550476, 34449.31101378008, 34593.308133837185, 34799.0, 34897.12757181091, 35005.299894001975, 1005.582683186484, 1015.3400289811682, 1189.7739429508365, 1198.7353342224037, 1226.969325766863, 17174.570635733955, 17334.0, 17351.13244337778, 17490.65018699619, 17492.5626859327, 658689.0, 659276.0, 661062.0, 661179.0, 664601.0, 67811.0, 68188.3181168192, 68898.65550672315, 68959.0, 68992.31007689859, 1422.0133239063657, 1452.4408102880468, 1474.7336874276532, 1476.4463326252655, 1486.2865824404346, 32806.83596582002, 32883.34233315368, 33095.834520827244, 33445.66554334426, 33879.49180762241, 57107.14339284831, 57452.13821792593, 57801.0, 58075.419245807, 58096.0, 430160.0, 430542.0, 431581.0, 432248.0, 432448.0, 30713.232169195948, 31054.84472577713, 31508.527372089895, 31614.841925790224, 31799.205019874687, 50584.24123638222, 50801.0, 51045.74477127591, 51183.0, 51838.740806295726, 43068.35397468978, 43454.78272608617, 45108.0, 45648.0, 46271.537284628066, 42780.0, 43317.0, 44079.0, 44610.55389446064, 45200.547994519635, 36383.636163638024, 37803.810980944916, 41899.58100418957, 42402.0, 43067.56932430636, 37527.0, 37595.0, 38532.0, 38568.80715596404, 39295.41056884092, 29672.258193545335, 29763.404731904808, 30173.69826301709, 32390.0, 32585.348293033534], "value": 20872.64062624084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2351414741255, 400.93785463253187, 407.9306517891958, 411.8846722917584, 423.78175239751516, 15387.923060384683, 19148.90425547872, 20881.0, 20936.581268374623, 21396.8930155349, 20031.59936801263, 20082.49793755157, 21088.68366974493, 21202.469938251514, 21237.15051397942, 5848.327442344143, 5980.372060933604, 5987.191729116557, 5995.340512543617, 6018.368071352511, 5502.5597952163735, 5911.704414779266, 5935.73289201987, 6044.365341639131, 6077.24034495688, 5680.573956953224, 5750.856228594277, 5755.338136114337, 5773.624714393572, 5776.942230577703, 5811.941880581204, 6393.648349340784, 6440.194975628046, 6441.066045423434, 6457.192850893614, 5069.695818250917, 5294.867628309285, 5347.4919882611475, 5879.52963762898, 6007.128966299906, 14029.368678409495, 14213.715725685532, 14282.928585357007, 25019.0, 25046.0, 2494.48862983088, 2582.7029891562524, 2723.9591406128925, 2890.8554572271514, 3064.2033071401597, 10279.0, 10727.302725322907, 10769.676909692644, 10848.783024339547, 14612.991420759969, 1933.236371633211, 1945.231633504772, 1977.6637971544872, 1978.881267123977, 1991.3229501969256, 76933.0, 90568.54715726379, 90687.54656226677, 91349.54325228398, 91659.0, 10807.621733239455, 11072.114230861513, 11103.333799972028, 11208.775824483628, 11214.831777523344, 15278.0, 15315.387384504718, 15328.923355383375, 15345.846541534665, 15358.692826143415, 8153.510789352539, 8234.135415781377, 8316.501009939422, 8389.161083891562, 8437.282830959315, 7804.921950780533, 7856.803579910434, 7886.692379489688, 8045.597720113971, 8082.393820463371, 4497.8425755098415, 4638.582527572535, 4656.767161641905, 4703.717776933395, 4709.434867815884, 1929.5851391950798, 1993.1230258686132, 2027.6552985992416, 2053.671412573981, 2086.5201003769216, 1000.7548150702979, 1018.4469674453725, 1103.7516558774373, 1111.5664890692635, 1139.7492551638627, 20633.277835275694, 21298.0, 21367.431785627094, 21414.357569272634, 21504.78495215028, 1066.6000249906285, 1072.4744875011345, 1084.6854412220368, 1094.4637127807475, 1119.261287550213, 10246.846297305547, 11864.0, 11882.524699012116, 11946.163768536118, 12024.579139730067, 535104.0, 540876.0, 552146.0, 553260.0, 553791.0, 97973.5101324503, 100202.4989875046, 102411.4879425598, 102970.48514757378, 103668.0, 1004.3170643962176, 1034.715453250347, 1056.0, 1105.9447027648746, 1117.6591139702468, 15707.842921570638, 18023.549411264823, 18665.346712864986, 18748.531286717942, 18832.62334753325, 33014.66985330116, 37736.433953490174, 44142.77928610337, 44392.0, 44525.0, 61222.69388653028, 62433.375666244574, 64883.35116648962, 66429.66785166043, 66465.33534664591, 8908.242799362128, 8933.19601235892, 8989.685361012333, 8989.730308090768, 9143.588538515916, 10199.796004080024, 14441.0, 14578.416863325348, 14736.705265894836, 14941.626459338604, 12553.748925021631, 12595.874041259836, 12926.870731292944, 12934.159279646792, 12979.41592628315, 12343.07426942965, 12608.432620531914, 12609.747805044031, 12643.120948758871, 12763.234205947672, 12383.69040773988, 12553.0, 12757.53288371812, 12799.232046077264, 12972.740545189232, 7621.733239336819, 8127.2279133482225, 8338.24955753985, 8906.465612063297, 9090.772730681785, 8803.515806630441, 12513.687157821127, 12725.490980361052, 13021.544245951347, 13137.474501019853], "value": 9627.561294800375, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.2366351179828, 1342.7985802129683, 1488.7469130247857, 1792.7131658934572, 1806.4129158023638, 8631.611577479012, 9228.86156707649, 9298.535073246345, 9879.851802222964, 9946.055124763145, 9353.67262145825, 9628.277879159055, 9765.2187824974, 9779.0, 9803.117719405253, 2490.576601977664, 2534.708508521516, 2539.3270783242456, 2540.5681034224226, 2544.8727563621837, 2498.0757119865675, 2579.66464359633, 2591.8056145789046, 2592.222333300012, 2597.5324441600505, 2505.649209110726, 2510.046182450666, 2561.398071453207, 2562.052040744927, 2562.4362640219124, 2518.7481251874756, 2526.936826579341, 2535.2647732157743, 2536.88584013718, 2538.669972903529, 2490.464550121714, 2498.3254521279337, 2499.1128149506844, 2499.6750422444966, 2523.104297974229, 9764.365316254492, 9809.656662016867, 9814.950925245399, 9841.950790246074, 9862.408255504693, 5645.661260324394, 5762.135679648044, 5782.768689252425, 5815.185873977646, 5820.941790582082, 3568.4825700273573, 3646.1613828819254, 3655.981720091409, 3699.8335074921692, 3715.8142092895246, 1182.8757980412106, 1202.0, 1210.7154818617619, 1301.3233118778278, 1338.6586420462818, 12809.807852882213, 13004.284764337957, 13206.141600796014, 13682.384292706853, 13741.931290343584, 4884.584810291165, 4907.190313598217, 4929.728864912464, 5018.0, 5068.493150684976, 10694.144468442506, 10769.62306319275, 10771.0, 10818.134549236041, 10821.729456763487, 5717.656940583578, 5742.885142297214, 5771.971140144273, 5780.16187652788, 5780.566457515703, 4788.521147885253, 5218.8956220876125, 5326.094563924142, 5365.382980957162, 5369.087255166631, 4166.33338665812, 4191.937120943188, 4218.198542276958, 4254.085371645111, 4290.914181716348, 1258.930758808256, 1269.041873385588, 1273.7579859826603, 1278.5397256987662, 1283.525095714573, 954.346272803132, 1041.182671602788, 1063.5107850388908, 1069.1286601419818, 1078.2506158219962, 6408.17505453025, 6658.234303055114, 6675.86648267032, 6701.29636388182, 6889.173299204027, 492.0356102040042, 500.82306579537794, 1052.9262951593314, 1156.1964434717959, 1167.0197034491068, 4498.6626003049905, 4598.632109431237, 4650.348951146842, 4790.736509491941, 4876.244182151772, 11950.103742219195, 12271.386430678609, 12423.875761242452, 12424.316662583644, 12448.439820208112, 11396.943015285036, 11869.050475961902, 11950.820737688942, 12362.38188090592, 12398.504059837685, 8493.150684931581, 8659.870101948476, 8682.565871706389, 8728.432651877607, 8752.299816014704, 6567.113439685581, 6700.66496675174, 6769.559978601375, 6771.559848609824, 6788.558743681645, 10421.322614030063, 10899.618513352312, 11242.0, 11250.7749845001, 11302.717432064264, 10954.507047182737, 11278.887211128113, 11279.266847654877, 11304.547818087512, 11373.033292170257, 7864.252895974873, 8360.331173506227, 8624.913750862663, 8634.309255259439, 8850.38047336706, 9540.809183816424, 9569.808603828023, 9585.137337639646, 9623.518824058629, 9633.566489507848, 8257.83484330322, 8332.666693332441, 8367.205115514016, 8443.831123377375, 8596.613152408281, 8049.074356448849, 8137.267645911897, 8192.83614327722, 8204.876926846222, 8316.584170791557, 7673.079230492377, 7844.333231675371, 7859.60701964888, 7977.162397948364, 8033.11635720082, 5593.416228279969, 5639.520640745583, 5779.7110144493445, 5796.884062318814, 5825.271841019872, 5751.626144300607, 5756.280464941882, 5930.614510056833, 6020.247469066367, 6093.482054025458], "value": 5042.488316489894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.7382126494497, 351.04865813645023, 352.4660139888068, 353.11896817440476, 358.7273672009275, 5786.971065144674, 5838.883222335551, 5866.0, 5896.0, 5926.377730338317, 5763.481286684198, 5783.855403614902, 5786.264120763775, 5816.371416003515, 5852.151438041481, 4387.890302742441, 4439.778011099448, 4478.619317358029, 4483.820647174109, 4499.865004049884, 4474.0, 4476.985356589532, 4501.212287849629, 4512.503624601291, 4515.480719717241, 4449.777511124447, 4458.3535387368975, 4487.887802804923, 4489.483709373415, 4516.728996260234, 4318.309070548713, 4425.513193548707, 4428.601425871655, 4440.24515832306, 4453.910921781546, 3925.8233379497706, 3933.606639336072, 3935.134270460494, 3945.842166313344, 3949.723519353646, 5639.887202255932, 5662.546996240291, 5690.829275121753, 5694.914576281318, 5700.201971723962, 5043.747812609392, 5089.694618322913, 5124.1801311790305, 5141.38303403594, 5189.091908915962, 6025.517958563304, 6026.8493287667725, 6040.456358927718, 6046.486048685867, 6117.113018612321, 4336.436263285784, 4348.21732088224, 4357.7385356878685, 4358.975640724428, 4364.759938203398, 6033.577649564532, 6103.87792244157, 6308.905366419507, 6353.174087368612, 6365.904511432333, 4410.911781764346, 4449.755263460541, 4458.665600080007, 4474.172278128557, 4479.731216126977, 4508.887277818015, 4514.6614003949835, 4520.61574766142, 4522.570355816192, 4523.163214805271, 4946.431160416526, 5144.790974121079, 5171.224316352502, 5192.7403629818355, 5193.870153246199, 6061.909071363933, 6069.119977603311, 6129.272473749228, 6150.261968563712, 6212.502999760009, 1536.4929573240804, 1553.3631211203578, 1554.5414102839688, 1556.6808804195339, 1566.2403734188908, 926.2775035472342, 972.397113789455, 984.6996666016934, 990.9058639429243, 991.940483570988, 5227.504346262212, 5270.262163297141, 5321.840344789663, 5353.866153346197, 5356.91964620531, 5589.469000445032, 5597.328320601554, 5636.239107720406, 5652.0, 5652.18043383707, 5059.898802024012, 5249.527542521115, 5266.0257852297445, 5347.224652425377, 5423.566114710814, 2950.5131653276967, 2961.067263811892, 2963.3776906849803, 2975.9851200743856, 2992.38656075504, 5499.560035197254, 5703.857403564944, 5723.6851973141875, 5740.937926483614, 5773.740181691834, 5572.247746554244, 5588.776448941997, 5591.664500130005, 5610.4670056344585, 5661.943380566142, 5715.656580801851, 5751.338596061423, 5770.336411312753, 5812.6221795584, 5845.398797535141, 5462.9726851365485, 5524.033294173423, 5530.668159910419, 5654.0210926175505, 5694.914576281442, 5364.90019546, 5484.533814625802, 5503.917441238465, 5508.697021663686, 5532.834014979557, 6212.844678883064, 6380.491898263837, 6479.416852483299, 6591.87938050523, 6593.736250549924, 4356.673249506236, 4359.215341238608, 4374.534530932174, 4380.890477738082, 4381.868543943687, 6156.384361563808, 6267.2479302484, 6290.49676025926, 6294.527910406646, 6338.0809782580345, 6099.268087829489, 6115.84710382244, 6146.832101900624, 6152.569320147726, 6160.383961603804, 5841.678707671119, 6127.234095738033, 6140.785072522441, 6168.568200225941, 6198.783042593487, 5987.520998320211, 6043.516518678407, 6053.878922421439, 6077.05805600115, 6084.817455476343, 6136.539759518143, 6163.753449862134, 6168.845778855564, 6179.320274769681, 6218.378162183745, 5840.561957853263, 6003.898635477548, 6008.24896887889, 6018.849528761816, 6033.849153771191], "value": 4501.5447841863515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.9270761985235, 868.6308318964439, 898.4474548152884, 908.6138391183745, 924.2144177449173, 16583.0, 17371.565710857234, 17486.912565437156, 17522.82477175228, 17627.559311017216, 15714.528564143066, 16021.439249626266, 16055.598610034755, 16091.908171609764, 16224.75662865055, 884.1467983396005, 899.3974037394928, 901.9278457723399, 902.5577467041136, 904.2043002158092, 585.7071464267866, 602.442740465068, 607.9392060793907, 742.4172024960408, 891.5809569502356, 928.1739252065667, 932.1936524905941, 933.6218831373304, 934.7896723237285, 935.7941252924346, 921.7326975177191, 928.7585227840742, 928.9303302252358, 931.4225180388203, 933.2394098809483, 680.9216940051908, 682.5290549520814, 683.596677960006, 685.1948959972013, 687.7489716253582, 15810.604734881605, 15816.920915395465, 15860.36558537657, 15891.36434542617, 15922.920385398114, 14975.475858344906, 16338.183090845529, 16577.91711041449, 17128.57178570533, 17274.654506909916, 12782.488700452064, 12804.423800928887, 12889.613311600668, 12922.547710830077, 12934.935325323408, 4082.12234369609, 4127.9174416511805, 4165.354370072643, 4167.562405947392, 4238.91522169558, 87215.12784872134, 87246.56376718139, 87356.0, 87365.0, 88534.5573272136, 12187.329696866758, 12206.511739530497, 12221.938890305491, 12271.815922761165, 12500.124991250525, 23944.7605523946, 23947.760522394903, 24004.63993040106, 24089.277321680376, 24743.133990310253, 8321.375896807764, 8389.874151887727, 8404.243618074403, 9176.908230917605, 9352.345335826427, 5138.075146473596, 5141.074606570854, 5175.585953123741, 5191.299174611455, 5335.1730481775385, 3720.813959302024, 3891.105045839473, 3894.7078969077434, 3906.4921560197563, 3909.100906791454, 665.723724654263, 672.8082496488478, 674.3795707948699, 685.2325395557008, 714.8927660850914, 708.3589351636776, 721.3543878228955, 726.4841962206892, 736.8268456912622, 755.1165136789969, 9724.0, 10525.789484210272, 10731.946340268405, 10813.0, 10998.34009959405, 753.8718417868976, 769.7870949205865, 781.1017330070464, 781.386611509962, 784.9097353804385, 5151.891102773753, 5153.1497302945345, 5174.172132458789, 5196.792128314901, 5228.111221092423, 130828.0, 133295.0, 134336.0, 137098.31450842883, 137479.31260343635, 76366.61816690992, 115191.42404287925, 116282.0, 117270.41364793121, 121062.0, 103284.48357758163, 103799.0, 104025.95974040314, 105772.47113764382, 105995.47002264939, 9706.9029309706, 9828.397783471268, 9869.309148359833, 9949.9473652849, 9977.950110249401, 59585.0, 60105.699471504115, 60294.39705602888, 60358.39641603528, 61451.692741536004, 83128.16871831204, 84875.0, 86453.56773216346, 86602.56698716467, 87091.12908871083, 12318.568850090203, 12353.581385640535, 12363.443645035815, 12683.365831708563, 12869.22784632925, 13327.133736307109, 13330.200187988752, 13518.188908665512, 13685.0, 14227.573172804832, 12821.0, 13174.275414852274, 13253.86746132565, 13564.593062208149, 13965.930170349084, 12722.427490763122, 13016.15394999322, 13416.195028298333, 13680.110792798436, 13761.931190343985, 12863.356832158543, 13080.0, 13354.198748075147, 13561.321933903067, 14138.08102473336, 11213.383263920563, 11323.886761132284, 11504.769904602028, 11913.52345906154, 11944.76110477803, 11651.825222621837, 12265.0, 13012.036208096859, 13396.665083372995, 13663.38514766818], "value": 8128.875245154779, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 115.0, 111.0, 111.0, 110.0, 110.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 143.0, 167.0, 120.0, 147.0, 141.0, 118.0, 171.0, 122.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 161.0, 164.0, 161.0, 162.0, 164.0, 163.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 180.0, 77.0, 75.0, 75.0, 76.0, 159.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 146.0, 84.0, 84.0, 82.0, 145.0, 84.0, 82.0, 143.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 50.0, 51.0, 50.0, 51.0, 51.0, 50.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 58.0, 59.0, 59.0, 58.0, 57.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 72.0, 74.0, 73.0, 74.0, 76.0, 73.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 131.0, 134.0, 120.0, 130.0, 128.0, 126.0, 120.0, 159.0, 124.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 157.0, 154.0, 155.0, 158.0, 150.0, 151.0, 154.0, 150.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 61.0, 62.0, 65.0, 66.0, 62.0, 61.0, 61.0, 61.0], "value": 63.4, "unit": "score"}]}]} 03:49:37 INFO - Return code: 0 03:49:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:37 ERROR - # TBPL SUCCESS # 03:49:37 INFO - Running post-action listener: _resource_record_post_action 03:49:37 INFO - [mozharness: 2016-09-03 10:49:37.329087Z] Finished run-tests step (success) 03:49:37 INFO - Running post-run listener: _resource_record_post_run 03:49:37 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 330149888; Read time: 0; Write time: 178828 03:49:37 INFO - TinderboxPrint: CPU usage
13.3% 03:49:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:49:37 INFO - TinderboxPrint: I/O write bytes / time
330,149,888 / 178,828 03:49:37 INFO - TinderboxPrint: CPU idle
8,217.1 (86.7%) 03:49:37 INFO - TinderboxPrint: CPU user
1,205.7 (12.7%) 03:49:37 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77234176; Read time: 0; Write time: 42732 03:49:37 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 250490880; Read time: 0; Write time: 135940 03:49:37 INFO - Running post-run listener: _upload_blobber_files 03:49:37 INFO - Blob upload gear active. 03:49:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:37 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 03:49:37 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'] 03:49:37 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 03:49:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:39 INFO - (blobuploader) - INFO - Done attempting. 03:49:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:42 INFO - (blobuploader) - INFO - Done attempting. 03:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:43 INFO - (blobuploader) - INFO - Done attempting. 03:49:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:43 INFO - Return code: 0 03:49:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06179fd02023d81f32d509675158b28b955ffefc9cee8c4f1f0403868221a7f79f312685a390e716f728e5ac3742252f4e228734276d33507dcc7f7167f4d0b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a85906437b12e3794da23cc1e4b64b24f7686f9f7d91f16c3a7da90141861b0dbf9d35fe409de863d691f67a667de31cf4dfcd04220857a04d3309792c9b8f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69c2d807b0590de592970bd3ec6f5465226599efabefd130dfb5f0b22b7f6d33fe470413ec1b7eee3adb17dd4cbd4e88b69eb140c4713c7c23c554a76fedc90b"} 03:49:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:43 INFO - Contents: 03:49:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06179fd02023d81f32d509675158b28b955ffefc9cee8c4f1f0403868221a7f79f312685a390e716f728e5ac3742252f4e228734276d33507dcc7f7167f4d0b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a85906437b12e3794da23cc1e4b64b24f7686f9f7d91f16c3a7da90141861b0dbf9d35fe409de863d691f67a667de31cf4dfcd04220857a04d3309792c9b8f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69c2d807b0590de592970bd3ec6f5465226599efabefd130dfb5f0b22b7f6d33fe470413ec1b7eee3adb17dd4cbd4e88b69eb140c4713c7c23c554a76fedc90b"} 03:49:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:43 INFO - Copying logs to upload dir... 03:49:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.881649 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-03 03:49:42.347790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 03:49:42.353155) ========= 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=ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06179fd02023d81f32d509675158b28b955ffefc9cee8c4f1f0403868221a7f79f312685a390e716f728e5ac3742252f4e228734276d33507dcc7f7167f4d0b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a85906437b12e3794da23cc1e4b64b24f7686f9f7d91f16c3a7da90141861b0dbf9d35fe409de863d691f67a667de31cf4dfcd04220857a04d3309792c9b8f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69c2d807b0590de592970bd3ec6f5465226599efabefd130dfb5f0b22b7f6d33fe470413ec1b7eee3adb17dd4cbd4e88b69eb140c4713c7c23c554a76fedc90b"} build_url:https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06179fd02023d81f32d509675158b28b955ffefc9cee8c4f1f0403868221a7f79f312685a390e716f728e5ac3742252f4e228734276d33507dcc7f7167f4d0b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a85906437b12e3794da23cc1e4b64b24f7686f9f7d91f16c3a7da90141861b0dbf9d35fe409de863d691f67a667de31cf4dfcd04220857a04d3309792c9b8f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69c2d807b0590de592970bd3ec6f5465226599efabefd130dfb5f0b22b7f6d33fe470413ec1b7eee3adb17dd4cbd4e88b69eb140c4713c7c23c554a76fedc90b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 03:49:42.379397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:49:42.379815) ========= 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=ed14279e38b05397cf4aa391000001a4-1472898104.775651-135275134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:49:42.465167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 03:49:42.465543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 03:49:42.465929) ========= ========= Total master_lag: 0.16 =========