builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1471362769.42 results: success (0) buildid: 20160816071917 builduid: 72e192aeee604bb298eb38708725c94e revision: 8b47af8a1ad296295a0f9bfb61d6280265a5f109 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.416573) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.416977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.417400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.461299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.461654) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 08:52:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2016-08-16 08:52:49 (45.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.224857 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.700305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.700578) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.168958 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.887504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:49.888238) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8b47af8a1ad296295a0f9bfb61d6280265a5f109 --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 8b47af8a1ad296295a0f9bfb61d6280265a5f109 --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=337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 08:52:49,807 truncating revision to first 12 chars 2016-08-16 08:52:49,807 Setting DEBUG logging. 2016-08-16 08:52:49,807 attempt 1/10 2016-08-16 08:52:49,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8b47af8a1ad2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 08:52:50,111 unpacking tar archive at: mozilla-aurora-8b47af8a1ad2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:50.539572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:50.539852) ========= script_repo_revision: 8b47af8a1ad296295a0f9bfb61d6280265a5f109 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:50.540216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:50.540484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 08:52:50.549741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-08-16 08:52:50.550004) ========= /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=337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:52:50 INFO - MultiFileLogger online at 20160816 08:52:50 in /builds/slave/test 08:52:50 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 08:52:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:50 INFO - {'append_to_log': False, 08:52:50 INFO - 'base_work_dir': '/builds/slave/test', 08:52:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:52:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:50 INFO - 'branch': 'Mozilla-Aurora', 08:52:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:50 INFO - 'config_files': ('talos/linux_config.py',), 08:52:50 INFO - 'default_actions': ('clobber', 08:52:50 INFO - 'read-buildbot-config', 08:52:50 INFO - 'download-and-extract', 08:52:50 INFO - 'populate-webroot', 08:52:50 INFO - 'create-virtualenv', 08:52:50 INFO - 'install', 08:52:50 INFO - 'run-tests'), 08:52:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:50 INFO - 'download_minidump_stackwalk': True, 08:52:50 INFO - 'download_symbols': 'ondemand', 08:52:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:50 INFO - 'installer_path': 'installer.exe', 08:52:50 INFO - 'log_level': 'info', 08:52:50 INFO - 'log_name': 'talos', 08:52:50 INFO - 'log_to_console': True, 08:52:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:52:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:52:50 INFO - 'opt_config_files': (), 08:52:50 INFO - 'pip_index': False, 08:52:50 INFO - 'sps_profile': False, 08:52:50 INFO - 'sps_profile_interval': 0, 08:52:50 INFO - 'suite': 'dromaeojs-e10s', 08:52:50 INFO - 'system_bits': '32', 08:52:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:50 INFO - 'title': 'talos-linux64-ix-060', 08:52:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:50 INFO - 'use_talos_json': True, 08:52:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:50 INFO - 'work_dir': 'build'} 08:52:50 INFO - [mozharness: 2016-08-16 15:52:50.655197Z] Running clobber step. 08:52:50 INFO - Running pre-action listener: _resource_record_pre_action 08:52:50 INFO - Running main action method: clobber 08:52:50 INFO - rmtree: /builds/slave/test/build 08:52:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:52 INFO - Running post-action listener: _resource_record_post_action 08:52:52 INFO - [mozharness: 2016-08-16 15:52:52.507103Z] Finished clobber step (success) 08:52:52 INFO - [mozharness: 2016-08-16 15:52:52.507203Z] Running read-buildbot-config step. 08:52:52 INFO - Running pre-action listener: _resource_record_pre_action 08:52:52 INFO - Running main action method: read_buildbot_config 08:52:52 INFO - Using buildbot properties: 08:52:52 INFO - { 08:52:52 INFO - "project": "", 08:52:52 INFO - "product": "firefox", 08:52:52 INFO - "script_repo_revision": "production", 08:52:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:52:52 INFO - "repository": "", 08:52:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:52:52 INFO - "buildid": "20160816071917", 08:52:52 INFO - "pgo_build": "True", 08:52:52 INFO - "basedir": "/builds/slave/test", 08:52:52 INFO - "buildnumber": 467, 08:52:52 INFO - "slavename": "talos-linux64-ix-060", 08:52:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:52:52 INFO - "platform": "ubuntu64_hw", 08:52:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:52:52 INFO - "branch": "mozilla-aurora", 08:52:52 INFO - "repo_path": "releases/mozilla-aurora", 08:52:52 INFO - "revision": "8b47af8a1ad296295a0f9bfb61d6280265a5f109", 08:52:52 INFO - "stage_platform": "linux64-pgo", 08:52:52 INFO - "builduid": "72e192aeee604bb298eb38708725c94e", 08:52:52 INFO - "slavebuilddir": "test" 08:52:52 INFO - } 08:52:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 08:52:52 INFO - Running post-action listener: _resource_record_post_action 08:52:52 INFO - [mozharness: 2016-08-16 15:52:52.509689Z] Finished read-buildbot-config step (success) 08:52:52 INFO - [mozharness: 2016-08-16 15:52:52.509779Z] Running download-and-extract step. 08:52:52 INFO - Running pre-action listener: _resource_record_pre_action 08:52:52 INFO - Running main action method: download_and_extract 08:52:52 INFO - mkdir: /builds/slave/test/build/tests 08:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:52 INFO - https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:52:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:52:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:52:52 INFO - retry: Failed, sleeping 30 seconds before retrying 08:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:53:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:53:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:53:22 INFO - retry: Failed, sleeping 60 seconds before retrying 08:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:54:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:54:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:54:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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! 08:54:22 INFO - Caught exception: HTTP Error 404: Not Found 08:54:22 INFO - Caught exception: HTTP Error 404: Not Found 08:54:22 INFO - Caught exception: HTTP Error 404: Not Found 08:54:22 INFO - trying https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:54:22 INFO - Downloading https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:54:23 INFO - Downloaded 1361 bytes. 08:54:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:54:23 INFO - Using the following test package requirements: 08:54:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 08:54:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:54:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:54:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'jsshell-linux-x86_64.zip'], 08:54:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:54:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 08:54:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:54:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:54:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:54:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:54:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:54: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')]} 08:54:23 INFO - https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:54:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:54:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:54:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:54:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:54:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:54:23 INFO - retry: Failed, sleeping 30 seconds before retrying 08:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:54:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:54:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:54:53 INFO - retry: Failed, sleeping 60 seconds before retrying 08:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:55:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:55:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:55:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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! 08:55:53 INFO - Caught exception: HTTP Error 404: Not Found 08:55:53 INFO - Caught exception: HTTP Error 404: Not Found 08:55:53 INFO - Caught exception: HTTP Error 404: Not Found 08:55:53 INFO - trying https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:55:54 INFO - Downloaded 21766574 bytes. 08:55:54 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'] 08:55:54 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 08:55:55 INFO - Return code: 0 08:55:55 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 08:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:55 INFO - https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:55:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:55:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:55:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:55:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:55:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:55:55 INFO - retry: Failed, sleeping 30 seconds before retrying 08:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:56:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:56:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:56:25 INFO - retry: Failed, sleeping 60 seconds before retrying 08:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:57:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:57:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:57:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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! 08:57:25 INFO - Caught exception: HTTP Error 404: Not Found 08:57:25 INFO - Caught exception: HTTP Error 404: Not Found 08:57:25 INFO - Caught exception: HTTP Error 404: Not Found 08:57:25 INFO - trying https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:57:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:57:26 INFO - Downloaded 21766574 bytes. 08:57:26 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'] 08:57:26 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 08:57:27 INFO - Return code: 0 08:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:27 INFO - https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:57:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:57:27 INFO - retry: Failed, sleeping 30 seconds before retrying 08:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:57:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:57:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:57:57 INFO - retry: Failed, sleeping 60 seconds before retrying 08:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:58:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:58:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:58:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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! 08:58:57 INFO - Caught exception: HTTP Error 404: Not Found 08:58:57 INFO - Caught exception: HTTP Error 404: Not Found 08:58:57 INFO - Caught exception: HTTP Error 404: Not Found 08:58:57 INFO - trying https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:58:58 INFO - Downloaded 14413723 bytes. 08:58:58 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'] 08:58:58 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 08:58:58 INFO - Return code: 0 08:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:58 INFO - https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:58:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:58:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:58:58 INFO - retry: Failed, sleeping 30 seconds before retrying 08:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 08:59:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:59:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:59:28 INFO - retry: Failed, sleeping 60 seconds before retrying 09:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 09:00:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:00:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:00:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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! 09:00:28 INFO - Caught exception: HTTP Error 404: Not Found 09:00:28 INFO - Caught exception: HTTP Error 404: Not Found 09:00:28 INFO - Caught exception: HTTP Error 404: Not Found 09:00:28 INFO - trying https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:00:28 INFO - Downloading https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 09:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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 09:00:30 INFO - Downloaded 63780556 bytes. 09:00:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:00:30 INFO - mkdir: /builds/slave/test/properties 09:00:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:00:30 INFO - Writing to file /builds/slave/test/properties/build_url 09:00:30 INFO - Contents: 09:00:30 INFO - build_url:https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:00:30 INFO - Running post-action listener: _resource_record_post_action 09:00:30 INFO - Running post-action listener: set_extra_try_arguments 09:00:30 INFO - [mozharness: 2016-08-16 16:00:30.801548Z] Finished download-and-extract step (success) 09:00:30 INFO - [mozharness: 2016-08-16 16:00:30.801780Z] Running populate-webroot step. 09:00:30 INFO - Running pre-action listener: _resource_record_pre_action 09:00:30 INFO - Running main action method: populate_webroot 09:00:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:00:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:00:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:00:30 INFO - '--tppagecycles', 09:00:30 INFO - '7'], 09:00:30 INFO - 'tests': ['tsvgm']}}, 09:00:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:00:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:00:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:00:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:00:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['damp', 'tps']}, 09:00:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'tests': ['damp', 'tps']}, 09:00:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['dromaeo_dom']}, 09:00:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:00:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['basic_compositor_video']}, 09:00:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:00:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['a11yr', 09:00:30 INFO - 'ts_paint', 09:00:30 INFO - 'tpaint', 09:00:30 INFO - 'sessionrestore', 09:00:30 INFO - 'sessionrestore_no_auto_restore', 09:00:30 INFO - 'tabpaint']}, 09:00:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:00:30 INFO - 'ts_paint', 09:00:30 INFO - 'tpaint', 09:00:30 INFO - 'sessionrestore', 09:00:30 INFO - 'sessionrestore_no_auto_restore', 09:00:30 INFO - 'tabpaint']}, 09:00:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:00:30 INFO - 'ts_paint', 09:00:30 INFO - 'tpaint', 09:00:30 INFO - 'sessionrestore', 09:00:30 INFO - 'sessionrestore_no_auto_restore', 09:00:30 INFO - 'tabpaint']}, 09:00:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:00:30 INFO - 'ts_paint', 09:00:30 INFO - 'tpaint', 09:00:30 INFO - 'sessionrestore', 09:00:30 INFO - 'sessionrestore_no_auto_restore', 09:00:30 INFO - 'tabpaint']}, 09:00:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['a11yr', 09:00:30 INFO - 'ts_paint', 09:00:30 INFO - 'tpaint', 09:00:30 INFO - 'sessionrestore', 09:00:30 INFO - 'sessionrestore_no_auto_restore', 09:00:30 INFO - 'tabpaint']}, 09:00:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['a11yr', 09:00:30 INFO - 'ts_paint', 09:00:30 INFO - 'tpaint', 09:00:30 INFO - 'sessionrestore', 09:00:30 INFO - 'sessionrestore_no_auto_restore', 09:00:30 INFO - 'tabpaint']}, 09:00:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['tsvgx', 09:00:30 INFO - 'tsvgr_opacity', 09:00:30 INFO - 'tart', 09:00:30 INFO - 'tscrollx', 09:00:30 INFO - 'cart']}, 09:00:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:00:30 INFO - 'tsvgr_opacity', 09:00:30 INFO - 'tart', 09:00:30 INFO - 'tscrollx', 09:00:30 INFO - 'cart']}, 09:00:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'talos_options': ['--disable-e10s'], 09:00:30 INFO - 'tests': ['tp5o']}, 09:00:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'tests': ['tp5o']}, 09:00:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'talos_options': ['--disable-e10s', 09:00:30 INFO - '--xperf_path', 09:00:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:30 INFO - 'tests': ['tp5n']}, 09:00:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:30 INFO - 'talos_options': ['--xperf_path', 09:00:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:30 INFO - 'tests': ['tp5n']}}, 09:00:30 INFO - 'talos.zip': {'path': '', 09:00:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:00:30 INFO - Running post-action listener: _resource_record_post_action 09:00:30 INFO - [mozharness: 2016-08-16 16:00:30.822143Z] Finished populate-webroot step (success) 09:00:30 INFO - [mozharness: 2016-08-16 16:00:30.822233Z] Running create-virtualenv step. 09:00:30 INFO - Running pre-action listener: _resource_record_pre_action 09:00:30 INFO - Running main action method: create_virtualenv 09:00:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:00:30 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 09:00:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:00:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:00:30 INFO - Using real prefix '/usr' 09:00:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:00:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:00:33 INFO - Installing pip.................done. 09:00:33 INFO - Return code: 0 09:00:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:33 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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:33 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 09:00:33 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 09:00:33 INFO - Using env: {'DISPLAY': ':0', 09:00:33 INFO - 'HOME': '/home/cltbld', 09:00:33 INFO - 'LANG': 'en_US.UTF-8', 09:00:33 INFO - 'LANGUAGE': 'en_US:en', 09:00:33 INFO - 'LOGNAME': 'cltbld', 09:00:33 INFO - 'MAIL': '/var/mail/cltbld', 09:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:33 INFO - 'MOZ_NO_REMOTE': '1', 09:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:33 INFO - 'NO_EM_RESTART': '1', 09:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:33 INFO - 'PWD': '/builds/slave/test', 09:00:33 INFO - 'SHELL': '/bin/bash', 09:00:33 INFO - 'SHLVL': '1', 09:00:33 INFO - 'TERM': 'linux', 09:00:33 INFO - 'TMOUT': '86400', 09:00:33 INFO - 'USER': 'cltbld', 09:00:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:33 INFO - '_': '/tools/buildbot/bin/python'} 09:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:33 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 09:00:33 INFO - Cleaning up... 09:00:33 INFO - Return code: 0 09:00:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:33 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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:33 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 09:00:33 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 09:00:33 INFO - Using env: {'DISPLAY': ':0', 09:00:33 INFO - 'HOME': '/home/cltbld', 09:00:33 INFO - 'LANG': 'en_US.UTF-8', 09:00:33 INFO - 'LANGUAGE': 'en_US:en', 09:00:33 INFO - 'LOGNAME': 'cltbld', 09:00:33 INFO - 'MAIL': '/var/mail/cltbld', 09:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:33 INFO - 'MOZ_NO_REMOTE': '1', 09:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:33 INFO - 'NO_EM_RESTART': '1', 09:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:33 INFO - 'PWD': '/builds/slave/test', 09:00:33 INFO - 'SHELL': '/bin/bash', 09:00:33 INFO - 'SHLVL': '1', 09:00:33 INFO - 'TERM': 'linux', 09:00:33 INFO - 'TMOUT': '86400', 09:00:33 INFO - 'USER': 'cltbld', 09:00:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:33 INFO - '_': '/tools/buildbot/bin/python'} 09:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:34 INFO - Downloading/unpacking psutil>=3.1.1 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:36 INFO - Installing collected packages: psutil 09:00:36 INFO - Running setup.py install for psutil 09:00:36 INFO - building 'psutil._psutil_linux' extension 09:00:36 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 09:00:37 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 09:00:37 INFO - building 'psutil._psutil_posix' extension 09:00:37 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 09:00:37 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 09:00:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:37 INFO - Successfully installed psutil 09:00:37 INFO - Cleaning up... 09:00:37 INFO - Return code: 0 09:00:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:00: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 mozsystemmonitor==0.3 09:00:37 INFO - Using env: {'DISPLAY': ':0', 09:00:37 INFO - 'HOME': '/home/cltbld', 09:00:37 INFO - 'LANG': 'en_US.UTF-8', 09:00:37 INFO - 'LANGUAGE': 'en_US:en', 09:00:37 INFO - 'LOGNAME': 'cltbld', 09:00:37 INFO - 'MAIL': '/var/mail/cltbld', 09:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:37 INFO - 'MOZ_NO_REMOTE': '1', 09:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:37 INFO - 'NO_EM_RESTART': '1', 09:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:37 INFO - 'PWD': '/builds/slave/test', 09:00:37 INFO - 'SHELL': '/bin/bash', 09:00:37 INFO - 'SHLVL': '1', 09:00:37 INFO - 'TERM': 'linux', 09:00:37 INFO - 'TMOUT': '86400', 09:00:37 INFO - 'USER': 'cltbld', 09:00:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:37 INFO - '_': '/tools/buildbot/bin/python'} 09:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:00:39 INFO - Installing collected packages: mozsystemmonitor 09:00:39 INFO - Running setup.py install for mozsystemmonitor 09:00:39 INFO - Successfully installed mozsystemmonitor 09:00:39 INFO - Cleaning up... 09:00:39 INFO - Return code: 0 09:00:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:00:39 INFO - Using env: {'DISPLAY': ':0', 09:00:39 INFO - 'HOME': '/home/cltbld', 09:00:39 INFO - 'LANG': 'en_US.UTF-8', 09:00:39 INFO - 'LANGUAGE': 'en_US:en', 09:00:39 INFO - 'LOGNAME': 'cltbld', 09:00:39 INFO - 'MAIL': '/var/mail/cltbld', 09:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:39 INFO - 'MOZ_NO_REMOTE': '1', 09:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:39 INFO - 'NO_EM_RESTART': '1', 09:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:39 INFO - 'PWD': '/builds/slave/test', 09:00:39 INFO - 'SHELL': '/bin/bash', 09:00:39 INFO - 'SHLVL': '1', 09:00:39 INFO - 'TERM': 'linux', 09:00:39 INFO - 'TMOUT': '86400', 09:00:39 INFO - 'USER': 'cltbld', 09:00:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:39 INFO - '_': '/tools/buildbot/bin/python'} 09:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:00:40 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 09:00:40 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 09:00:40 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 09:00:40 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 09:00:40 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 09:00:40 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 09:00:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:00:41 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 09:00:41 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 09:00:41 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 09:00:41 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 09:00:41 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 09:00:41 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 09:00:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:42 INFO - warning: no files found matching '*.txt' 09:00:42 INFO - no previously-included directories found matching 'build' 09:00:42 INFO - no previously-included directories found matching 'dist' 09:00:42 INFO - no previously-included directories found matching '.git*' 09:00:42 INFO - Installing collected packages: jsonschema, functools32 09:00:42 INFO - Running setup.py install for functools32 09:00:42 INFO - warning: no files found matching '*.txt' 09:00:42 INFO - no previously-included directories found matching 'build' 09:00:42 INFO - no previously-included directories found matching 'dist' 09:00:42 INFO - no previously-included directories found matching '.git*' 09:00:42 INFO - Successfully installed jsonschema functools32 09:00:42 INFO - Cleaning up... 09:00:42 INFO - Return code: 0 09:00:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:00:42 INFO - Using env: {'DISPLAY': ':0', 09:00:42 INFO - 'HOME': '/home/cltbld', 09:00:42 INFO - 'LANG': 'en_US.UTF-8', 09:00:42 INFO - 'LANGUAGE': 'en_US:en', 09:00:42 INFO - 'LOGNAME': 'cltbld', 09:00:42 INFO - 'MAIL': '/var/mail/cltbld', 09:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:42 INFO - 'MOZ_NO_REMOTE': '1', 09:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:42 INFO - 'NO_EM_RESTART': '1', 09:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:42 INFO - 'PWD': '/builds/slave/test', 09:00:42 INFO - 'SHELL': '/bin/bash', 09:00:42 INFO - 'SHLVL': '1', 09:00:42 INFO - 'TERM': 'linux', 09:00:42 INFO - 'TMOUT': '86400', 09:00:42 INFO - 'USER': 'cltbld', 09:00:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:42 INFO - '_': '/tools/buildbot/bin/python'} 09:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:00:42 INFO - Cleaning up... 09:00:42 INFO - Return code: 0 09:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:00:42 INFO - Using env: {'DISPLAY': ':0', 09:00:42 INFO - 'HOME': '/home/cltbld', 09:00:42 INFO - 'LANG': 'en_US.UTF-8', 09:00:42 INFO - 'LANGUAGE': 'en_US:en', 09:00:42 INFO - 'LOGNAME': 'cltbld', 09:00:42 INFO - 'MAIL': '/var/mail/cltbld', 09:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:42 INFO - 'MOZ_NO_REMOTE': '1', 09:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:42 INFO - 'NO_EM_RESTART': '1', 09:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:42 INFO - 'PWD': '/builds/slave/test', 09:00:42 INFO - 'SHELL': '/bin/bash', 09:00:42 INFO - 'SHLVL': '1', 09:00:42 INFO - 'TERM': 'linux', 09:00:42 INFO - 'TMOUT': '86400', 09:00:42 INFO - 'USER': 'cltbld', 09:00:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:42 INFO - '_': '/tools/buildbot/bin/python'} 09:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:45 INFO - Downloading docopt-0.6.1.tar.gz 09:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:45 INFO - Running setup.py install for blobuploader 09:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:45 INFO - Running setup.py install for requests 09:00:45 INFO - Running setup.py install for docopt 09:00:46 INFO - Successfully installed blobuploader requests docopt 09:00:46 INFO - Cleaning up... 09:00:46 INFO - Return code: 0 09:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:46 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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:46 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 09:00:46 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 09:00:46 INFO - Using env: {'DISPLAY': ':0', 09:00:46 INFO - 'HOME': '/home/cltbld', 09:00:46 INFO - 'LANG': 'en_US.UTF-8', 09:00:46 INFO - 'LANGUAGE': 'en_US:en', 09:00:46 INFO - 'LOGNAME': 'cltbld', 09:00:46 INFO - 'MAIL': '/var/mail/cltbld', 09:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:46 INFO - 'MOZ_NO_REMOTE': '1', 09:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:46 INFO - 'NO_EM_RESTART': '1', 09:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:46 INFO - 'PWD': '/builds/slave/test', 09:00:46 INFO - 'SHELL': '/bin/bash', 09:00:46 INFO - 'SHLVL': '1', 09:00:46 INFO - 'TERM': 'linux', 09:00:46 INFO - 'TMOUT': '86400', 09:00:46 INFO - 'USER': 'cltbld', 09:00:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:46 INFO - '_': '/tools/buildbot/bin/python'} 09:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:46 INFO - Running setup.py (path:/tmp/pip-NQ14kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:46 INFO - Running setup.py (path:/tmp/pip-brOJj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:46 INFO - Running setup.py (path:/tmp/pip-tvnyIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:46 INFO - Running setup.py (path:/tmp/pip-XoV2jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:46 INFO - Running setup.py (path:/tmp/pip-DK_Rzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:46 INFO - Running setup.py (path:/tmp/pip-1Zpvkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:46 INFO - Running setup.py (path:/tmp/pip-QDrTwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:46 INFO - Running setup.py (path:/tmp/pip-6EJ8h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:46 INFO - Running setup.py (path:/tmp/pip-WE6xGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:46 INFO - Running setup.py (path:/tmp/pip-3brHbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:47 INFO - Running setup.py (path:/tmp/pip-rWPp7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:47 INFO - Running setup.py (path:/tmp/pip-yO5HAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:47 INFO - Running setup.py (path:/tmp/pip-MiHmFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:47 INFO - Running setup.py (path:/tmp/pip-893Yiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:47 INFO - Running setup.py (path:/tmp/pip-VoAUjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:47 INFO - Running setup.py (path:/tmp/pip-QycrWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:47 INFO - Running setup.py (path:/tmp/pip-bCR4fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:47 INFO - Running setup.py install for manifestparser 09:00:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:47 INFO - Running setup.py install for mozcrash 09:00:47 INFO - Running setup.py install for mozdebug 09:00:47 INFO - Running setup.py install for mozdevice 09:00:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:47 INFO - Running setup.py install for mozfile 09:00:48 INFO - Running setup.py install for mozhttpd 09:00:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for mozinfo 09:00:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for mozInstall 09:00:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for mozleak 09:00:48 INFO - Running setup.py install for mozlog 09:00:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for moznetwork 09:00:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for mozprocess 09:00:48 INFO - Running setup.py install for mozprofile 09:00:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for mozrunner 09:00:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:48 INFO - Running setup.py install for mozscreenshot 09:00:49 INFO - Running setup.py install for moztest 09:00:49 INFO - Running setup.py install for mozversion 09:00:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:49 INFO - Cleaning up... 09:00:49 INFO - Return code: 0 09:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:49 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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:49 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 09:00:49 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 09:00:49 INFO - Using env: {'DISPLAY': ':0', 09:00:49 INFO - 'HOME': '/home/cltbld', 09:00:49 INFO - 'LANG': 'en_US.UTF-8', 09:00:49 INFO - 'LANGUAGE': 'en_US:en', 09:00:49 INFO - 'LOGNAME': 'cltbld', 09:00:49 INFO - 'MAIL': '/var/mail/cltbld', 09:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:49 INFO - 'MOZ_NO_REMOTE': '1', 09:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:49 INFO - 'NO_EM_RESTART': '1', 09:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:49 INFO - 'PWD': '/builds/slave/test', 09:00:49 INFO - 'SHELL': '/bin/bash', 09:00:49 INFO - 'SHLVL': '1', 09:00:49 INFO - 'TERM': 'linux', 09:00:49 INFO - 'TMOUT': '86400', 09:00:49 INFO - 'USER': 'cltbld', 09:00:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:49 INFO - '_': '/tools/buildbot/bin/python'} 09:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:49 INFO - Running setup.py (path:/tmp/pip-fvMeYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:49 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)) 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:49 INFO - Running setup.py (path:/tmp/pip-A5RRCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:49 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)) 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:49 INFO - Running setup.py (path:/tmp/pip-rqVkM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:49 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)) 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:49 INFO - Running setup.py (path:/tmp/pip-Uv2rH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:49 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)) 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:49 INFO - Running setup.py (path:/tmp/pip-EZgAkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:49 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)) 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:49 INFO - Running setup.py (path:/tmp/pip-CVTXCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:49 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)) 09:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:49 INFO - Running setup.py (path:/tmp/pip-sEvIes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:50 INFO - Running setup.py (path:/tmp/pip-3szMXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:50 INFO - Running setup.py (path:/tmp/pip-Ooi30U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:50 INFO - Running setup.py (path:/tmp/pip-SycMMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:50 INFO - Running setup.py (path:/tmp/pip-CQSKsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:50 INFO - Running setup.py (path:/tmp/pip-lYrtUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:50 INFO - Running setup.py (path:/tmp/pip-nfG1Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:50 INFO - Running setup.py (path:/tmp/pip-pzfKtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:50 INFO - Running setup.py (path:/tmp/pip-xDt2tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:50 INFO - Running setup.py (path:/tmp/pip-GXRiS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:50 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)) 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:50 INFO - Running setup.py (path:/tmp/pip-3hCiOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:50 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)) 09:00:50 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)) 09:00:50 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)) 09:00:50 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)) 09:00:50 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)) 09:00:50 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)) 09:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:52 INFO - Downloading blessings-1.6.tar.gz 09:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:52 INFO - Installing collected packages: blessings 09:00:52 INFO - Running setup.py install for blessings 09:00:52 INFO - Successfully installed blessings 09:00:52 INFO - Cleaning up... 09:00:52 INFO - Return code: 0 09:00:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:53 INFO - Reading from file tmpfile_stdout 09:00:53 INFO - Current package versions: 09:00:53 INFO - argparse == 1.2.1 09:00:53 INFO - blessings == 1.6 09:00:53 INFO - blobuploader == 1.2.4 09:00:53 INFO - docopt == 0.6.1 09:00:53 INFO - functools32 == 3.2.3-2 09:00:53 INFO - jsonschema == 2.5.1 09:00:53 INFO - manifestparser == 1.1 09:00:53 INFO - mozInstall == 1.12 09:00:53 INFO - mozcrash == 0.17 09:00:53 INFO - mozdebug == 0.1 09:00:53 INFO - mozdevice == 0.48 09:00:53 INFO - mozfile == 1.2 09:00:53 INFO - mozhttpd == 0.7 09:00:53 INFO - mozinfo == 0.9 09:00:53 INFO - mozleak == 0.1 09:00:53 INFO - mozlog == 3.3 09:00:53 INFO - moznetwork == 0.27 09:00:53 INFO - mozprocess == 0.23 09:00:53 INFO - mozprofile == 0.28 09:00:53 INFO - mozrunner == 6.12 09:00:53 INFO - mozscreenshot == 0.1 09:00:53 INFO - mozsystemmonitor == 0.3 09:00:53 INFO - moztest == 0.7 09:00:53 INFO - mozversion == 1.4 09:00:53 INFO - psutil == 3.1.1 09:00:53 INFO - requests == 1.2.3 09:00:53 INFO - wsgiref == 0.1.2 09:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:53 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 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:53 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 09:00:53 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 09:00:53 INFO - Using env: {'DISPLAY': ':0', 09:00:53 INFO - 'HOME': '/home/cltbld', 09:00:53 INFO - 'LANG': 'en_US.UTF-8', 09:00:53 INFO - 'LANGUAGE': 'en_US:en', 09:00:53 INFO - 'LOGNAME': 'cltbld', 09:00:53 INFO - 'MAIL': '/var/mail/cltbld', 09:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:53 INFO - 'MOZ_NO_REMOTE': '1', 09:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:53 INFO - 'NO_EM_RESTART': '1', 09:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:53 INFO - 'PWD': '/builds/slave/test', 09:00:53 INFO - 'SHELL': '/bin/bash', 09:00:53 INFO - 'SHLVL': '1', 09:00:53 INFO - 'TERM': 'linux', 09:00:53 INFO - 'TMOUT': '86400', 09:00:53 INFO - 'USER': 'cltbld', 09:00:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:53 INFO - '_': '/tools/buildbot/bin/python'} 09:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 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)) 09:00:53 INFO - Cleaning up... 09:00:53 INFO - Return code: 0 09:00:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', '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 09:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:00:53 INFO - Using env: {'DISPLAY': ':0', 09:00:53 INFO - 'HOME': '/home/cltbld', 09:00:53 INFO - 'LANG': 'en_US.UTF-8', 09:00:53 INFO - 'LANGUAGE': 'en_US:en', 09:00:53 INFO - 'LOGNAME': 'cltbld', 09:00:53 INFO - 'MAIL': '/var/mail/cltbld', 09:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:53 INFO - 'MOZ_NO_REMOTE': '1', 09:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:53 INFO - 'NO_EM_RESTART': '1', 09:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:53 INFO - 'PWD': '/builds/slave/test', 09:00:53 INFO - 'SHELL': '/bin/bash', 09:00:53 INFO - 'SHLVL': '1', 09:00:53 INFO - 'TERM': 'linux', 09:00:53 INFO - 'TMOUT': '86400', 09:00:53 INFO - 'USER': 'cltbld', 09:00:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:53 INFO - '_': '/tools/buildbot/bin/python'} 09:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:53 INFO - Cleaning up... 09:00:53 INFO - Return code: 0 09:00:53 INFO - Running post-action listener: _resource_record_post_action 09:00:53 INFO - Running post-action listener: _start_resource_monitoring 09:00:53 INFO - Starting resource monitoring. 09:00:53 INFO - [mozharness: 2016-08-16 16:00:53.594209Z] Finished create-virtualenv step (success) 09:00:53 INFO - [mozharness: 2016-08-16 16:00:53.595167Z] Running install step. 09:00:53 INFO - Running pre-action listener: _resource_record_pre_action 09:00:53 INFO - Running main action method: install 09:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:53 INFO - Reading from file tmpfile_stdout 09:00:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:53 INFO - Reading from file tmpfile_stdout 09:00:53 INFO - Output received: 09:00:53 INFO - Usage: mozinstall [options] installer 09:00:53 INFO - Options: 09:00:53 INFO - -h, --help show this help message and exit 09:00:53 INFO - -d DEST, --destination=DEST 09:00:53 INFO - Directory to install application into. [default: 09:00:53 INFO - "/builds/slave/test"] 09:00:53 INFO - --app=APP Application being installed. [default: firefox] 09:00:53 INFO - mkdir: /builds/slave/test/build/application 09:00:53 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'] 09:00:53 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 09:01:10 INFO - Reading from file tmpfile_stdout 09:01:10 INFO - Output received: 09:01:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:10 INFO - Running post-action listener: _resource_record_post_action 09:01:10 INFO - [mozharness: 2016-08-16 16:01:10.127288Z] Finished install step (success) 09:01:10 INFO - [mozharness: 2016-08-16 16:01:10.127563Z] Running run-tests step. 09:01:10 INFO - Running pre-action listener: _resource_record_pre_action 09:01:10 INFO - Running main action method: run_tests 09:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:10 INFO - Python 2.7.3 09:01:10 INFO - Return code: 0 09:01:10 INFO - grabbing minidump binary from tooltool 09:01:10 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')]} 09:01:10 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 0x250d570>, '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 0x250e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:10 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 09:01:10 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 09:01:10 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 09:01:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:10 INFO - Return code: 0 09:01:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:10 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/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:01:10 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/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 09:01:10 INFO - Using env: {'DISPLAY': ':0', 09:01:10 INFO - 'HOME': '/home/cltbld', 09:01:10 INFO - 'LANG': 'en_US.UTF-8', 09:01:10 INFO - 'LANGUAGE': 'en_US:en', 09:01:10 INFO - 'LOGNAME': 'cltbld', 09:01:10 INFO - 'MAIL': '/var/mail/cltbld', 09:01:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:10 INFO - 'MOZ_NO_REMOTE': '1', 09:01:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:10 INFO - 'NO_EM_RESTART': '1', 09:01:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:10 INFO - 'PWD': '/builds/slave/test', 09:01:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:10 INFO - 'SHELL': '/bin/bash', 09:01:10 INFO - 'SHLVL': '1', 09:01:10 INFO - 'TERM': 'linux', 09:01:10 INFO - 'TMOUT': '86400', 09:01:10 INFO - 'USER': 'cltbld', 09:01:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508', 09:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:10 INFO - '_': '/tools/buildbot/bin/python'} 09:01:10 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/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:01:10 INFO - mozversion application_buildid: 20160816071917 09:01:10 INFO - mozversion application_changeset: 8b47af8a1ad296295a0f9bfb61d6280265a5f109 09:01:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:01:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:10 INFO - mozversion application_name: Firefox 09:01:10 INFO - mozversion application_remotingname: firefox-dev 09:01:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:10 INFO - mozversion application_vendor: Mozilla 09:01:10 INFO - mozversion application_version: 50.0a2 09:01:10 INFO - mozversion platform_buildid: 20160816071917 09:01:10 INFO - mozversion platform_changeset: 8b47af8a1ad296295a0f9bfb61d6280265a5f109 09:01:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:10 INFO - mozversion platform_version: 50.0a2 09:01:10 INFO - using testdate: 1471363270 09:01:10 INFO - actual date: 1471363270 09:01:10 INFO - starting webserver on 'localhost:49105' 09:01:10 INFO - SUITE-START | Running 2 tests 09:01:10 INFO - TEST-START | dromaeo_css 09:01:10 INFO - operating with platform_type : linux_ 09:01:10 INFO - Initialising browser for dromaeo_css test... 09:01:10 INFO - TEST-INFO | started process 3293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3TEUik/profile http://localhost:49105/getInfo.html) 09:01:15 INFO - PROCESS | 3293 | __metrics Screen width/height:1600/1200 09:01:15 INFO - PROCESS | 3293 | colorDepth:24 09:01:15 INFO - PROCESS | 3293 | Browser inner width/height: 1024/697 09:01:15 INFO - PROCESS | 3293 | __metrics 09:01:16 ERROR - PROCESS | 3293 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:01:17 INFO - TEST-INFO | 3293: exit 0 09:01:17 INFO - Browser initialized. 09:01:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:01:17 INFO - TEST-INFO | started process 3419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3TEUik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:29 INFO - PROCESS | 3419 | RSS: Main: 152252416 09:01:29 INFO - PROCESS | 3419 | 09:02:18 INFO - PROCESS | 3419 | 1471363338877 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:04:26 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:49105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49105/tests/dromaeo/cssquery-ext.html) 09:04:28 INFO - PROCESS | 3419 | RSS: Main: 157831168 09:04:28 INFO - PROCESS | 3419 | 09:07:30 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:49105/tests/dromaeo/cssquery-ext.html (next: http://localhost:49105/tests/dromaeo/cssquery-jquery.html) 09:07:30 INFO - PROCESS | 3419 | RSS: Main: 153595904 09:07:30 INFO - PROCESS | 3419 | 09:10:32 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:49105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49105/tests/dromaeo/cssquery-mootools.html) 09:10:33 INFO - PROCESS | 3419 | RSS: Main: 153747456 09:10:33 INFO - PROCESS | 3419 | 09:13:35 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:49105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49105/tests/dromaeo/cssquery-prototype.html) 09:13:35 INFO - PROCESS | 3419 | RSS: Main: 152936448 09:13:35 INFO - PROCESS | 3419 | 09:16:38 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:49105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49105/tests/dromaeo/cssquery-yui.html) 09:16:38 INFO - PROCESS | 3419 | RSS: Main: 155205632 09:16:38 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:49105/tests/dromaeo/cssquery-yui.html (next: http://localhost:49105/tests/dromaeo/cssquery-dojo.html) 09:19:41 INFO - PROCESS | 3419 | RSS: Main: 155521024 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | __start_tp_report 09:19:41 INFO - PROCESS | 3419 | _x_x_mozilla_page_load 09:19:41 INFO - PROCESS | 3419 | _x_x_mozilla_page_load_details 09:19:41 INFO - PROCESS | 3419 | |i|pagename|runs| 09:19:41 INFO - PROCESS | 3419 | |0;dojo.html;3228.644849066602;3245.38337715834;3247.0421225738405;3275.6560561141077;3282.310714749902;5624.268845050148;5680;5688.232088668028;5690.51630611398;5697.458741419564;5615.298087739033;5678.091505359143;5686.488216060554;5700.629459085157;5721.370649228582;5114.616403769723;5141.023205590945;5157.71632560209;5209.531142197202;5228.294180285669;5039.067772462088;5082.847514574551;5091.592672586203;5102.260172275018;5107.7956881724685;5120.129577971754;5133.589312854962;5159.22611608258;5175.560077393426;5236.895262094756;5155.587552995751;5168.819091331786;5170.353705786777;5209.6874187548865;5230.555402790767;4920.7539623019065;5008;5108.106081435734;5138.820141295037;5176.301199338079;5599.8880022399735;5682.715864206814;5687.118496633028;5687.260656114679;5723;6092.939070609282;6140.324564297924;6146.262448506163;6155.076738489218;6156.322804491502;5892.970535147339;5916.97041514794;6195.628262304276;6204.317525072239;6233.688315584202;5489.58828087891;5609.186667933168;5618.690971996498;5631.8028868989795;5634.690092044936;6043.7884674036195;6088.391160883964;6094.634321940698;6098.420650038239;6153.661548614869;5746.511546518593;5781.94218057814;5854.648721076749;5928.436798504135;5945.643261404243;6049.243844519435;6147.108669243024;6149.477294430024;6168.414000669929;6189.5048396129105;6089.854073308047;6116.021436570128;6123.252118380239;6140.254444788676;6148.538859585549;5743.655380677173;5924.851878703067;6133.0800379942475;6133.601315914451;6135.429105316479;4610.354550362952;4686.390769199982;4705.12955103307;4712.340272361872;4716.481187069419;4163.375493675912;4175.62419382257;4191.497020357516;4213.578642135762;4229.238737027303;5567.3040869891265;5670.461306175906;5839.532837373;5840.8539786504825;5842.941570584325;6000.249968753906;6041.667708276087;6096.420840020191;6118.235220597426;6118.510519158456;5747.827565173052;5771.0477771168125;5777.826665200051;5802.88394232113;5820.738066787005;5004.649674522749;5147.510986456281;5208.713520756319;5217.660852044605;5219.217117432339;6174.104754810617;6314.116023756677;6349;6356.555041147168;6366.236051673829;6071.150038994456;6085;6093.573449858467;6100.176476175659;6123.663198524124;6024.969875150597;6138.480361557057;6172.444479996642;6320.336364681826;6324.462420694293;5981.7906373278465;6024.33732289439;6033;6044.546659000504;6057.061155520902;6116.602420842631;6119.663418511846;6124.050772130327;6141.048137538689;6146.631202127886;5631.239782629293;5889.587728858939;5915.940840591539;5948.375420580776;5963.493103086286;5950.285965684146;5958.374370691015;5961.642301461926;5976.462118409364;6003.339632640494;5904.586678932434;5921.319048309328;5938.287405511366;5942.910856337072;5943.286805583185;5745.2818397700285;5773.971130144322;5887.234659494409;5959.612625179349;5972.372900845348;5812.76748930055;5839.153322768259;5841;5842.357340692605;5859.384764599826 09:19:41 INFO - PROCESS | 3419 | |1;ext.html;587.4008511318456;656.8259411256018;660.4518249852623;663.6582160187502;717.4153065251822;40524;45261.41585044528;45372.77313613432;45528.544714552845;45625;46042.30936535946;46174;46300.53699463004;46463.30305045427;46543;9037.18665320121;9096.727098187032;9137.588808503633;9140.177384035436;9173.220276276492;8995.190432861042;9069.274458043374;9077.092290770936;9093.499857507835;9101.40840845343;9088;9145.359824812265;9157.038510956354;9170.908290917105;9179.036201198878;9027.729168124966;9042.954785226064;9082.091790820898;9098.317626178063;9102.226310763594;8944.821103577957;9006.054364291786;9019.503927283997;9062.139096785795;9070.727878163665;43239.13521729548;43566.78216608928;43609;43663.345049824275;43679.344809827875;3240.270939038721;3688.0779805048737;3725.366687663077;3731.6828069614116;4329.653627709776;32276.83861580677;32805.83597082023;32880;33244;33290.667093329;4473.418455600784;4484.618807401374;4498.100379924028;4502.347159661864;4518.2319005769095;298274.50862745766;300238;300366;301657;302173;38324.80837595794;38374.616253837106;38377;38516;38698.226035479136;39022.414663780066;39038;39126.80436597799;39696.60303396987;39957;19007.809921900604;19389.80610193908;19410.22359105648;19429.80570194308;19457.124429400712;14773.40906363755;14797.852021479863;14852;14919.179445130405;14936.32786524609;20688.275910343065;20865.852378119045;21007.8949605251;21129.577408451743;21197.152113915272;7716.5370077795515;7738.96130519355;7801.531908085533;7935.484193527403;7977.720779772796;1045.2839804733783;1068.316277582348;1075.6450371377427;1180.7107258721496;1209.6492017314881;34590.481142782875;34733.47899781455;34947.825260873535;35063.64936350655;35400;1181.5037684172496;1194.5341316886422;1210.44319612979;1246.364354179357;1291.5285920639087;18209.45371638853;18366.908165459354;18421.171047302905;18515;18605.627887442177;525761;530302;530974;533039;537288;61731.38268617346;62901;63290.68354658289;64705.35294647088;64716;1342.8791408773257;1439.8560143985728;1458.5332693537966;1490.8285547161997;1514.6970605878869;32185.67814321827;35255.647443526264;35317.470237945934;35719.10702232361;35871.82064089663;53481.7325913368;54018.729906350214;54105.72947135239;54154;54315;437169;438390;440306;441365;442425;30668;31128.22179445532;31379.372412551165;31520.84239578879;31757.20606984844;50879.2368114486;51149;51409.22886156636;51455.48544514507;51675.224871626204;43554;43718.344224836015;44050.77974610106;44305.778471107435;44719.776401117786;43496;43909.78045109754;44859;45537;45839.77080114578;43311.35032974445;44093;44527.332090018026;44933.775331123135;44982.325265121704;36911.63088369189;38577.6142238574;38750.192213255206;39516;39604.95447135107;29619;29866.402671946875;29955.550666739582;30228.84885575646;30360.240993975327 09:19:41 INFO - PROCESS | 3419 | |2;jquery.html;405.4323946474933;407.7614595461655;412.12217975711735;414.7967495926996;430.49631930641146;18952;20377.49056273594;20439.080241389136;20877.37367878964;21027.053782579784;19876.20495180195;20033.198672053102;20121.899390503062;20445.48886277844;20588.48528786781;5772.105323674838;5919.644821310735;5980.700964951735;5989.431004054608;5993.1909192259145;4245.694786128093;4507.57178068083;5925.377835327293;5961.165436838846;6580.769673061443;6599.835004124887;6633.303503132174;6644.103046088764;6647.767328143516;6660.50046246531;6545.312742162076;6563.934360656404;6571.967140164316;6574.704138313788;6612.471002319803;5684.573656975744;5711.685857277848;5816.912746308809;5850.327212370589;5860.70696465175;23408;24161.87919060411;24285.271441856774;24285.514289714105;24354;2625.9868700656566;2685.368938299498;2707.6344693466326;2780.304923769058;3010.5634682971067;15009.699806003928;15144.772828407582;15557.29992150356;15629;15677.843221567866;1974.9802501975084;1994.7606287245478;2043.795620437959;2081.3339731285996;2117.3224568138203;81489.59255203746;82957;82963.5851820737;83304.58347708284;83533;10709.678709638723;10813.945930270456;10881.238313317992;10929.469874217615;10943.945280273707;14739.705205895822;14836.480723174853;14881.776773348409;14898.733607643255;14930.25348732559;8517.403781735218;8930.928288605279;8933.28533717314;9039.774005649911;9093.36346455755;8826.470411775314;8914.37599368038;8916.910830891738;9137.543122843832;9153.908460915438;6721.66391680414;6738.932610673928;6823.965880170567;6897.206821215524;6913.516053876281;1956.1197461142542;1966.665666836641;2005.4785755703622;2011.3463124484601;2018;423.8707194305705;441.59152783675614;977.1254727019278;1062.9202809789297;1070.4433694478828;11318.830217546743;11994.400279986141;12204.877951220375;12429.586393083262;12474.313912734706;463.84924899407827;471.9787609557578;475.9714417134983;481.89157439575814;482.08885206958877;6561.901571476432;6591.406773390418;6661.16735408074;6679.332066793282;6686.063951046857;531773;533116;548361;555568;556516;94204.52897735467;99495.50252248693;100576.49711751395;106932.46533767437;107051;1056.5245639462273;1068.6793961811425;1092.956281748737;1101.4217535793773;1119.3619636807105;18275.54311142232;18627.90686046561;19131.713024304925;19229.4231173065;19449.4165175045;43630.56369436265;43716;44619.88450288639;45170.54829451795;46034.539654603024;65950;66696;67364;67899.3210067893;68062.31937680757;8526.658933642584;8614.095519970564;8616.569171541523;8909.955450222968;9018.729438116867;13236.933815330862;13533.661658458224;13766.65583360424;13870.237136957565;14245.430182792987;12097.395130243629;12150.75698486043;12190.135318200038;12248.448819803309;12286.631401057983;11776.70558236051;11808.350540720343;12185.39073046362;12355.135140540076;12422.37888105573;6703.899441508283;12235.93882030584;12427.627171184879;12588.87411125877;12742.745145097231;8808.427452215585;8828.249598784176;8885.689000884939;8981.910180898107;8986.101389861224;11177.441127943734;11732.296062236293;12282.140250182401;12396.690082748004;12833.614991550268 09:19:41 INFO - PROCESS | 3419 | |3;mootools.html;1586.825449200588;1598.5843680643034;1770.2653398839475;1882.3129557711438;1901.8193271639188;8182.468139570924;9192.35653504255;9303.255739540837;9971.950140249306;10013.44926029069;9462.76343091423;9834;9839;9839.163671087967;9851.162651174642;2409.325388891113;2435.3546310227803;2443.9755602444015;2462.9630555541594;2464.605663093905;2429.4047958250253;2441.8779061046966;2475.715292741331;2493.2769496845985;2495.538325409796;2405.8337733236426;2418.7702168293986;2453.0433131078894;2455.9631605525933;2461.5569197544437;2320.825938054644;2329.557384097016;2332.696749422581;2333.614953532665;2339.532093581282;2344.6483027545833;2347.694799676048;2350.21267875262;2351.6354964980455;2352.1179557665873;9647.90352096477;9660.855087173628;9701.51492425383;9706.738124043899;9736.075072868067;5436.972815135939;5620.1288800236025;5675.035244008528;5678.801241956512;5679.801206957736;3389.7288216942584;3490.8429120689375;3496.4930085137767;3525.5593050868642;3539.8938031859084;1169.713420212045;1193.624008437348;1194.1223200947297;1196.9401529923468;1234.5864135514614;13102;13140.802887956785;13199.934000330033;13236.205827650372;13262.867371326356;4347.608715215646;4565.931511027337;4580.88547786308;4735.810567577328;4766.642501812378;10267.178625709925;10312.175025997902;10350.482475876175;10369.118624916966;10439.895601044043;5352.116900711339;5364.195370694427;5369.892602148013;5393.2449457076045;5399.7030163340605;4433.334999750064;4837.540433658797;4928.310036594879;4948.4309304429735;5023.14606516893;3820.1786615877163;3948.8223029963146;3970.2059588082498;3982.880513584539;4049.5545489996075;1134.9886501135047;1156.9363684997406;1167.6555416152255;1168.1530890104607;1175.835383046374;893.3032234856822;928.8792456980549;1024.537321722577;1033.7363972187045;1087.7770057138268;6400.615963042233;6488.448481878999;6498.610083395011;6571.9671401643645;6673.432758215509;441.80118946474215;460.8479201863377;461.33797999870296;465.26952684285345;470.4307787577002;4465.977670111693;4494.977525112419;4502.032063106448;4513.390692256569;4541.114482675846;11756.647300580997;11908.404579770977;12156.635300940987;12304.138710290374;12311.4459849307;11754.94122529399;11854.110941679408;11884.643460696192;11932.88067119335;12225.327606981524;8386.37102217324;8802.427842190236;8804.8679269811;8971.910280897238;9124.58939347731;6422.710978005907;6475.3200913903365;6627;6723.092382528296;6844.555103918428;11163.218574699693;11518.481668324777;11586.073114151017;11654.359010254517;11724.531018759495;11306.982371586597;11310.660680179608;11487.31076135401;11491.655250342503;11539.942300288782;7237.63811809418;8277.130901255281;8338.291245244221;8749.78125546841;8933;9278.95360523193;9323.393979391318;9341.906580934103;9366.67216647414;9385;8083.232092951161;8258.504489730636;8270.751877443687;8317.750467485985;8440.788980275542;7945;8032.83934321322;8050.436469447082;8081.838363232585;8084.514929104273;7765.22347765219;7780.144184139627;7811.1017233016655;7909;8059.153788852086;5783.132530120515;5845.210896528914;5881.9705901470215;5951.256092988377;6057.454829065406;5840.065589505659;5924.555658325729;5979.910301345571;6055.728297057667;6057.212562366864 09:19:41 INFO - PROCESS | 3419 | |4;prototype.html;335.35109562995603;336.72893320876693;344.51423492875045;348;349.15330323964395;5848.678322692255;5876.795256972327;5929.733162007709;5930.945563035029;5974.850628734278;5823.854403639911;5846.742950265702;5849.532037437006;5893.968555502791;5899;4006.8998275043064;4302.161078589684;4454.754988475633;4454.97772511137;4491.910161796762;4417.955820441803;4483.8654840354675;4487.663425243103;4516.661250406216;4516.796744146505;4497.662675299349;4501.2445146392765;4504.4594648642205;4509.571590698878;4523.2988886722615;4336.002719374562;4399.824007039714;4427.180971520279;4441.178381999308;4519.367288579601;3847.7306588538813;3871.6709079728257;3876.282887665791;3881.86413475527;3885.61143885612;5577.498025177753;5640.5487560995025;5644.971775141139;5666.596745677358;5685.374608793029;5063.417706963673;5111.744412779383;5127.846164615067;5176.689398636094;5186.662866913639;6015.766767812632;6034.547408944347;6039;6115.48018418435;6128.406614280275;4282.50751163617;4295.012147206129;4298.312270036779;4304.548022457629;4305.052888364586;6110.602810817282;6161.44546990773;6309.652969086698;6319.6208227506495;6331.588446750947;4337.0892112656065;4358.302671572596;4387.780610969503;4397.450318710161;4408.955910440919;4449.621782148553;4451.666125040635;4457.197704413236;4463.910721785546;4465.419495465634;4988.975055124701;5089.567386772166;5143.5113664201845;5148.661348049534;5156.788154783623;6037.366076561985;6047.939520604826;6086.513078953673;6094.756209751649;6100.206973093469;1498.1161114942236;1521;1523.4667866246725;1527.8319384867655;1535.6084198529304;941.1388579449726;974.8196583632051;981.9165370943407;983.7786498038028;1006.1447769395954;5237.8428647140645;5291.285676433709;5295.417504074549;5360.276362691065;5364.785408583691;5483.7806487740845;5631;5632.662040277596;5670.291213598301;5680.68756218412;4994.825181118644;5235.424103348629;5268.104422248227;5323.733813309319;5382.434844341366;2976.6725660177362;3004.39912017593;3010.367822757202;3013.698630136969;3050.5881705969855;5637.282758552496;5780.814932938738;5818.389069147764;5837.3870743571315;5866.530677545786;5356.91964620531;5549.278593782863;5580.079286917613;5625.578081643811;5667.234923285386;5646.249662604606;5785.8553536161935;5789.915630373062;5793.565482588822;5821.563382746226;5346.224797404432;5413.24214609947;5460;5525.889482210253;5548.334199896039;5438.510534051954;5473.616846820843;5474.671519708831;5480.369757477782;5505.064139096443;6375.330590287953;6602.755063278509;6646;6655.866882662416;6732.990051492316;4425.336199570091;4453.087117141044;4468.352088947149;4469.486009108864;4485.618722408632;6265.96867015662;6394.4564712;6432.453241474527;6496.285408604956;6497.382748638872;6233.563650544418;6241.594296370721;6255.343188965093;6257.655828929453;6257.906131407942;6004.309504407049;6240.219972503437;6243.157173781481;6248.781292654735;6306.4639505642535;6100.816975490742;6133.294671112701;6138.662373569497;6139.4781443577795;6141.293751218667;6178.196834411498;6217.564770466205;6239.313675495782;6242.3133455320785;6267.96866015667;5709.7145142741865;6025.728842202024;6055.333913269625;6094.20775299226;6114.48026917717 09:19:41 INFO - PROCESS | 3419 | |5;yui.html;820.6922404098464;847.6016272351997;872.2324354567982;898.6809682562692;915.3476932841448;15750.291236894338;16782.160891955413;16802.915985420088;17001.659966800657;17035.91482042591;14766.852331476683;15046.097234165958;15224.771628425582;15257.923710381432;15300.387984480607;867.2714919467662;886.0740526150156;891.4116682989228;891.6522556203086;895.8029233568637;844.6325848255998;895.6372669069037;906.7597086771978;908.27791905435;911.257325279898;945.5508633399115;949.5347279832866;953.4136506048765;953.713885834247;954.2461455450186;937.2595649436937;937.6671281695036;939.9530023498866;946.3470205558177;949.6391371278904;688.6006116452446;689.0663151429791;692.4529621598931;692.4979389942251;696.6377483708494;15621.687566248725;15636.374545018185;15649.139297338641;15669;15682.843171568253;14717.926410367987;15712.60718482047;16484.258208380532;16528;16604.50186494407;12255.877441225652;12346.38268086601;12569.622911312676;12596.685082873002;12805.10364274501;3943.9014024649327;3958.7426817256787;4001.7398869073418;4144.5026596808575;4147.7926103695;62223.688881555754;78018.60990695067;90546.54726726325;91019.54490227572;95315;12138.514459421702;12364.319962402154;12488.313142777235;12684.175528590613;12685.556005539762;22305;22320.330390088322;22375.55248895013;22558.774412255996;22599.661005084938;8999.19007289347;9033.548322583845;9059.637614495477;9209.769755756026;9273.026332235153;4873.658843880965;4911.386076740408;4965.90068198634;5043.672161309577;5233.058049551041;3601.1897323102617;3739.5886452490204;3763.736538442283;3768.1333293342686;3778.0932576181517;615.6521565315583;623.7349126621168;625.433982246068;626.3892704612966;649.9447546958562;572.2703552969997;613.408061220915;657.9801307972718;659.9439047681001;686.4885660183096;10218.897811021943;10296.794064118676;10494.475276236157;10715.946420267848;10827.275392420517;611.8195132435942;640.6892657061321;718.6119495472491;727.1310783613636;738.3133685672376;4939.90120197594;5232.529072383504;5241.606879484054;5289.444608316148;5310.628256022119;69960.65019674868;79710.60144699355;100665.49667251616;131937.68062319254;144077;116244.41877790556;116901.415492922;119794.40102799605;119894;121923;64175.679121605026;79171.60414198007;96470;97645.02354976359;107255.46372268088;9684.32209745311;9733.513324333897;9846.655367062118;10083.798324033332;10138.138258248131;43565;56701.716491417275;57747.13379299398;59001.70499147649;60005;49451.752741236065;50323.74838125786;60151.69924150351;81934;84895.57552212446;12790;12904.483820647445;12985.091043626855;13100.934495327463;13345.599632011055;13400.731985360433;13547.545813798577;13721.931390342985;13807.930960345537;13861.376238069513;12777;13048.804267936179;13102.475900963855;13613.455461781417;13691.863081369058;12814.615561533168;12997.960163187112;13037.47850086024;13149.934250328688;13567.660808479866;12438.937805310916;12790.552330668754;13776;14194.645133871323;14967.176805275814;11176.41784799915;12060.216085954386;12117.636470905887;12459.626211213677;12924.418401172157;11844.70388240301;11969.760604788029;12059.397030148633;12248.326342051272;12337.383130843602 09:19:41 INFO - PROCESS | 3419 | __end_tp_report 09:19:41 INFO - PROCESS | 3419 | __start_cc_report 09:19:41 INFO - PROCESS | 3419 | _x_x_mozilla_cycle_collect,334 09:19:41 INFO - PROCESS | 3419 | __end_cc_report 09:19:41 INFO - PROCESS | 3419 | __startTimestamp1471364381368__endTimestamp 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | ------- Summary: start ------- 09:19:41 INFO - PROCESS | 3419 | Number of tests: 6 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | [#0] dojo.html Cycles:165 Average:5633.45 Median:5841.00 stddev:643.79 (11.0%) stddev-sans-first:617.50 09:19:41 INFO - PROCESS | 3419 | Values: 3228.6 3245.4 3247.0 3275.7 3282.3 5624.3 5680.0 5688.2 5690.5 5697.5 5615.3 5678.1 5686.5 5700.6 5721.4 5114.6 5141.0 5157.7 5209.5 5228.3 5039.1 5082.8 5091.6 5102.3 5107.8 5120.1 5133.6 5159.2 5175.6 5236.9 5155.6 5168.8 5170.4 5209.7 5230.6 4920.8 5008.0 5108.1 5138.8 5176.3 5599.9 5682.7 5687.1 5687.3 5723.0 6092.9 6140.3 6146.3 6155.1 6156.3 5893.0 5917.0 6195.6 6204.3 6233.7 5489.6 5609.2 5618.7 5631.8 5634.7 6043.8 6088.4 6094.6 6098.4 6153.7 5746.5 5781.9 5854.6 5928.4 5945.6 6049.2 6147.1 6149.5 6168.4 6189.5 6089.9 6116.0 6123.3 6140.3 6148.5 5743.7 5924.9 6133.1 6133.6 6135.4 4610.4 4686.4 4705.1 4712.3 4716.5 4163.4 4175.6 4191.5 4213.6 4229.2 5567.3 5670.5 5839.5 5840.9 5842.9 6000.2 6041.7 6096.4 6118.2 6118.5 5747.8 5771.0 5777.8 5802.9 5820.7 5004.6 5147.5 5208.7 5217.7 5219.2 6174.1 6314.1 6349.0 6356.6 6366.2 6071.2 6085.0 6093.6 6100.2 6123.7 6025.0 6138.5 6172.4 6320.3 6324.5 5981.8 6024.3 6033.0 6044.5 6057.1 6116.6 6119.7 6124.1 6141.0 6146.6 5631.2 5889.6 5915.9 5948.4 5963.5 5950.3 5958.4 5961.6 5976.5 6003.3 5904.6 5921.3 5938.3 5942.9 5943.3 5745.3 5774.0 5887.2 5959.6 5972.4 5812.8 5839.2 5841.0 5842.4 5859.4 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | [#1] ext.html Cycles:180 Average:59118.90 Median:43587.89 stddev:115048.66 (263.9%) stddev-sans-first:115287.47 09:19:41 INFO - PROCESS | 3419 | Values: 587.4 656.8 660.5 663.7 717.4 40524.0 45261.4 45372.8 45528.5 45625.0 46042.3 46174.0 46300.5 46463.3 46543.0 9037.2 9096.7 9137.6 9140.2 9173.2 8995.2 9069.3 9077.1 9093.5 9101.4 9088.0 9145.4 9157.0 9170.9 9179.0 9027.7 9043.0 9082.1 9098.3 9102.2 8944.8 9006.1 9019.5 9062.1 9070.7 43239.1 43566.8 43609.0 43663.3 43679.3 3240.3 3688.1 3725.4 3731.7 4329.7 32276.8 32805.8 32880.0 33244.0 33290.7 4473.4 4484.6 4498.1 4502.3 4518.2 298274.5 300238.0 300366.0 301657.0 302173.0 38324.8 38374.6 38377.0 38516.0 38698.2 39022.4 39038.0 39126.8 39696.6 39957.0 19007.8 19389.8 19410.2 19429.8 19457.1 14773.4 14797.9 14852.0 14919.2 14936.3 20688.3 20865.9 21007.9 21129.6 21197.2 7716.5 7739.0 7801.5 7935.5 7977.7 1045.3 1068.3 1075.6 1180.7 1209.6 34590.5 34733.5 34947.8 35063.6 35400.0 1181.5 1194.5 1210.4 1246.4 1291.5 18209.5 18366.9 18421.2 18515.0 18605.6 525761.0 530302.0 530974.0 533039.0 537288.0 61731.4 62901.0 63290.7 64705.4 64716.0 1342.9 1439.9 1458.5 1490.8 1514.7 32185.7 35255.6 35317.5 35719.1 35871.8 53481.7 54018.7 54105.7 54154.0 54315.0 437169.0 438390.0 440306.0 441365.0 442425.0 30668.0 31128.2 31379.4 31520.8 31757.2 50879.2 51149.0 51409.2 51455.5 51675.2 43554.0 43718.3 44050.8 44305.8 44719.8 43496.0 43909.8 44859.0 45537.0 45839.8 43311.4 44093.0 44527.3 44933.8 44982.3 36911.6 38577.6 38750.2 39516.0 39605.0 29619.0 29866.4 29955.6 30228.8 30360.2 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | [#2] jquery.html Cycles:180 Average:31349.13 Median:409.94 stddev:89913.44 (21933.2%) stddev-sans-first:90135.65 09:19:41 INFO - PROCESS | 3419 | Values: 405.4 407.8 412.1 414.8 430.5 18952.0 20377.5 20439.1 20877.4 21027.1 19876.2 20033.2 20121.9 20445.5 20588.5 5772.1 5919.6 5980.7 5989.4 5993.2 4245.7 4507.6 5925.4 5961.2 6580.8 6599.8 6633.3 6644.1 6647.8 6660.5 6545.3 6563.9 6572.0 6574.7 6612.5 5684.6 5711.7 5816.9 5850.3 5860.7 23408.0 24161.9 24285.3 24285.5 24354.0 2626.0 2685.4 2707.6 2780.3 3010.6 15009.7 15144.8 15557.3 15629.0 15677.8 1975.0 1994.8 2043.8 2081.3 2117.3 81489.6 82957.0 82963.6 83304.6 83533.0 10709.7 10813.9 10881.2 10929.5 10943.9 14739.7 14836.5 14881.8 14898.7 14930.3 8517.4 8930.9 8933.3 9039.8 9093.4 8826.5 8914.4 8916.9 9137.5 9153.9 6721.7 6738.9 6824.0 6897.2 6913.5 1956.1 1966.7 2005.5 2011.3 2018.0 423.9 441.6 977.1 1062.9 1070.4 11318.8 11994.4 12204.9 12429.6 12474.3 463.8 472.0 476.0 481.9 482.1 6561.9 6591.4 6661.2 6679.3 6686.1 531773.0 533116.0 548361.0 555568.0 556516.0 94204.5 99495.5 100576.5 106932.5 107051.0 1056.5 1068.7 1093.0 1101.4 1119.4 18275.5 18627.9 19131.7 19229.4 19449.4 43630.6 43716.0 44619.9 45170.5 46034.5 65950.0 66696.0 67364.0 67899.3 68062.3 8526.7 8614.1 8616.6 8910.0 9018.7 13236.9 13533.7 13766.7 13870.2 14245.4 12097.4 12150.8 12190.1 12248.4 12286.6 11776.7 11808.4 12185.4 12355.1 12422.4 6703.9 12235.9 12427.6 12588.9 12742.7 8808.4 8828.2 8885.7 8981.9 8986.1 11177.4 11732.3 12282.1 12396.7 12833.6 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | [#3] mootools.html Cycles:180 Average:6247.94 Median:4527.25 stddev:3662.08 (80.9%) stddev-sans-first:3655.60 09:19:41 INFO - PROCESS | 3419 | Values: 1586.8 1598.6 1770.3 1882.3 1901.8 8182.5 9192.4 9303.3 9972.0 10013.4 9462.8 9834.0 9839.0 9839.2 9851.2 2409.3 2435.4 2444.0 2463.0 2464.6 2429.4 2441.9 2475.7 2493.3 2495.5 2405.8 2418.8 2453.0 2456.0 2461.6 2320.8 2329.6 2332.7 2333.6 2339.5 2344.6 2347.7 2350.2 2351.6 2352.1 9647.9 9660.9 9701.5 9706.7 9736.1 5437.0 5620.1 5675.0 5678.8 5679.8 3389.7 3490.8 3496.5 3525.6 3539.9 1169.7 1193.6 1194.1 1196.9 1234.6 13102.0 13140.8 13199.9 13236.2 13262.9 4347.6 4565.9 4580.9 4735.8 4766.6 10267.2 10312.2 10350.5 10369.1 10439.9 5352.1 5364.2 5369.9 5393.2 5399.7 4433.3 4837.5 4928.3 4948.4 5023.1 3820.2 3948.8 3970.2 3982.9 4049.6 1135.0 1156.9 1167.7 1168.2 1175.8 893.3 928.9 1024.5 1033.7 1087.8 6400.6 6488.4 6498.6 6572.0 6673.4 441.8 460.8 461.3 465.3 470.4 4466.0 4495.0 4502.0 4513.4 4541.1 11756.6 11908.4 12156.6 12304.1 12311.4 11754.9 11854.1 11884.6 11932.9 12225.3 8386.4 8802.4 8804.9 8971.9 9124.6 6422.7 6475.3 6627.0 6723.1 6844.6 11163.2 11518.5 11586.1 11654.4 11724.5 11307.0 11310.7 11487.3 11491.7 11539.9 7237.6 8277.1 8338.3 8749.8 8933.0 9279.0 9323.4 9341.9 9366.7 9385.0 8083.2 8258.5 8270.8 8317.8 8440.8 7945.0 8032.8 8050.4 8081.8 8084.5 7765.2 7780.1 7811.1 7909.0 8059.2 5783.1 5845.2 5882.0 5951.3 6057.5 5840.1 5924.6 5979.9 6055.7 6057.2 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | [#4] prototype.html Cycles:180 Average:4977.01 Median:5515.48 stddev:1474.46 (26.7%) stddev-sans-first:1436.85 09:19:41 INFO - PROCESS | 3419 | Values: 335.4 336.7 344.5 348.0 349.2 5848.7 5876.8 5929.7 5930.9 5974.9 5823.9 5846.7 5849.5 5894.0 5899.0 4006.9 4302.2 4454.8 4455.0 4491.9 4418.0 4483.9 4487.7 4516.7 4516.8 4497.7 4501.2 4504.5 4509.6 4523.3 4336.0 4399.8 4427.2 4441.2 4519.4 3847.7 3871.7 3876.3 3881.9 3885.6 5577.5 5640.5 5645.0 5666.6 5685.4 5063.4 5111.7 5127.8 5176.7 5186.7 6015.8 6034.5 6039.0 6115.5 6128.4 4282.5 4295.0 4298.3 4304.5 4305.1 6110.6 6161.4 6309.7 6319.6 6331.6 4337.1 4358.3 4387.8 4397.5 4409.0 4449.6 4451.7 4457.2 4463.9 4465.4 4989.0 5089.6 5143.5 5148.7 5156.8 6037.4 6047.9 6086.5 6094.8 6100.2 1498.1 1521.0 1523.5 1527.8 1535.6 941.1 974.8 981.9 983.8 1006.1 5237.8 5291.3 5295.4 5360.3 5364.8 5483.8 5631.0 5632.7 5670.3 5680.7 4994.8 5235.4 5268.1 5323.7 5382.4 2976.7 3004.4 3010.4 3013.7 3050.6 5637.3 5780.8 5818.4 5837.4 5866.5 5356.9 5549.3 5580.1 5625.6 5667.2 5646.2 5785.9 5789.9 5793.6 5821.6 5346.2 5413.2 5460.0 5525.9 5548.3 5438.5 5473.6 5474.7 5480.4 5505.1 6375.3 6602.8 6646.0 6655.9 6733.0 4425.3 4453.1 4468.4 4469.5 4485.6 6266.0 6394.5 6432.5 6496.3 6497.4 6233.6 6241.6 6255.3 6257.7 6257.9 6004.3 6240.2 6243.2 6248.8 6306.5 6100.8 6133.3 6138.7 6139.5 6141.3 6178.2 6217.6 6239.3 6242.3 6268.0 5709.7 6025.7 6055.3 6094.2 6114.5 09:19:41 INFO - PROCESS | 3419 | 09:19:41 INFO - PROCESS | 3419 | [#5] yui.html Cycles:180 Average:21495.45 Median:3861.00 stddev:31569.46 (817.7%) stddev-sans-first:31619.85 09:19:41 INFO - PROCESS | 3419 | Values: 820.7 847.6 872.2 898.7 915.3 15750.3 16782.2 16802.9 17001.7 17035.9 14766.9 15046.1 15224.8 15257.9 15300.4 867.3 886.1 891.4 891.7 895.8 844.6 895.6 906.8 908.3 911.3 945.6 949.5 953.4 953.7 954.2 937.3 937.7 940.0 946.3 949.6 688.6 689.1 692.5 692.5 696.6 15621.7 15636.4 15649.1 15669.0 15682.8 14717.9 15712.6 16484.3 16528.0 16604.5 12255.9 12346.4 12569.6 12596.7 12805.1 3943.9 3958.7 4001.7 4144.5 4147.8 62223.7 78018.6 90546.5 91019.5 95315.0 12138.5 12364.3 12488.3 12684.2 12685.6 22305.0 22320.3 22375.6 22558.8 22599.7 8999.2 9033.5 9059.6 9209.8 9273.0 4873.7 4911.4 4965.9 5043.7 5233.1 3601.2 3739.6 3763.7 3768.1 3778.1 615.7 623.7 625.4 626.4 649.9 572.3 613.4 658.0 659.9 686.5 10218.9 10296.8 10494.5 10715.9 10827.3 611.8 640.7 718.6 727.1 738.3 4939.9 5232.5 5241.6 5289.4 5310.6 69960.7 79710.6 100665.5 131937.7 144077.0 116244.4 116901.4 119794.4 119894.0 121923.0 64175.7 79171.6 96470.0 97645.0 107255.5 9684.3 9733.5 9846.7 10083.8 10138.1 43565.0 56701.7 57747.1 59001.7 60005.0 49451.8 50323.7 60151.7 81934.0 84895.6 12790.0 12904.5 12985.1 13100.9 13345.6 13400.7 13547.5 13721.9 13807.9 13861.4 12777.0 13048.8 13102.5 13613.5 13691.9 12814.6 12998.0 13037.5 13149.9 13567.7 12438.9 12790.6 13776.0 14194.6 14967.2 11176.4 12060.2 12117.6 12459.6 12924.4 11844.7 11969.8 12059.4 12248.3 12337.4 09:19:41 INFO - PROCESS | 3419 | -------- Summary: end -------- 09:19:41 INFO - PROCESS | 3419 | 09:19:42 INFO - TEST-INFO | 3419: exit 0 09:19:42 INFO - TEST-OK | dromaeo_css | took 1111338ms 09:19:42 INFO - TEST-START | kraken 09:19:42 INFO - operating with platform_type : linux_ 09:19:42 INFO - Initialising browser for kraken test... 09:19:42 INFO - TEST-INFO | started process 3688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHM1cV/profile http://localhost:49105/getInfo.html) 09:19:46 INFO - PROCESS | 3688 | __metrics Screen width/height:1600/1200 09:19:46 INFO - PROCESS | 3688 | colorDepth:24 09:19:46 INFO - PROCESS | 3688 | Browser inner width/height: 1024/697 09:19:46 INFO - PROCESS | 3688 | __metrics 09:19:47 ERROR - PROCESS | 3688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:19:47 INFO - TEST-INFO | 3688: exit 0 09:19:47 INFO - Browser initialized. 09:19:47 INFO - Running cycle 1/1 for kraken test... 09:19:47 INFO - TEST-INFO | started process 3818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHM1cV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:59 INFO - PROCESS | 3818 | RSS: Main: 152461312 09:19:59 INFO - PROCESS | 3818 | 09:20:02 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49105/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:03 INFO - PROCESS | 3818 | RSS: Main: 157757440 09:20:03 INFO - PROCESS | 3818 | 09:20:05 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49105/tests/kraken/driver.html?testName=audio-dft) 09:20:06 INFO - PROCESS | 3818 | RSS: Main: 156348416 09:20:06 INFO - PROCESS | 3818 | 09:20:09 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49105/tests/kraken/driver.html?testName=audio-fft) 09:20:09 INFO - PROCESS | 3818 | RSS: Main: 157007872 09:20:09 INFO - PROCESS | 3818 | 09:20:11 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49105/tests/kraken/driver.html?testName=audio-oscillator) 09:20:12 INFO - PROCESS | 3818 | RSS: Main: 156794880 09:20:12 INFO - PROCESS | 3818 | 09:20:14 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:20:15 INFO - PROCESS | 3818 | RSS: Main: 156831744 09:20:15 INFO - PROCESS | 3818 | 09:20:18 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49105/tests/kraken/driver.html?testName=imaging-darkroom) 09:20:19 INFO - PROCESS | 3818 | RSS: Main: 156401664 09:20:19 INFO - PROCESS | 3818 | 09:20:22 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49105/tests/kraken/driver.html?testName=imaging-desaturate) 09:20:23 INFO - PROCESS | 3818 | RSS: Main: 156606464 09:20:23 INFO - PROCESS | 3818 | 09:20:25 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49105/tests/kraken/driver.html?testName=json-parse-financial) 09:20:26 INFO - PROCESS | 3818 | RSS: Main: 157323264 09:20:26 INFO - PROCESS | 3818 | 09:20:28 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:20:28 INFO - PROCESS | 3818 | RSS: Main: 157003776 09:20:28 INFO - PROCESS | 3818 | 09:20:30 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:20:31 INFO - PROCESS | 3818 | RSS: Main: 156971008 09:20:31 INFO - PROCESS | 3818 | 09:20:33 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:33 INFO - PROCESS | 3818 | RSS: Main: 157470720 09:20:33 INFO - PROCESS | 3818 | 09:20:36 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:36 INFO - PROCESS | 3818 | RSS: Main: 157818880 09:20:36 INFO - PROCESS | 3818 | 09:20:39 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:40 INFO - PROCESS | 3818 | RSS: Main: 157974528 09:20:40 INFO - PROCESS | 3818 | 09:20:41 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:49105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49105/tests/kraken/driver.html?testName=ai-astar) 09:20:42 INFO - PROCESS | 3818 | RSS: Main: 158531584 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | __start_tp_report 09:20:42 INFO - PROCESS | 3818 | _x_x_mozilla_page_load 09:20:42 INFO - PROCESS | 3818 | _x_x_mozilla_page_load_details 09:20:42 INFO - PROCESS | 3818 | |i|pagename|runs| 09:20:42 INFO - PROCESS | 3818 | |0;ai-astar;102;111;105;109;116;111;111;112;115;112 09:20:42 INFO - PROCESS | 3818 | |1;audio-beat-detection;155;114;149;163;120;137;143;122;166;121 09:20:42 INFO - PROCESS | 3818 | |2;audio-dft;162;162;163;163;161;163;161;162;161;162 09:20:42 INFO - PROCESS | 3818 | |3;audio-fft;75;75;75;186;77;73;75;76;171;76 09:20:42 INFO - PROCESS | 3818 | |4;audio-oscillator;83;84;153;84;85;84;150;84;84;142 09:20:42 INFO - PROCESS | 3818 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;118 09:20:42 INFO - PROCESS | 3818 | |6;imaging-darkroom;148;147;148;147;147;148;149;148;147;147 09:20:42 INFO - PROCESS | 3818 | |7;imaging-desaturate;96;95;98;96;95;95;96;96;96;95 09:20:42 INFO - PROCESS | 3818 | |8;json-parse-financial;55;54;54;52;55;57;51;56;51;52 09:20:42 INFO - PROCESS | 3818 | |9;json-stringify-tinderbox;60;59;60;59;61;59;58;59;60;59 09:20:42 INFO - PROCESS | 3818 | |10;stanford-crypto-aes;73;71;72;74;72;71;72;74;74;72 09:20:42 INFO - PROCESS | 3818 | |11;stanford-crypto-ccm;122;122;117;123;122;138;128;119;160;131 09:20:42 INFO - PROCESS | 3818 | |12;stanford-crypto-pbkdf2;152;150;154;152;156;156;155;154;150;152 09:20:42 INFO - PROCESS | 3818 | |13;stanford-crypto-sha256-iterative;69;62;62;64;66;62;60;64;61;62 09:20:42 INFO - PROCESS | 3818 | __end_tp_report 09:20:42 INFO - PROCESS | 3818 | __start_cc_report 09:20:42 INFO - PROCESS | 3818 | _x_x_mozilla_cycle_collect,854 09:20:42 INFO - PROCESS | 3818 | __end_cc_report 09:20:42 INFO - PROCESS | 3818 | __startTimestamp1471364442136__endTimestamp 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | ------- Summary: start ------- 09:20:42 INFO - PROCESS | 3818 | Number of tests: 14 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:4.22 (3.8%) stddev-sans-first:3.20 09:20:42 INFO - PROCESS | 3818 | Values: 102.0 111.0 105.0 109.0 116.0 111.0 111.0 112.0 115.0 112.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:146.00 stddev:19.09 (13.1%) stddev-sans-first:19.35 09:20:42 INFO - PROCESS | 3818 | Values: 155.0 114.0 149.0 163.0 120.0 137.0 143.0 122.0 166.0 121.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:20:42 INFO - PROCESS | 3818 | Values: 162.0 162.0 163.0 163.0 161.0 163.0 161.0 162.0 161.0 162.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#3] audio-fft Cycles:10 Average:95.90 Median:75.00 stddev:43.69 (58.3%) stddev-sans-first:45.68 09:20:42 INFO - PROCESS | 3818 | Values: 75.0 75.0 75.0 186.0 77.0 73.0 75.0 76.0 171.0 76.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:31.19 (37.1%) stddev-sans-first:32.21 09:20:42 INFO - PROCESS | 3818 | Values: 83.0 84.0 153.0 84.0 85.0 84.0 150.0 84.0 84.0 142.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:20:42 INFO - PROCESS | 3818 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:20:42 INFO - PROCESS | 3818 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 149.0 148.0 147.0 147.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 09:20:42 INFO - PROCESS | 3818 | Values: 96.0 95.0 98.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.50 stddev:2.11 (3.9%) stddev-sans-first:2.19 09:20:42 INFO - PROCESS | 3818 | Values: 55.0 54.0 54.0 52.0 55.0 57.0 51.0 56.0 51.0 52.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 09:20:42 INFO - PROCESS | 3818 | Values: 60.0 59.0 60.0 59.0 61.0 59.0 58.0 59.0 60.0 59.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:72.50 stddev:1.18 (1.6%) stddev-sans-first:1.24 09:20:42 INFO - PROCESS | 3818 | Values: 73.0 71.0 72.0 74.0 72.0 71.0 72.0 74.0 74.0 72.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:125.50 stddev:12.77 (10.2%) stddev-sans-first:13.35 09:20:42 INFO - PROCESS | 3818 | Values: 122.0 122.0 117.0 123.0 122.0 138.0 128.0 119.0 160.0 131.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:2.23 (1.5%) stddev-sans-first:2.33 09:20:42 INFO - PROCESS | 3818 | Values: 152.0 150.0 154.0 152.0 156.0 156.0 155.0 154.0 150.0 152.0 09:20:42 INFO - PROCESS | 3818 | 09:20:42 INFO - PROCESS | 3818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.66 (4.2%) stddev-sans-first:1.81 09:20:42 INFO - PROCESS | 3818 | Values: 69.0 62.0 62.0 64.0 66.0 62.0 60.0 64.0 61.0 62.0 09:20:42 INFO - PROCESS | 3818 | -------- Summary: end -------- 09:20:42 INFO - PROCESS | 3818 | 09:20:43 INFO - TEST-INFO | 3818: exit 0 09:20:43 INFO - TEST-OK | kraken | took 61146ms 09:20:43 INFO - SUITE-END | took 1172s 09:20:43 INFO - Completed test suite (00:19:32) 09:20:43 INFO - javascript benchmark 09:20:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7562.500753089086, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.644849066602, 3245.38337715834, 3247.0421225738405, 3275.6560561141077, 3282.310714749902, 5624.268845050148, 5680.0, 5688.232088668028, 5690.51630611398, 5697.458741419564, 5615.298087739033, 5678.091505359143, 5686.488216060554, 5700.629459085157, 5721.370649228582, 5114.616403769723, 5141.023205590945, 5157.71632560209, 5209.531142197202, 5228.294180285669, 5039.067772462088, 5082.847514574551, 5091.592672586203, 5102.260172275018, 5107.7956881724685, 5120.129577971754, 5133.589312854962, 5159.22611608258, 5175.560077393426, 5236.895262094756, 5155.587552995751, 5168.819091331786, 5170.353705786777, 5209.6874187548865, 5230.555402790767, 4920.7539623019065, 5008.0, 5108.106081435734, 5138.820141295037, 5176.301199338079, 5599.8880022399735, 5682.715864206814, 5687.118496633028, 5687.260656114679, 5723.0, 6092.939070609282, 6140.324564297924, 6146.262448506163, 6155.076738489218, 6156.322804491502, 5892.970535147339, 5916.97041514794, 6195.628262304276, 6204.317525072239, 6233.688315584202, 5489.58828087891, 5609.186667933168, 5618.690971996498, 5631.8028868989795, 5634.690092044936, 6043.7884674036195, 6088.391160883964, 6094.634321940698, 6098.420650038239, 6153.661548614869, 5746.511546518593, 5781.94218057814, 5854.648721076749, 5928.436798504135, 5945.643261404243, 6049.243844519435, 6147.108669243024, 6149.477294430024, 6168.414000669929, 6189.5048396129105, 6089.854073308047, 6116.021436570128, 6123.252118380239, 6140.254444788676, 6148.538859585549, 5743.655380677173, 5924.851878703067, 6133.0800379942475, 6133.601315914451, 6135.429105316479, 4610.354550362952, 4686.390769199982, 4705.12955103307, 4712.340272361872, 4716.481187069419, 4163.375493675912, 4175.62419382257, 4191.497020357516, 4213.578642135762, 4229.238737027303, 5567.3040869891265, 5670.461306175906, 5839.532837373, 5840.8539786504825, 5842.941570584325, 6000.249968753906, 6041.667708276087, 6096.420840020191, 6118.235220597426, 6118.510519158456, 5747.827565173052, 5771.0477771168125, 5777.826665200051, 5802.88394232113, 5820.738066787005, 5004.649674522749, 5147.510986456281, 5208.713520756319, 5217.660852044605, 5219.217117432339, 6174.104754810617, 6314.116023756677, 6349.0, 6356.555041147168, 6366.236051673829, 6071.150038994456, 6085.0, 6093.573449858467, 6100.176476175659, 6123.663198524124, 6024.969875150597, 6138.480361557057, 6172.444479996642, 6320.336364681826, 6324.462420694293, 5981.7906373278465, 6024.33732289439, 6033.0, 6044.546659000504, 6057.061155520902, 6116.602420842631, 6119.663418511846, 6124.050772130327, 6141.048137538689, 6146.631202127886, 5631.239782629293, 5889.587728858939, 5915.940840591539, 5948.375420580776, 5963.493103086286, 5950.285965684146, 5958.374370691015, 5961.642301461926, 5976.462118409364, 6003.339632640494, 5904.586678932434, 5921.319048309328, 5938.287405511366, 5942.910856337072, 5943.286805583185, 5745.2818397700285, 5773.971130144322, 5887.234659494409, 5959.612625179349, 5972.372900845348, 5812.76748930055, 5839.153322768259, 5841.0, 5842.357340692605, 5859.384764599826], "value": 5589.853106291653, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4008511318456, 656.8259411256018, 660.4518249852623, 663.6582160187502, 717.4153065251822, 40524.0, 45261.41585044528, 45372.77313613432, 45528.544714552845, 45625.0, 46042.30936535946, 46174.0, 46300.53699463004, 46463.30305045427, 46543.0, 9037.18665320121, 9096.727098187032, 9137.588808503633, 9140.177384035436, 9173.220276276492, 8995.190432861042, 9069.274458043374, 9077.092290770936, 9093.499857507835, 9101.40840845343, 9088.0, 9145.359824812265, 9157.038510956354, 9170.908290917105, 9179.036201198878, 9027.729168124966, 9042.954785226064, 9082.091790820898, 9098.317626178063, 9102.226310763594, 8944.821103577957, 9006.054364291786, 9019.503927283997, 9062.139096785795, 9070.727878163665, 43239.13521729548, 43566.78216608928, 43609.0, 43663.345049824275, 43679.344809827875, 3240.270939038721, 3688.0779805048737, 3725.366687663077, 3731.6828069614116, 4329.653627709776, 32276.83861580677, 32805.83597082023, 32880.0, 33244.0, 33290.667093329, 4473.418455600784, 4484.618807401374, 4498.100379924028, 4502.347159661864, 4518.2319005769095, 298274.50862745766, 300238.0, 300366.0, 301657.0, 302173.0, 38324.80837595794, 38374.616253837106, 38377.0, 38516.0, 38698.226035479136, 39022.414663780066, 39038.0, 39126.80436597799, 39696.60303396987, 39957.0, 19007.809921900604, 19389.80610193908, 19410.22359105648, 19429.80570194308, 19457.124429400712, 14773.40906363755, 14797.852021479863, 14852.0, 14919.179445130405, 14936.32786524609, 20688.275910343065, 20865.852378119045, 21007.8949605251, 21129.577408451743, 21197.152113915272, 7716.5370077795515, 7738.96130519355, 7801.531908085533, 7935.484193527403, 7977.720779772796, 1045.2839804733783, 1068.316277582348, 1075.6450371377427, 1180.7107258721496, 1209.6492017314881, 34590.481142782875, 34733.47899781455, 34947.825260873535, 35063.64936350655, 35400.0, 1181.5037684172496, 1194.5341316886422, 1210.44319612979, 1246.364354179357, 1291.5285920639087, 18209.45371638853, 18366.908165459354, 18421.171047302905, 18515.0, 18605.627887442177, 525761.0, 530302.0, 530974.0, 533039.0, 537288.0, 61731.38268617346, 62901.0, 63290.68354658289, 64705.35294647088, 64716.0, 1342.8791408773257, 1439.8560143985728, 1458.5332693537966, 1490.8285547161997, 1514.6970605878869, 32185.67814321827, 35255.647443526264, 35317.470237945934, 35719.10702232361, 35871.82064089663, 53481.7325913368, 54018.729906350214, 54105.72947135239, 54154.0, 54315.0, 437169.0, 438390.0, 440306.0, 441365.0, 442425.0, 30668.0, 31128.22179445532, 31379.372412551165, 31520.84239578879, 31757.20606984844, 50879.2368114486, 51149.0, 51409.22886156636, 51455.48544514507, 51675.224871626204, 43554.0, 43718.344224836015, 44050.77974610106, 44305.778471107435, 44719.776401117786, 43496.0, 43909.78045109754, 44859.0, 45537.0, 45839.77080114578, 43311.35032974445, 44093.0, 44527.332090018026, 44933.775331123135, 44982.325265121704, 36911.63088369189, 38577.6142238574, 38750.192213255206, 39516.0, 39604.95447135107, 29619.0, 29866.402671946875, 29955.550666739582, 30228.84885575646, 30360.240993975327], "value": 20737.171826312027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.4323946474933, 407.7614595461655, 412.12217975711735, 414.7967495926996, 430.49631930641146, 18952.0, 20377.49056273594, 20439.080241389136, 20877.37367878964, 21027.053782579784, 19876.20495180195, 20033.198672053102, 20121.899390503062, 20445.48886277844, 20588.48528786781, 5772.105323674838, 5919.644821310735, 5980.700964951735, 5989.431004054608, 5993.1909192259145, 4245.694786128093, 4507.57178068083, 5925.377835327293, 5961.165436838846, 6580.769673061443, 6599.835004124887, 6633.303503132174, 6644.103046088764, 6647.767328143516, 6660.50046246531, 6545.312742162076, 6563.934360656404, 6571.967140164316, 6574.704138313788, 6612.471002319803, 5684.573656975744, 5711.685857277848, 5816.912746308809, 5850.327212370589, 5860.70696465175, 23408.0, 24161.87919060411, 24285.271441856774, 24285.514289714105, 24354.0, 2625.9868700656566, 2685.368938299498, 2707.6344693466326, 2780.304923769058, 3010.5634682971067, 15009.699806003928, 15144.772828407582, 15557.29992150356, 15629.0, 15677.843221567866, 1974.9802501975084, 1994.7606287245478, 2043.795620437959, 2081.3339731285996, 2117.3224568138203, 81489.59255203746, 82957.0, 82963.5851820737, 83304.58347708284, 83533.0, 10709.678709638723, 10813.945930270456, 10881.238313317992, 10929.469874217615, 10943.945280273707, 14739.705205895822, 14836.480723174853, 14881.776773348409, 14898.733607643255, 14930.25348732559, 8517.403781735218, 8930.928288605279, 8933.28533717314, 9039.774005649911, 9093.36346455755, 8826.470411775314, 8914.37599368038, 8916.910830891738, 9137.543122843832, 9153.908460915438, 6721.66391680414, 6738.932610673928, 6823.965880170567, 6897.206821215524, 6913.516053876281, 1956.1197461142542, 1966.665666836641, 2005.4785755703622, 2011.3463124484601, 2018.0, 423.8707194305705, 441.59152783675614, 977.1254727019278, 1062.9202809789297, 1070.4433694478828, 11318.830217546743, 11994.400279986141, 12204.877951220375, 12429.586393083262, 12474.313912734706, 463.84924899407827, 471.9787609557578, 475.9714417134983, 481.89157439575814, 482.08885206958877, 6561.901571476432, 6591.406773390418, 6661.16735408074, 6679.332066793282, 6686.063951046857, 531773.0, 533116.0, 548361.0, 555568.0, 556516.0, 94204.52897735467, 99495.50252248693, 100576.49711751395, 106932.46533767437, 107051.0, 1056.5245639462273, 1068.6793961811425, 1092.956281748737, 1101.4217535793773, 1119.3619636807105, 18275.54311142232, 18627.90686046561, 19131.713024304925, 19229.4231173065, 19449.4165175045, 43630.56369436265, 43716.0, 44619.88450288639, 45170.54829451795, 46034.539654603024, 65950.0, 66696.0, 67364.0, 67899.3210067893, 68062.31937680757, 8526.658933642584, 8614.095519970564, 8616.569171541523, 8909.955450222968, 9018.729438116867, 13236.933815330862, 13533.661658458224, 13766.65583360424, 13870.237136957565, 14245.430182792987, 12097.395130243629, 12150.75698486043, 12190.135318200038, 12248.448819803309, 12286.631401057983, 11776.70558236051, 11808.350540720343, 12185.39073046362, 12355.135140540076, 12422.37888105573, 6703.899441508283, 12235.93882030584, 12427.627171184879, 12588.87411125877, 12742.745145097231, 8808.427452215585, 8828.249598784176, 8885.689000884939, 8981.910180898107, 8986.101389861224, 11177.441127943734, 11732.296062236293, 12282.140250182401, 12396.690082748004, 12833.614991550268], "value": 9367.598961983758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1586.825449200588, 1598.5843680643034, 1770.2653398839475, 1882.3129557711438, 1901.8193271639188, 8182.468139570924, 9192.35653504255, 9303.255739540837, 9971.950140249306, 10013.44926029069, 9462.76343091423, 9834.0, 9839.0, 9839.163671087967, 9851.162651174642, 2409.325388891113, 2435.3546310227803, 2443.9755602444015, 2462.9630555541594, 2464.605663093905, 2429.4047958250253, 2441.8779061046966, 2475.715292741331, 2493.2769496845985, 2495.538325409796, 2405.8337733236426, 2418.7702168293986, 2453.0433131078894, 2455.9631605525933, 2461.5569197544437, 2320.825938054644, 2329.557384097016, 2332.696749422581, 2333.614953532665, 2339.532093581282, 2344.6483027545833, 2347.694799676048, 2350.21267875262, 2351.6354964980455, 2352.1179557665873, 9647.90352096477, 9660.855087173628, 9701.51492425383, 9706.738124043899, 9736.075072868067, 5436.972815135939, 5620.1288800236025, 5675.035244008528, 5678.801241956512, 5679.801206957736, 3389.7288216942584, 3490.8429120689375, 3496.4930085137767, 3525.5593050868642, 3539.8938031859084, 1169.713420212045, 1193.624008437348, 1194.1223200947297, 1196.9401529923468, 1234.5864135514614, 13102.0, 13140.802887956785, 13199.934000330033, 13236.205827650372, 13262.867371326356, 4347.608715215646, 4565.931511027337, 4580.88547786308, 4735.810567577328, 4766.642501812378, 10267.178625709925, 10312.175025997902, 10350.482475876175, 10369.118624916966, 10439.895601044043, 5352.116900711339, 5364.195370694427, 5369.892602148013, 5393.2449457076045, 5399.7030163340605, 4433.334999750064, 4837.540433658797, 4928.310036594879, 4948.4309304429735, 5023.14606516893, 3820.1786615877163, 3948.8223029963146, 3970.2059588082498, 3982.880513584539, 4049.5545489996075, 1134.9886501135047, 1156.9363684997406, 1167.6555416152255, 1168.1530890104607, 1175.835383046374, 893.3032234856822, 928.8792456980549, 1024.537321722577, 1033.7363972187045, 1087.7770057138268, 6400.615963042233, 6488.448481878999, 6498.610083395011, 6571.9671401643645, 6673.432758215509, 441.80118946474215, 460.8479201863377, 461.33797999870296, 465.26952684285345, 470.4307787577002, 4465.977670111693, 4494.977525112419, 4502.032063106448, 4513.390692256569, 4541.114482675846, 11756.647300580997, 11908.404579770977, 12156.635300940987, 12304.138710290374, 12311.4459849307, 11754.94122529399, 11854.110941679408, 11884.643460696192, 11932.88067119335, 12225.327606981524, 8386.37102217324, 8802.427842190236, 8804.8679269811, 8971.910280897238, 9124.58939347731, 6422.710978005907, 6475.3200913903365, 6627.0, 6723.092382528296, 6844.555103918428, 11163.218574699693, 11518.481668324777, 11586.073114151017, 11654.359010254517, 11724.531018759495, 11306.982371586597, 11310.660680179608, 11487.31076135401, 11491.655250342503, 11539.942300288782, 7237.63811809418, 8277.130901255281, 8338.291245244221, 8749.78125546841, 8933.0, 9278.95360523193, 9323.393979391318, 9341.906580934103, 9366.67216647414, 9385.0, 8083.232092951161, 8258.504489730636, 8270.751877443687, 8317.750467485985, 8440.788980275542, 7945.0, 8032.83934321322, 8050.436469447082, 8081.838363232585, 8084.514929104273, 7765.22347765219, 7780.144184139627, 7811.1017233016655, 7909.0, 8059.153788852086, 5783.132530120515, 5845.210896528914, 5881.9705901470215, 5951.256092988377, 6057.454829065406, 5840.065589505659, 5924.555658325729, 5979.910301345571, 6055.728297057667, 6057.212562366864], "value": 4844.724418129397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.35109562995603, 336.72893320876693, 344.51423492875045, 348.0, 349.15330323964395, 5848.678322692255, 5876.795256972327, 5929.733162007709, 5930.945563035029, 5974.850628734278, 5823.854403639911, 5846.742950265702, 5849.532037437006, 5893.968555502791, 5899.0, 4006.8998275043064, 4302.161078589684, 4454.754988475633, 4454.97772511137, 4491.910161796762, 4417.955820441803, 4483.8654840354675, 4487.663425243103, 4516.661250406216, 4516.796744146505, 4497.662675299349, 4501.2445146392765, 4504.4594648642205, 4509.571590698878, 4523.2988886722615, 4336.002719374562, 4399.824007039714, 4427.180971520279, 4441.178381999308, 4519.367288579601, 3847.7306588538813, 3871.6709079728257, 3876.282887665791, 3881.86413475527, 3885.61143885612, 5577.498025177753, 5640.5487560995025, 5644.971775141139, 5666.596745677358, 5685.374608793029, 5063.417706963673, 5111.744412779383, 5127.846164615067, 5176.689398636094, 5186.662866913639, 6015.766767812632, 6034.547408944347, 6039.0, 6115.48018418435, 6128.406614280275, 4282.50751163617, 4295.012147206129, 4298.312270036779, 4304.548022457629, 4305.052888364586, 6110.602810817282, 6161.44546990773, 6309.652969086698, 6319.6208227506495, 6331.588446750947, 4337.0892112656065, 4358.302671572596, 4387.780610969503, 4397.450318710161, 4408.955910440919, 4449.621782148553, 4451.666125040635, 4457.197704413236, 4463.910721785546, 4465.419495465634, 4988.975055124701, 5089.567386772166, 5143.5113664201845, 5148.661348049534, 5156.788154783623, 6037.366076561985, 6047.939520604826, 6086.513078953673, 6094.756209751649, 6100.206973093469, 1498.1161114942236, 1521.0, 1523.4667866246725, 1527.8319384867655, 1535.6084198529304, 941.1388579449726, 974.8196583632051, 981.9165370943407, 983.7786498038028, 1006.1447769395954, 5237.8428647140645, 5291.285676433709, 5295.417504074549, 5360.276362691065, 5364.785408583691, 5483.7806487740845, 5631.0, 5632.662040277596, 5670.291213598301, 5680.68756218412, 4994.825181118644, 5235.424103348629, 5268.104422248227, 5323.733813309319, 5382.434844341366, 2976.6725660177362, 3004.39912017593, 3010.367822757202, 3013.698630136969, 3050.5881705969855, 5637.282758552496, 5780.814932938738, 5818.389069147764, 5837.3870743571315, 5866.530677545786, 5356.91964620531, 5549.278593782863, 5580.079286917613, 5625.578081643811, 5667.234923285386, 5646.249662604606, 5785.8553536161935, 5789.915630373062, 5793.565482588822, 5821.563382746226, 5346.224797404432, 5413.24214609947, 5460.0, 5525.889482210253, 5548.334199896039, 5438.510534051954, 5473.616846820843, 5474.671519708831, 5480.369757477782, 5505.064139096443, 6375.330590287953, 6602.755063278509, 6646.0, 6655.866882662416, 6732.990051492316, 4425.336199570091, 4453.087117141044, 4468.352088947149, 4469.486009108864, 4485.618722408632, 6265.96867015662, 6394.4564712, 6432.453241474527, 6496.285408604956, 6497.382748638872, 6233.563650544418, 6241.594296370721, 6255.343188965093, 6257.655828929453, 6257.906131407942, 6004.309504407049, 6240.219972503437, 6243.157173781481, 6248.781292654735, 6306.4639505642535, 6100.816975490742, 6133.294671112701, 6138.662373569497, 6139.4781443577795, 6141.293751218667, 6178.196834411498, 6217.564770466205, 6239.313675495782, 6242.3133455320785, 6267.96866015667, 5709.7145142741865, 6025.728842202024, 6055.333913269625, 6094.20775299226, 6114.48026917717], "value": 4502.154770243508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.6922404098464, 847.6016272351997, 872.2324354567982, 898.6809682562692, 915.3476932841448, 15750.291236894338, 16782.160891955413, 16802.915985420088, 17001.659966800657, 17035.91482042591, 14766.852331476683, 15046.097234165958, 15224.771628425582, 15257.923710381432, 15300.387984480607, 867.2714919467662, 886.0740526150156, 891.4116682989228, 891.6522556203086, 895.8029233568637, 844.6325848255998, 895.6372669069037, 906.7597086771978, 908.27791905435, 911.257325279898, 945.5508633399115, 949.5347279832866, 953.4136506048765, 953.713885834247, 954.2461455450186, 937.2595649436937, 937.6671281695036, 939.9530023498866, 946.3470205558177, 949.6391371278904, 688.6006116452446, 689.0663151429791, 692.4529621598931, 692.4979389942251, 696.6377483708494, 15621.687566248725, 15636.374545018185, 15649.139297338641, 15669.0, 15682.843171568253, 14717.926410367987, 15712.60718482047, 16484.258208380532, 16528.0, 16604.50186494407, 12255.877441225652, 12346.38268086601, 12569.622911312676, 12596.685082873002, 12805.10364274501, 3943.9014024649327, 3958.7426817256787, 4001.7398869073418, 4144.5026596808575, 4147.7926103695, 62223.688881555754, 78018.60990695067, 90546.54726726325, 91019.54490227572, 95315.0, 12138.514459421702, 12364.319962402154, 12488.313142777235, 12684.175528590613, 12685.556005539762, 22305.0, 22320.330390088322, 22375.55248895013, 22558.774412255996, 22599.661005084938, 8999.19007289347, 9033.548322583845, 9059.637614495477, 9209.769755756026, 9273.026332235153, 4873.658843880965, 4911.386076740408, 4965.90068198634, 5043.672161309577, 5233.058049551041, 3601.1897323102617, 3739.5886452490204, 3763.736538442283, 3768.1333293342686, 3778.0932576181517, 615.6521565315583, 623.7349126621168, 625.433982246068, 626.3892704612966, 649.9447546958562, 572.2703552969997, 613.408061220915, 657.9801307972718, 659.9439047681001, 686.4885660183096, 10218.897811021943, 10296.794064118676, 10494.475276236157, 10715.946420267848, 10827.275392420517, 611.8195132435942, 640.6892657061321, 718.6119495472491, 727.1310783613636, 738.3133685672376, 4939.90120197594, 5232.529072383504, 5241.606879484054, 5289.444608316148, 5310.628256022119, 69960.65019674868, 79710.60144699355, 100665.49667251616, 131937.68062319254, 144077.0, 116244.41877790556, 116901.415492922, 119794.40102799605, 119894.0, 121923.0, 64175.679121605026, 79171.60414198007, 96470.0, 97645.02354976359, 107255.46372268088, 9684.32209745311, 9733.513324333897, 9846.655367062118, 10083.798324033332, 10138.138258248131, 43565.0, 56701.716491417275, 57747.13379299398, 59001.70499147649, 60005.0, 49451.752741236065, 50323.74838125786, 60151.69924150351, 81934.0, 84895.57552212446, 12790.0, 12904.483820647445, 12985.091043626855, 13100.934495327463, 13345.599632011055, 13400.731985360433, 13547.545813798577, 13721.931390342985, 13807.930960345537, 13861.376238069513, 12777.0, 13048.804267936179, 13102.475900963855, 13613.455461781417, 13691.863081369058, 12814.615561533168, 12997.960163187112, 13037.47850086024, 13149.934250328688, 13567.660808479866, 12438.937805310916, 12790.552330668754, 13776.0, 14194.645133871323, 14967.176805275814, 11176.41784799915, 12060.216085954386, 12117.636470905887, 12459.626211213677, 12924.418401172157, 11844.70388240301, 11969.760604788029, 12059.397030148633, 12248.326342051272, 12337.383130843602], "value": 7897.385788740336, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 109.0, 116.0, 111.0, 111.0, 112.0, 115.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 114.0, 149.0, 163.0, 120.0, 137.0, 143.0, 122.0, 166.0, 121.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 161.0, 163.0, 161.0, 162.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 186.0, 77.0, 73.0, 75.0, 76.0, 171.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 153.0, 84.0, 85.0, 84.0, 150.0, 84.0, 84.0, 142.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 98.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 52.0, 55.0, 57.0, 51.0, 56.0, 51.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 61.0, 59.0, 58.0, 59.0, 60.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 72.0, 74.0, 72.0, 71.0, 72.0, 74.0, 74.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 117.0, 123.0, 122.0, 138.0, 128.0, 119.0, 160.0, 131.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 154.0, 152.0, 156.0, 156.0, 155.0, 154.0, 150.0, 152.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 62.0, 62.0, 64.0, 66.0, 62.0, 60.0, 64.0, 61.0, 62.0], "value": 63.2, "unit": "score"}]}]} 09:20:43 INFO - Return code: 0 09:20:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:43 ERROR - # TBPL SUCCESS # 09:20:43 INFO - Running post-action listener: _resource_record_post_action 09:20:43 INFO - [mozharness: 2016-08-16 16:20:43.461793Z] Finished run-tests step (success) 09:20:43 INFO - Running post-run listener: _resource_record_post_run 09:20:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 7979008; Write bytes: 455639040; Read time: 1712; Write time: 329448 09:20:43 INFO - TinderboxPrint: CPU usage
13.3% 09:20:43 INFO - TinderboxPrint: I/O read bytes / time
7,979,008 / 1,712 09:20:43 INFO - TinderboxPrint: I/O write bytes / time
455,639,040 / 329,448 09:20:43 INFO - TinderboxPrint: CPU idle
8,223.9 (86.7%) 09:20:43 INFO - TinderboxPrint: CPU user
1,201.7 (12.7%) 09:20:43 INFO - TinderboxPrint: Swap in / out
0 / 0 09:20:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 8192; Write bytes: 122089472; Read time: 328; Write time: 79944 09:20:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5914624; Write bytes: 243351552; Read time: 1148; Write time: 142952 09:20:44 INFO - Running post-run listener: _upload_blobber_files 09:20:44 INFO - Blob upload gear active. 09:20:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:20:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:45 INFO - (blobuploader) - INFO - Done attempting. 09:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:48 INFO - (blobuploader) - INFO - Done attempting. 09:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:50 INFO - (blobuploader) - INFO - Done attempting. 09:20:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:50 INFO - Return code: 0 09:20:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4408e403314ccbe978af430e087bf855d91d35dfef719720fa36085bd2f3aed85ca12cc6f152773099553642c243d0b1493b2a29bb439ed7cd0afe39e05af21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03053dfaca7fae87c592e2da238e7063de2524c8c006953d119b0b2ee57a89ed840aa8e64ddb784957c2510d530af5a142348b1591f86e3209b4ebabe136fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e53eaf9d6ba980fc9da2e73d2e2adfb11b6a88e8afc087d4d44a7a86e97652650e14741a1fca414abaf92b542857617488071a9cd5ab79804e4a09d213e6d31"} 09:20:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:50 INFO - Contents: 09:20:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4408e403314ccbe978af430e087bf855d91d35dfef719720fa36085bd2f3aed85ca12cc6f152773099553642c243d0b1493b2a29bb439ed7cd0afe39e05af21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03053dfaca7fae87c592e2da238e7063de2524c8c006953d119b0b2ee57a89ed840aa8e64ddb784957c2510d530af5a142348b1591f86e3209b4ebabe136fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e53eaf9d6ba980fc9da2e73d2e2adfb11b6a88e8afc087d4d44a7a86e97652650e14741a1fca414abaf92b542857617488071a9cd5ab79804e4a09d213e6d31"} 09:20:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:50 INFO - Copying logs to upload dir... 09:20:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.984021 ========= master_lag: 0.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-08-16 09:20:51.163500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 09:20:51.166566) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508 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/e4408e403314ccbe978af430e087bf855d91d35dfef719720fa36085bd2f3aed85ca12cc6f152773099553642c243d0b1493b2a29bb439ed7cd0afe39e05af21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03053dfaca7fae87c592e2da238e7063de2524c8c006953d119b0b2ee57a89ed840aa8e64ddb784957c2510d530af5a142348b1591f86e3209b4ebabe136fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e53eaf9d6ba980fc9da2e73d2e2adfb11b6a88e8afc087d4d44a7a86e97652650e14741a1fca414abaf92b542857617488071a9cd5ab79804e4a09d213e6d31"} build_url:https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010975 build_url: 'https://queue.taskcluster.net/v1/task/YOv6XqDiQLiOjcJtS_dBxA/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/e4408e403314ccbe978af430e087bf855d91d35dfef719720fa36085bd2f3aed85ca12cc6f152773099553642c243d0b1493b2a29bb439ed7cd0afe39e05af21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03053dfaca7fae87c592e2da238e7063de2524c8c006953d119b0b2ee57a89ed840aa8e64ddb784957c2510d530af5a142348b1591f86e3209b4ebabe136fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e53eaf9d6ba980fc9da2e73d2e2adfb11b6a88e8afc087d4d44a7a86e97652650e14741a1fca414abaf92b542857617488071a9cd5ab79804e4a09d213e6d31"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 09:20:51.191868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 09:20:51.192213) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471362704.168664-2045562508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004372 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 09:20:51.477039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 09:20:51.477364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 09:20:51.477776) ========= ========= Total master_lag: 0.97 =========